builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1483027139.2 results: success (0) buildid: 20161229070619 builduid: 5b015cc31ace46e698c5f594b38d7151 revision: 87efd66165ddaa1b97608b92cd651b73c11aca6f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 07:58:59.197444) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 07:58:59.198076) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 07:58:59.198349) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 07:58:59.215447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 07:58:59.215772) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-29 07:58:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-12-29 07:58:59 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.069411 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 07:58:59.302754) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 07:58:59.303063) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021009 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 07:58:59.352595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 07:58:59.352938) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 87efd66165ddaa1b97608b92cd651b73c11aca6f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 87efd66165ddaa1b97608b92cd651b73c11aca6f --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=9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-29 07:58:59,535 truncating revision to first 12 chars 2016-12-29 07:58:59,535 Setting DEBUG logging. 2016-12-29 07:58:59,535 attempt 1/10 2016-12-29 07:58:59,535 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/87efd66165dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-29 07:58:59,855 unpacking tar archive at: mozilla-central-87efd66165dd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648625 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 07:59:00.018129) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 07:59:00.018449) ========= script_repo_revision: 87efd66165ddaa1b97608b92cd651b73c11aca6f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 07:59:00.018847) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 07:59:00.019168) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 07:59:00.028714) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-12-29 07:59:00.029028) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:59:00 INFO - MultiFileLogger online at 20161229 07:59:00 in /builds/slave/test 07:59:00 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:59:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:59:00 INFO - {'append_to_log': False, 07:59:00 INFO - 'base_work_dir': '/builds/slave/test', 07:59:00 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:59:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:59:00 INFO - 'branch': 'Firefox-Non-PGO', 07:59:00 INFO - 'buildbot_json_path': 'buildprops.json', 07:59:00 INFO - 'config_files': ('talos/linux_config.py',), 07:59:00 INFO - 'default_actions': ('clobber', 07:59:00 INFO - 'read-buildbot-config', 07:59:00 INFO - 'download-and-extract', 07:59:00 INFO - 'populate-webroot', 07:59:00 INFO - 'create-virtualenv', 07:59:00 INFO - 'install', 07:59:00 INFO - 'run-tests'), 07:59:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:59:00 INFO - 'download_minidump_stackwalk': True, 07:59:00 INFO - 'download_symbols': 'ondemand', 07:59:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:59:00 INFO - 'tooltool.py': '/tools/tooltool.py', 07:59:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:59:00 INFO - '/tools/misc-python/virtualenv.py')}, 07:59:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:59:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:59:00 INFO - 'installer_path': 'installer.exe', 07:59:00 INFO - 'log_level': 'info', 07:59:00 INFO - 'log_name': 'talos', 07:59:00 INFO - 'log_to_console': True, 07:59:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:59:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:59:00 INFO - 'opt_config_files': (), 07:59:00 INFO - 'pip_index': False, 07:59:00 INFO - 'sps_profile': False, 07:59:00 INFO - 'sps_profile_interval': 0, 07:59:00 INFO - 'suite': 'dromaeojs-e10s', 07:59:00 INFO - 'system_bits': '32', 07:59:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:59:00 INFO - 'title': 'talos-linux64-ix-022', 07:59:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:59:00 INFO - 'use_talos_json': True, 07:59:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:59:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:59:00 INFO - 'work_dir': 'build'} 07:59:00 INFO - [mozharness: 2016-12-29 15:59:00.308600Z] Running clobber step. 07:59:00 INFO - Running pre-action listener: _resource_record_pre_action 07:59:00 INFO - Running main action method: clobber 07:59:00 INFO - rmtree: /builds/slave/test/build 07:59:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:59:00 INFO - Running post-action listener: _resource_record_post_action 07:59:00 INFO - [mozharness: 2016-12-29 15:59:00.764951Z] Finished clobber step (success) 07:59:00 INFO - [mozharness: 2016-12-29 15:59:00.765052Z] Running read-buildbot-config step. 07:59:00 INFO - Running pre-action listener: _resource_record_pre_action 07:59:00 INFO - Running main action method: read_buildbot_config 07:59:00 INFO - Using buildbot properties: 07:59:00 INFO - { 07:59:00 INFO - "project": "", 07:59:00 INFO - "product": "firefox", 07:59:00 INFO - "script_repo_revision": "production", 07:59:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:59:00 INFO - "repository": "", 07:59:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:59:00 INFO - "buildid": "20161229070619", 07:59:00 INFO - "pgo_build": "False", 07:59:00 INFO - "basedir": "/builds/slave/test", 07:59:00 INFO - "buildnumber": 336, 07:59:00 INFO - "slavename": "talos-linux64-ix-022", 07:59:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:59:00 INFO - "platform": "ubuntu64_hw", 07:59:00 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:59:00 INFO - "branch": "mozilla-central", 07:59:00 INFO - "repo_path": "mozilla-central", 07:59:00 INFO - "revision": "87efd66165ddaa1b97608b92cd651b73c11aca6f", 07:59:00 INFO - "stage_platform": "linux64", 07:59:00 INFO - "builduid": "5b015cc31ace46e698c5f594b38d7151", 07:59:00 INFO - "slavebuilddir": "test" 07:59:00 INFO - } 07:59:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:59:00 INFO - Running post-action listener: _resource_record_post_action 07:59:00 INFO - [mozharness: 2016-12-29 15:59:00.767479Z] Finished read-buildbot-config step (success) 07:59:00 INFO - [mozharness: 2016-12-29 15:59:00.767569Z] Running download-and-extract step. 07:59:00 INFO - Running pre-action listener: _resource_record_pre_action 07:59:00 INFO - Running main action method: download_and_extract 07:59:00 INFO - mkdir: /builds/slave/test/build/tests 07:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:00 INFO - trying https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:59:00 INFO - Downloading https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:59:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:59:01 INFO - Downloaded 1361 bytes. 07:59:01 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:59:01 INFO - Using the following test package requirements: 07:59:01 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:59:01 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:01 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:59:01 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:01 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:59:01 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:01 INFO - u'jsshell-linux-x86_64.zip'], 07:59:01 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:01 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:59:01 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:59:01 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:01 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:59:01 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:01 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:59:01 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:01 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:59:01 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:59:01 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:59:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:59:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:59:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:59:01 INFO - Fetch https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:59:02 INFO - Expected file size: 20245905 07:59:02 INFO - Obtained file size: 20245905 07:59:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:59:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:59:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:59:06 INFO - Fetch https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:59:06 INFO - Expected file size: 20245905 07:59:06 INFO - Obtained file size: 20245905 07:59:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:59:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:59:11 INFO - Fetch https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:59:12 INFO - Expected file size: 14409776 07:59:12 INFO - Obtained file size: 14409776 07:59:12 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:59:12 INFO - trying https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:59:12 INFO - Downloading https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:59:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:59:13 INFO - Downloaded 55909368 bytes. 07:59:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:59:13 INFO - mkdir: /builds/slave/test/properties 07:59:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:59:13 INFO - Writing to file /builds/slave/test/properties/build_url 07:59:13 INFO - Contents: 07:59:13 INFO - build_url:https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:59:14 INFO - Running post-action listener: _resource_record_post_action 07:59:14 INFO - Running post-action listener: set_extra_try_arguments 07:59:14 INFO - [mozharness: 2016-12-29 15:59:14.118985Z] Finished download-and-extract step (success) 07:59:14 INFO - [mozharness: 2016-12-29 15:59:14.119214Z] Running populate-webroot step. 07:59:14 INFO - Running pre-action listener: _resource_record_pre_action 07:59:14 INFO - Running main action method: populate_webroot 07:59:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:59:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:59:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:59:14 INFO - '--tppagecycles', 07:59:14 INFO - '7'], 07:59:14 INFO - 'tests': ['tsvgm']}}, 07:59:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:59:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:59:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:59:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:59:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:59:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:59:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:59:14 INFO - 'talos_options': ['--disable-e10s'], 07:59:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:59:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:59:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:59:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:59:14 INFO - 'talos_options': ['--disable-e10s'], 07:59:14 INFO - 'tests': ['damp', 'tps']}, 07:59:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:59:14 INFO - 'tests': ['damp', 'tps']}, 07:59:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:59:14 INFO - 'tests': ['dromaeo_dom']}, 07:59:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:59:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:59:14 INFO - 'tests': ['basic_compositor_video']}, 07:59:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:59:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:59:14 INFO - 'tests': ['a11yr', 07:59:14 INFO - 'ts_paint', 07:59:14 INFO - 'tpaint', 07:59:14 INFO - 'sessionrestore', 07:59:14 INFO - 'sessionrestore_no_auto_restore', 07:59:14 INFO - 'tabpaint']}, 07:59:14 INFO - 'other-e10s': {'tests': ['a11yr', 07:59:14 INFO - 'ts_paint', 07:59:14 INFO - 'tpaint', 07:59:14 INFO - 'sessionrestore', 07:59:14 INFO - 'sessionrestore_no_auto_restore', 07:59:14 INFO - 'tabpaint']}, 07:59:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:59:14 INFO - 'ts_paint', 07:59:14 INFO - 'tpaint', 07:59:14 INFO - 'sessionrestore', 07:59:14 INFO - 'sessionrestore_no_auto_restore', 07:59:14 INFO - 'tabpaint']}, 07:59:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:59:14 INFO - 'ts_paint', 07:59:14 INFO - 'tpaint', 07:59:14 INFO - 'sessionrestore', 07:59:14 INFO - 'sessionrestore_no_auto_restore', 07:59:14 INFO - 'tabpaint']}, 07:59:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:59:14 INFO - 'tests': ['a11yr', 07:59:14 INFO - 'ts_paint', 07:59:14 INFO - 'tpaint', 07:59:14 INFO - 'sessionrestore', 07:59:14 INFO - 'sessionrestore_no_auto_restore', 07:59:14 INFO - 'tabpaint']}, 07:59:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:59:14 INFO - 'tests': ['a11yr', 07:59:14 INFO - 'ts_paint', 07:59:14 INFO - 'tpaint', 07:59:14 INFO - 'sessionrestore', 07:59:14 INFO - 'sessionrestore_no_auto_restore', 07:59:14 INFO - 'tabpaint']}, 07:59:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:59:14 INFO - 'tests': ['tsvgx', 07:59:14 INFO - 'tsvgr_opacity', 07:59:14 INFO - 'tart', 07:59:14 INFO - 'tscrollx', 07:59:14 INFO - 'cart', 07:59:14 INFO - 'tsvg_static']}, 07:59:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:59:14 INFO - 'tsvgr_opacity', 07:59:14 INFO - 'tart', 07:59:14 INFO - 'tscrollx', 07:59:14 INFO - 'cart', 07:59:14 INFO - 'tsvg_static']}, 07:59:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:59:14 INFO - 'talos_options': ['--disable-e10s'], 07:59:14 INFO - 'tests': ['tp5o']}, 07:59:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:59:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:59:14 INFO - 'talos_options': ['--disable-e10s', 07:59:14 INFO - '--xperf_path', 07:59:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:59:14 INFO - 'tests': ['tp5n']}, 07:59:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:59:14 INFO - 'talos_options': ['--xperf_path', 07:59:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:59:14 INFO - 'tests': ['tp5n']}}, 07:59:14 INFO - 'talos.zip': {'path': '', 07:59:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:59:14 INFO - Running post-action listener: _resource_record_post_action 07:59:14 INFO - [mozharness: 2016-12-29 15:59:14.138593Z] Finished populate-webroot step (success) 07:59:14 INFO - [mozharness: 2016-12-29 15:59:14.138682Z] Running create-virtualenv step. 07:59:14 INFO - Running pre-action listener: _resource_record_pre_action 07:59:14 INFO - Running main action method: create_virtualenv 07:59:14 INFO - Creating virtualenv /builds/slave/test/build/venv 07:59:14 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:59:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:59:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:59:14 INFO - Using real prefix '/usr' 07:59:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:59:14 INFO - Installing distribute.............................................................................................................................................................................................done. 07:59:16 INFO - Installing pip.................done. 07:59:16 INFO - Return code: 0 07:59:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:59:16 INFO - Reading from file tmpfile_stdout 07:59:16 INFO - Output received: 07:59:16 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:59:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:59:16 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:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:16 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:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:16 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 0x1feb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a820>, '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 0x235b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235b9b0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', '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:59:16 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:59:16 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:59:16 INFO - Using env: {'DISPLAY': ':0', 07:59:16 INFO - 'HOME': '/home/cltbld', 07:59:16 INFO - 'LANG': 'en_US.UTF-8', 07:59:16 INFO - 'LANGUAGE': 'en_US:en', 07:59:16 INFO - 'LOGNAME': 'cltbld', 07:59:16 INFO - 'MAIL': '/var/mail/cltbld', 07:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:16 INFO - 'MOZ_NO_REMOTE': '1', 07:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:16 INFO - 'NO_EM_RESTART': '1', 07:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:16 INFO - 'PWD': '/builds/slave/test', 07:59:16 INFO - 'SHELL': '/bin/bash', 07:59:16 INFO - 'SHLVL': '1', 07:59:16 INFO - 'TERM': 'linux', 07:59:16 INFO - 'TMOUT': '86400', 07:59:16 INFO - 'USER': 'cltbld', 07:59:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', 07:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:16 INFO - '_': '/tools/buildbot/bin/python'} 07:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:17 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:59:17 INFO - Cleaning up... 07:59:17 INFO - Return code: 0 07:59:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:17 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 0x1feb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a820>, '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 0x235b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235b9b0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', '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:59:17 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:59:17 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:59:17 INFO - Using env: {'DISPLAY': ':0', 07:59:17 INFO - 'HOME': '/home/cltbld', 07:59:17 INFO - 'LANG': 'en_US.UTF-8', 07:59:17 INFO - 'LANGUAGE': 'en_US:en', 07:59:17 INFO - 'LOGNAME': 'cltbld', 07:59:17 INFO - 'MAIL': '/var/mail/cltbld', 07:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:17 INFO - 'MOZ_NO_REMOTE': '1', 07:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:17 INFO - 'NO_EM_RESTART': '1', 07:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:17 INFO - 'PWD': '/builds/slave/test', 07:59:17 INFO - 'SHELL': '/bin/bash', 07:59:17 INFO - 'SHLVL': '1', 07:59:17 INFO - 'TERM': 'linux', 07:59:17 INFO - 'TMOUT': '86400', 07:59:17 INFO - 'USER': 'cltbld', 07:59:17 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', 07:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:17 INFO - '_': '/tools/buildbot/bin/python'} 07:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:17 INFO - Downloading/unpacking psutil>=3.1.1 07:59:17 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:59:17 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:59:17 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:59:17 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:59:17 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:59:17 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:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:59:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:19 INFO - Installing collected packages: psutil 07:59:19 INFO - Running setup.py install for psutil 07:59:19 INFO - building 'psutil._psutil_linux' extension 07:59:19 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:59:19 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:59:19 INFO - building 'psutil._psutil_posix' extension 07:59:19 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:59:19 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:59:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:19 INFO - Successfully installed psutil 07:59:19 INFO - Cleaning up... 07:59:20 INFO - Return code: 0 07:59:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:59:20 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:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:20 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:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:20 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 0x1feb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a820>, '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 0x235b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235b9b0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', '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:59:20 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:59:20 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:59:20 INFO - Using env: {'DISPLAY': ':0', 07:59:20 INFO - 'HOME': '/home/cltbld', 07:59:20 INFO - 'LANG': 'en_US.UTF-8', 07:59:20 INFO - 'LANGUAGE': 'en_US:en', 07:59:20 INFO - 'LOGNAME': 'cltbld', 07:59:20 INFO - 'MAIL': '/var/mail/cltbld', 07:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:20 INFO - 'MOZ_NO_REMOTE': '1', 07:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:20 INFO - 'NO_EM_RESTART': '1', 07:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:20 INFO - 'PWD': '/builds/slave/test', 07:59:20 INFO - 'SHELL': '/bin/bash', 07:59:20 INFO - 'SHLVL': '1', 07:59:20 INFO - 'TERM': 'linux', 07:59:20 INFO - 'TMOUT': '86400', 07:59:20 INFO - 'USER': 'cltbld', 07:59:20 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', 07:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:20 INFO - '_': '/tools/buildbot/bin/python'} 07:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:59:20 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:59:20 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:59:20 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:59:20 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:59:20 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:59:20 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:59:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:59:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:59:22 INFO - Installing collected packages: mozsystemmonitor 07:59:22 INFO - Running setup.py install for mozsystemmonitor 07:59:22 INFO - Successfully installed mozsystemmonitor 07:59:22 INFO - Cleaning up... 07:59:22 INFO - Return code: 0 07:59:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:59:22 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:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:22 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:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:22 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 0x1feb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a820>, '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 0x235b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235b9b0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', '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:59:22 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:59:22 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:59:22 INFO - Using env: {'DISPLAY': ':0', 07:59:22 INFO - 'HOME': '/home/cltbld', 07:59:22 INFO - 'LANG': 'en_US.UTF-8', 07:59:22 INFO - 'LANGUAGE': 'en_US:en', 07:59:22 INFO - 'LOGNAME': 'cltbld', 07:59:22 INFO - 'MAIL': '/var/mail/cltbld', 07:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:22 INFO - 'MOZ_NO_REMOTE': '1', 07:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:22 INFO - 'NO_EM_RESTART': '1', 07:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:22 INFO - 'PWD': '/builds/slave/test', 07:59:22 INFO - 'SHELL': '/bin/bash', 07:59:22 INFO - 'SHLVL': '1', 07:59:22 INFO - 'TERM': 'linux', 07:59:22 INFO - 'TMOUT': '86400', 07:59:22 INFO - 'USER': 'cltbld', 07:59:22 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', 07:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:22 INFO - '_': '/tools/buildbot/bin/python'} 07:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:22 INFO - Downloading/unpacking jsonschema==2.5.1 07:59:22 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:59:22 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:59:22 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:59:22 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:59:22 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:59:22 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:59:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:59:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:59:24 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:59:24 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:59:24 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:59:24 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:59:24 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:59:24 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:59:24 INFO - Downloading functools32-3.2.3-2.tar.gz 07:59:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:59:24 INFO - warning: no files found matching '*.txt' 07:59:24 INFO - no previously-included directories found matching 'build' 07:59:24 INFO - no previously-included directories found matching 'dist' 07:59:24 INFO - no previously-included directories found matching '.git*' 07:59:24 INFO - Installing collected packages: jsonschema, functools32 07:59:25 INFO - Running setup.py install for functools32 07:59:25 INFO - warning: no files found matching '*.txt' 07:59:25 INFO - no previously-included directories found matching 'build' 07:59:25 INFO - no previously-included directories found matching 'dist' 07:59:25 INFO - no previously-included directories found matching '.git*' 07:59:25 INFO - Successfully installed jsonschema functools32 07:59:25 INFO - Cleaning up... 07:59:25 INFO - Return code: 0 07:59:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:59:25 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:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:25 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:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:25 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 0x1feb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a820>, '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 0x235b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235b9b0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', '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:59:25 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:59:25 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:59:25 INFO - Using env: {'DISPLAY': ':0', 07:59:25 INFO - 'HOME': '/home/cltbld', 07:59:25 INFO - 'LANG': 'en_US.UTF-8', 07:59:25 INFO - 'LANGUAGE': 'en_US:en', 07:59:25 INFO - 'LOGNAME': 'cltbld', 07:59:25 INFO - 'MAIL': '/var/mail/cltbld', 07:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:25 INFO - 'MOZ_NO_REMOTE': '1', 07:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:25 INFO - 'NO_EM_RESTART': '1', 07:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:25 INFO - 'PWD': '/builds/slave/test', 07:59:25 INFO - 'SHELL': '/bin/bash', 07:59:25 INFO - 'SHLVL': '1', 07:59:25 INFO - 'TERM': 'linux', 07:59:25 INFO - 'TMOUT': '86400', 07:59:25 INFO - 'USER': 'cltbld', 07:59:25 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', 07:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:25 INFO - '_': '/tools/buildbot/bin/python'} 07:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:59:25 INFO - Cleaning up... 07:59:25 INFO - Return code: 0 07:59:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:59:25 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:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:25 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:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:25 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 0x1feb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a820>, '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 0x235b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235b9b0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', '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:59:25 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:59:25 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:59:25 INFO - Using env: {'DISPLAY': ':0', 07:59:25 INFO - 'HOME': '/home/cltbld', 07:59:25 INFO - 'LANG': 'en_US.UTF-8', 07:59:25 INFO - 'LANGUAGE': 'en_US:en', 07:59:25 INFO - 'LOGNAME': 'cltbld', 07:59:25 INFO - 'MAIL': '/var/mail/cltbld', 07:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:25 INFO - 'MOZ_NO_REMOTE': '1', 07:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:25 INFO - 'NO_EM_RESTART': '1', 07:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:25 INFO - 'PWD': '/builds/slave/test', 07:59:25 INFO - 'SHELL': '/bin/bash', 07:59:25 INFO - 'SHLVL': '1', 07:59:25 INFO - 'TERM': 'linux', 07:59:25 INFO - 'TMOUT': '86400', 07:59:25 INFO - 'USER': 'cltbld', 07:59:25 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', 07:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:25 INFO - '_': '/tools/buildbot/bin/python'} 07:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:25 INFO - Downloading/unpacking blobuploader==1.2.4 07:59:25 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:59:25 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:59:25 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:59:25 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:59:25 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:59:25 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:59:27 INFO - Downloading blobuploader-1.2.4.tar.gz 07:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:59:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:59:27 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:59:27 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:59:27 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:59:27 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:59:27 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:59:27 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:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:59:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:59:28 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:59:28 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:59:28 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:59:28 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:59:28 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:59:28 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:59:28 INFO - Downloading docopt-0.6.1.tar.gz 07:59:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:59:28 INFO - Installing collected packages: blobuploader, requests, docopt 07:59:28 INFO - Running setup.py install for blobuploader 07:59:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:59:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:59:28 INFO - Running setup.py install for requests 07:59:28 INFO - Running setup.py install for docopt 07:59:28 INFO - Successfully installed blobuploader requests docopt 07:59:28 INFO - Cleaning up... 07:59:29 INFO - Return code: 0 07:59:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:29 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 0x1feb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a820>, '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 0x235b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235b9b0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', '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:59:29 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:59:29 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:59:29 INFO - Using env: {'DISPLAY': ':0', 07:59:29 INFO - 'HOME': '/home/cltbld', 07:59:29 INFO - 'LANG': 'en_US.UTF-8', 07:59:29 INFO - 'LANGUAGE': 'en_US:en', 07:59:29 INFO - 'LOGNAME': 'cltbld', 07:59:29 INFO - 'MAIL': '/var/mail/cltbld', 07:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:29 INFO - 'MOZ_NO_REMOTE': '1', 07:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:29 INFO - 'NO_EM_RESTART': '1', 07:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:29 INFO - 'PWD': '/builds/slave/test', 07:59:29 INFO - 'SHELL': '/bin/bash', 07:59:29 INFO - 'SHLVL': '1', 07:59:29 INFO - 'TERM': 'linux', 07:59:29 INFO - 'TMOUT': '86400', 07:59:29 INFO - 'USER': 'cltbld', 07:59:29 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', 07:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:29 INFO - '_': '/tools/buildbot/bin/python'} 07:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:59:29 INFO - Running setup.py (path:/tmp/pip-S_cKHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:59:29 INFO - Running setup.py (path:/tmp/pip-Tvb_s6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:59:29 INFO - Running setup.py (path:/tmp/pip-SMsfsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:59:29 INFO - Running setup.py (path:/tmp/pip-jSO0o2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:59:29 INFO - Running setup.py (path:/tmp/pip-gOdSfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:59:29 INFO - Running setup.py (path:/tmp/pip-peYzjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:59:29 INFO - Running setup.py (path:/tmp/pip-CTXEV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:59:29 INFO - Running setup.py (path:/tmp/pip-91uyDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:59:29 INFO - Running setup.py (path:/tmp/pip-f1vbss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:59:29 INFO - Running setup.py (path:/tmp/pip-0Dqlpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:59:29 INFO - Running setup.py (path:/tmp/pip-A9FcEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:59:30 INFO - Running setup.py (path:/tmp/pip-MZD7x6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:59:30 INFO - Running setup.py (path:/tmp/pip-8MiJlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:59:30 INFO - Running setup.py (path:/tmp/pip-A0oBUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:30 INFO - Running setup.py (path:/tmp/pip-vDMf2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:59:30 INFO - Running setup.py (path:/tmp/pip-egMPxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:59:30 INFO - Running setup.py (path:/tmp/pip-lbX77G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:59:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:59:30 INFO - Running setup.py install for manifestparser 07:59:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:59:30 INFO - Running setup.py install for mozcrash 07:59:30 INFO - Running setup.py install for mozdebug 07:59:30 INFO - Running setup.py install for mozdevice 07:59:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:59:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:59:30 INFO - Running setup.py install for mozfile 07:59:30 INFO - Running setup.py install for mozhttpd 07:59:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:59:31 INFO - Running setup.py install for mozinfo 07:59:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:59:31 INFO - Running setup.py install for mozInstall 07:59:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:59:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:59:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:59:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:59:31 INFO - Running setup.py install for mozleak 07:59:31 INFO - Running setup.py install for mozlog 07:59:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:59:31 INFO - Running setup.py install for moznetwork 07:59:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:59:31 INFO - Running setup.py install for mozprocess 07:59:31 INFO - Running setup.py install for mozprofile 07:59:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:59:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:59:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:59:31 INFO - Running setup.py install for mozrunner 07:59:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:59:31 INFO - Running setup.py install for mozscreenshot 07:59:32 INFO - Running setup.py install for moztest 07:59:32 INFO - Running setup.py install for mozversion 07:59:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:59:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:59:32 INFO - Cleaning up... 07:59:32 INFO - Return code: 0 07:59:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:32 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:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:32 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:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:32 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 0x1feb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a820>, '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 0x235b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235b9b0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', '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:59:32 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:59:32 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:59:32 INFO - Using env: {'DISPLAY': ':0', 07:59:32 INFO - 'HOME': '/home/cltbld', 07:59:32 INFO - 'LANG': 'en_US.UTF-8', 07:59:32 INFO - 'LANGUAGE': 'en_US:en', 07:59:32 INFO - 'LOGNAME': 'cltbld', 07:59:32 INFO - 'MAIL': '/var/mail/cltbld', 07:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:32 INFO - 'MOZ_NO_REMOTE': '1', 07:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:32 INFO - 'NO_EM_RESTART': '1', 07:59:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:32 INFO - 'PWD': '/builds/slave/test', 07:59:32 INFO - 'SHELL': '/bin/bash', 07:59:32 INFO - 'SHLVL': '1', 07:59:32 INFO - 'TERM': 'linux', 07:59:32 INFO - 'TMOUT': '86400', 07:59:32 INFO - 'USER': 'cltbld', 07:59:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', 07:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:32 INFO - '_': '/tools/buildbot/bin/python'} 07:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:59:32 INFO - Running setup.py (path:/tmp/pip-ji2iZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:59:32 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:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:59:32 INFO - Running setup.py (path:/tmp/pip-0VjzIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:59:32 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:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:59:32 INFO - Running setup.py (path:/tmp/pip-Kh2Str-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:59:32 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:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:59:32 INFO - Running setup.py (path:/tmp/pip-xcJumV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:59:32 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:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:59:32 INFO - Running setup.py (path:/tmp/pip-bCMULS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:59:32 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:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:59:32 INFO - Running setup.py (path:/tmp/pip-TlM6zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:59:32 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:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:59:32 INFO - Running setup.py (path:/tmp/pip-sbjXMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:59:32 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:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:59:32 INFO - Running setup.py (path:/tmp/pip-rvTWEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:59:33 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:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:59:33 INFO - Running setup.py (path:/tmp/pip-X9jNm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:59:33 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:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:59:33 INFO - Running setup.py (path:/tmp/pip-JYr9Vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:59:33 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:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:59:33 INFO - Running setup.py (path:/tmp/pip-eHR0mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:59:33 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:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:59:33 INFO - Running setup.py (path:/tmp/pip-e6pVL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:59:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:59:33 INFO - Running setup.py (path:/tmp/pip-TrXDxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:59:33 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:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:59:33 INFO - Running setup.py (path:/tmp/pip-gg_pNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:59:33 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:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:33 INFO - Running setup.py (path:/tmp/pip-aRgPm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:33 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:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:59:33 INFO - Running setup.py (path:/tmp/pip-e4_p8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:59:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:59:33 INFO - Running setup.py (path:/tmp/pip-pRPWh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:59:33 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:59:33 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:59:33 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:59:33 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:59:33 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:59:33 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:59:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:35 INFO - Downloading blessings-1.6.tar.gz 07:59:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:59:35 INFO - Installing collected packages: blessings 07:59:35 INFO - Running setup.py install for blessings 07:59:35 INFO - Successfully installed blessings 07:59:35 INFO - Cleaning up... 07:59:35 INFO - Return code: 0 07:59:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:59:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:59:36 INFO - Reading from file tmpfile_stdout 07:59:36 INFO - Current package versions: 07:59:36 INFO - argparse == 1.2.1 07:59:36 INFO - blessings == 1.6 07:59:36 INFO - blobuploader == 1.2.4 07:59:36 INFO - docopt == 0.6.1 07:59:36 INFO - functools32 == 3.2.3-2 07:59:36 INFO - jsonschema == 2.5.1 07:59:36 INFO - manifestparser == 1.1 07:59:36 INFO - mozInstall == 1.12 07:59:36 INFO - mozcrash == 1.0 07:59:36 INFO - mozdebug == 0.1 07:59:36 INFO - mozdevice == 0.49 07:59:36 INFO - mozfile == 1.2 07:59:36 INFO - mozhttpd == 0.7 07:59:36 INFO - mozinfo == 0.9 07:59:36 INFO - mozleak == 0.1 07:59:36 INFO - mozlog == 3.4 07:59:36 INFO - moznetwork == 0.27 07:59:36 INFO - mozprocess == 0.23 07:59:36 INFO - mozprofile == 0.28 07:59:36 INFO - mozrunner == 6.13 07:59:36 INFO - mozscreenshot == 0.1 07:59:36 INFO - mozsystemmonitor == 0.3 07:59:36 INFO - moztest == 0.7 07:59:36 INFO - mozversion == 1.4 07:59:36 INFO - psutil == 3.1.1 07:59:36 INFO - requests == 1.2.3 07:59:36 INFO - wsgiref == 0.1.2 07:59:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:36 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 0x1feb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a820>, '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 0x235b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235b9b0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', '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:59:36 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:59:36 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:59:36 INFO - Using env: {'DISPLAY': ':0', 07:59:36 INFO - 'HOME': '/home/cltbld', 07:59:36 INFO - 'LANG': 'en_US.UTF-8', 07:59:36 INFO - 'LANGUAGE': 'en_US:en', 07:59:36 INFO - 'LOGNAME': 'cltbld', 07:59:36 INFO - 'MAIL': '/var/mail/cltbld', 07:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:36 INFO - 'MOZ_NO_REMOTE': '1', 07:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:36 INFO - 'NO_EM_RESTART': '1', 07:59:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:36 INFO - 'PWD': '/builds/slave/test', 07:59:36 INFO - 'SHELL': '/bin/bash', 07:59:36 INFO - 'SHLVL': '1', 07:59:36 INFO - 'TERM': 'linux', 07:59:36 INFO - 'TMOUT': '86400', 07:59:36 INFO - 'USER': 'cltbld', 07:59:36 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', 07:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:36 INFO - '_': '/tools/buildbot/bin/python'} 07:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:36 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:59:36 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:59:36 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:59:36 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:59:36 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:59:36 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:59:36 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:59:36 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:59:36 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:59:36 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:59:36 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:59:36 INFO - Cleaning up... 07:59:36 INFO - Return code: 0 07:59:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235a820>, '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 0x235b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235b9b0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', '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:59:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:59:36 INFO - Using env: {'DISPLAY': ':0', 07:59:36 INFO - 'HOME': '/home/cltbld', 07:59:36 INFO - 'LANG': 'en_US.UTF-8', 07:59:36 INFO - 'LANGUAGE': 'en_US:en', 07:59:36 INFO - 'LOGNAME': 'cltbld', 07:59:36 INFO - 'MAIL': '/var/mail/cltbld', 07:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:36 INFO - 'MOZ_NO_REMOTE': '1', 07:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:36 INFO - 'NO_EM_RESTART': '1', 07:59:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:36 INFO - 'PWD': '/builds/slave/test', 07:59:36 INFO - 'SHELL': '/bin/bash', 07:59:36 INFO - 'SHLVL': '1', 07:59:36 INFO - 'TERM': 'linux', 07:59:36 INFO - 'TMOUT': '86400', 07:59:36 INFO - 'USER': 'cltbld', 07:59:36 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', 07:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:36 INFO - '_': '/tools/buildbot/bin/python'} 07:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:59:36 INFO - Cleaning up... 07:59:36 INFO - Return code: 0 07:59:36 INFO - Running post-action listener: _resource_record_post_action 07:59:36 INFO - Running post-action listener: _start_resource_monitoring 07:59:36 INFO - Starting resource monitoring. 07:59:36 INFO - [mozharness: 2016-12-29 15:59:36.721096Z] Finished create-virtualenv step (success) 07:59:36 INFO - [mozharness: 2016-12-29 15:59:36.721616Z] Running install step. 07:59:36 INFO - Running pre-action listener: _resource_record_pre_action 07:59:36 INFO - Running main action method: install 07:59:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:59:36 INFO - Reading from file tmpfile_stdout 07:59:36 INFO - Detecting whether we're running mozinstall >=1.0... 07:59:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:59:37 INFO - Reading from file tmpfile_stdout 07:59:37 INFO - Output received: 07:59:37 INFO - Usage: mozinstall [options] installer 07:59:37 INFO - Options: 07:59:37 INFO - -h, --help show this help message and exit 07:59:37 INFO - -d DEST, --destination=DEST 07:59:37 INFO - Directory to install application into. [default: 07:59:37 INFO - "/builds/slave/test"] 07:59:37 INFO - --app=APP Application being installed. [default: firefox] 07:59:37 INFO - mkdir: /builds/slave/test/build/application 07:59:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:59:53 INFO - Reading from file tmpfile_stdout 07:59:53 INFO - Output received: 07:59:53 INFO - /builds/slave/test/build/application/firefox/firefox 07:59:53 INFO - Running post-action listener: _resource_record_post_action 07:59:53 INFO - [mozharness: 2016-12-29 15:59:53.100570Z] Finished install step (success) 07:59:53 INFO - [mozharness: 2016-12-29 15:59:53.100814Z] Running run-tests step. 07:59:53 INFO - Running pre-action listener: _resource_record_pre_action 07:59:53 INFO - Running main action method: run_tests 07:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:59:53 INFO - Python 2.7.3 07:59:53 INFO - Return code: 0 07:59:53 INFO - grabbing minidump binary from tooltool 07:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:53 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 0x235a820>, '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 0x235b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x235b9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:59:53 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:59:53 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:59:53 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:59:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:59:53 INFO - Return code: 0 07:59:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:59:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:59:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:59:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:59:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:59:53 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/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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:59:53 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/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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:59:53 INFO - Using env: {'DISPLAY': ':0', 07:59:53 INFO - 'HOME': '/home/cltbld', 07:59:53 INFO - 'LANG': 'en_US.UTF-8', 07:59:53 INFO - 'LANGUAGE': 'en_US:en', 07:59:53 INFO - 'LOGNAME': 'cltbld', 07:59:53 INFO - 'MAIL': '/var/mail/cltbld', 07:59:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:59:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:53 INFO - 'MOZ_NO_REMOTE': '1', 07:59:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:53 INFO - 'NO_EM_RESTART': '1', 07:59:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:53 INFO - 'PWD': '/builds/slave/test', 07:59:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:59:53 INFO - 'SHELL': '/bin/bash', 07:59:53 INFO - 'SHLVL': '1', 07:59:53 INFO - 'TERM': 'linux', 07:59:53 INFO - 'TMOUT': '86400', 07:59:53 INFO - 'USER': 'cltbld', 07:59:53 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451', 07:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:53 INFO - '_': '/tools/buildbot/bin/python'} 07:59:53 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/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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:59:53 INFO - mozversion application_buildid: 20161229070619 07:59:53 INFO - mozversion application_changeset: 87efd66165ddaa1b97608b92cd651b73c11aca6f 07:59:53 INFO - mozversion application_display_name: Nightly 07:59:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:59:53 INFO - mozversion application_name: Firefox 07:59:53 INFO - mozversion application_remotingname: firefox 07:59:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:59:53 INFO - mozversion application_vendor: Mozilla 07:59:53 INFO - mozversion application_version: 53.0a1 07:59:53 INFO - mozversion platform_buildid: 20161229070619 07:59:53 INFO - mozversion platform_changeset: 87efd66165ddaa1b97608b92cd651b73c11aca6f 07:59:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:59:53 INFO - mozversion platform_version: 53.0a1 07:59:53 INFO - using testdate: 1483027193 07:59:53 INFO - actual date: 1483027193 07:59:53 INFO - starting webserver on 'localhost:38275' 07:59:53 INFO - SUITE-START | Running 2 tests 07:59:53 INFO - TEST-START | dromaeo_css 07:59:53 INFO - operating with platform_type : linux_ 07:59:53 INFO - Initialising browser for dromaeo_css test... 07:59:53 INFO - TEST-INFO | started process 30407 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6rmaSS/profile http://localhost:38275/getInfo.html) 07:59:53 INFO - PROCESS | 30407 | 1483027193917 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 07:59:57 INFO - PROCESS | 30407 | __metrics Screen width/height:1600/1200 07:59:57 INFO - PROCESS | 30407 | colorDepth:24 07:59:57 INFO - PROCESS | 30407 | Browser inner width/height: 1024/697 07:59:57 INFO - PROCESS | 30407 | __metrics 07:59:58 ERROR - PROCESS | 30407 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 07:59:59 INFO - TEST-INFO | 30407: exit 0 07:59:59 INFO - Browser initialized. 07:59:59 INFO - Running cycle 1/1 for dromaeo_css test... 07:59:59 INFO - TEST-INFO | started process 30530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6rmaSS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:00:11 INFO - PROCESS | 30530 | RSS: Main: 158093312 08:00:11 INFO - PROCESS | 30530 | 08:03:15 INFO - PROCESS | 30530 | Cycle 1(1): loaded http://localhost:38275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38275/tests/dromaeo/cssquery-ext.html) 08:03:16 INFO - PROCESS | 30530 | RSS: Main: 167469056 08:03:16 INFO - PROCESS | 30530 | 08:04:59 INFO - PROCESS | 30530 | ************************* 08:04:59 INFO - PROCESS | 30530 | A coding exception was thrown and uncaught in a Task. 08:04:59 INFO - PROCESS | 30530 | 08:04:59 INFO - PROCESS | 30530 | Full message: ReferenceError: fetch is not defined 08:04:59 INFO - PROCESS | 30530 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 08:04:59 INFO - PROCESS | 30530 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 08:04:59 INFO - PROCESS | 30530 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 08:04:59 INFO - PROCESS | 30530 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:04:59 INFO - PROCESS | 30530 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:04:59 INFO - PROCESS | 30530 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:04:59 INFO - PROCESS | 30530 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 08:04:59 INFO - PROCESS | 30530 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:04:59 INFO - PROCESS | 30530 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:04:59 INFO - PROCESS | 30530 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:04:59 INFO - PROCESS | 30530 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 08:04:59 INFO - PROCESS | 30530 | 08:04:59 INFO - PROCESS | 30530 | ************************* 08:06:19 INFO - PROCESS | 30530 | Cycle 1(1): loaded http://localhost:38275/tests/dromaeo/cssquery-ext.html (next: http://localhost:38275/tests/dromaeo/cssquery-jquery.html) 08:06:19 INFO - PROCESS | 30530 | RSS: Main: 163065856 08:06:19 INFO - PROCESS | 30530 | 08:09:21 INFO - PROCESS | 30530 | Cycle 1(1): loaded http://localhost:38275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38275/tests/dromaeo/cssquery-mootools.html) 08:09:22 INFO - PROCESS | 30530 | RSS: Main: 168271872 08:09:22 INFO - PROCESS | 30530 | 08:12:24 INFO - PROCESS | 30530 | Cycle 1(1): loaded http://localhost:38275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38275/tests/dromaeo/cssquery-prototype.html) 08:12:25 INFO - PROCESS | 30530 | RSS: Main: 163348480 08:12:25 INFO - PROCESS | 30530 | 08:15:28 INFO - PROCESS | 30530 | Cycle 1(1): loaded http://localhost:38275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38275/tests/dromaeo/cssquery-yui.html) 08:15:28 INFO - PROCESS | 30530 | RSS: Main: 166068224 08:15:28 INFO - PROCESS | 30530 | 08:18:31 INFO - PROCESS | 30530 | Cycle 1(1): loaded http://localhost:38275/tests/dromaeo/cssquery-yui.html (next: http://localhost:38275/tests/dromaeo/cssquery-dojo.html) 08:18:32 INFO - PROCESS | 30530 | RSS: Main: 166944768 08:18:32 INFO - PROCESS | 30530 | 08:18:32 INFO - PROCESS | 30530 | __start_tp_report 08:18:32 INFO - PROCESS | 30530 | _x_x_mozilla_page_load 08:18:32 INFO - PROCESS | 30530 | _x_x_mozilla_page_load_details 08:18:32 INFO - PROCESS | 30530 | |i|pagename|runs| 08:18:32 INFO - PROCESS | 30530 | |0;dojo.html;2636.2486691292984;2649.205238428471;2649.562822134348;2676.51822671919;2677.2905180127264;4733.763311834403;4801.135795556794;4813.013332266885;4825.855224343267;4834.782434790434;4772.57046865782;4854.7329896855745;4907.26391041344;4910.9263361049525;4981.028699403618;4399.846005389812;4454.97772511137;4477.597016268535;4532.66005049621;4559.863204103882;4051.9392209116886;4515.164694531506;4530;4547.704399214041;4560.247559152735;4311.310190369557;4450.710703804275;4471.3293006049025;4482.887927801815;4563.817447302104;4360.672949528798;4419.491758447787;4444.444444444444;4458.71018383804;4533.320001999694;4413.977930110329;4427.977860110679;4428.22506061438;4438.289873620238;4444.711093778894;4829.227323628203;4831.516848315176;4868.780904859254;4871.12319782439;4880.804767809319;4967.751612419364;5014.674046186986;5151.278820965068;5200.167973124319;5202.03762303975;5261.500157485033;5270.49930256625;5273.630845840793;5276.894462110737;5315.335583052119;4933.975330123327;4945.703257804544;4950.331705219821;4950.727709975914;4988.326575912241;5176.249443830623;5191.766370513336;5198.4801519847715;5273.815416460406;5385.838424847261;5004.524570165829;5041.168207245837;5063.746812659352;5063.974680126649;5064.240363945438;5123.974380128076;5132.358455193101;5133.281340612317;5137.101007323703;5144.588432925357;5087.033463641897;5117.8464646060675;5151.562117220078;5157.510036546522;5284.233786100994;5200.453952335026;5216.035033518811;5222.2427747976335;5223.869403264949;5224.320838290998;4393.890152746143;4393.978030109829;4396.208682437192;4404.977975110104;4442.911141777146;3693.4829123922673;3720.6651401374006;3752.9437058444146;3755.080005398695;3773.716971227169;4444.511103778582;4455.487618923865;4469.754163520973;4478.992226749021;4505.954940450619;5206.479352064764;5215.29593504872;5217.34783152106;5226.3205783248695;5262.973685131627;4336.306191009423;4365.716228445141;4367.737935723867;4411.029573493826;4465.151621192028;4559.817607295738;4570.4743954445;4571.565701258375;4580.358749775034;4583.770811459413;4815.470298267188;4823.614110871192;4836.443808962014;4843.055604157155;4848.466668666514;5124.180131178993;5138.76875540609;5149.124648809786;5149.794008239778;5153.613478989166;4824.252240902666;4827.372441582572;4829.420469543677;4829.73436460998;4839.879003024953;5024.346834911438;5039.294498770102;5057.8229761958155;5118.078745825638;5118.97440512795;5239.135542635422;5241.344831896013;5243.449437809128;5256.05391029603;5287.154055351125;5076.289319495348;5086.61850361217;5093.337866077386;5098;5143.819966301162;4924.8768780780765;4937.0372777308085;4983.401991761012;5051.974740126276;5066.873328166826;4884.926726099183;4941.110600092018;4948.331975183448;4954.653174277766;4963.900721985612;4986.8753281168265;5023.723695196799;5041.521055499722;5048.621353398436;5069.6197785167;4786.664933454625;4837.516248375135;4923.876903077452;4930.950690493192;4983 08:18:32 INFO - PROCESS | 30530 | |1;ext.html;490.78650786907684;502.5728131088573;510.42832028128504;512.1421618788529;514.7837908078607;36183;39150.21699566011;39153.21693566131;43477.7826110869;44020.55979440205;40102;40451.59548404515;40811;40878;41059.38410923839;7562.130355009175;7831.334336581397;7858.253465920757;9410.38832475887;9739.220862330996;9390.765230869214;9646.855297170512;9650.613975440974;9662.806743865118;9667.12995830375;9675.467849268287;9675.806483870318;9677.225821934264;9693.273004524654;9694.321397502177;9584.568694408734;9625.085616866387;9647.131758141766;9653.082957119062;9688.321817472779;9528.809423811485;9593.088656577615;9605.18355939746;9606.903930960741;9609.471479068648;34305.6569434305;34333.65666343355;34465.65534344675;34616.30767384638;34650.653493465245;3630.528031355907;3685.4656074869263;3709.1098136447326;3746.9017350283657;3775.6224377562025;25652;25686.87156564224;25710.48579028409;25880.482390352277;27034.729652703616;3363.697267245935;3365.074604483762;3378.45944648855;3415.1803567143957;3418.3505134024704;225814;226556;227253;227930.86034569886;228468;46624.76687616608;46690;46733.532664672915;46804.76597617058;47019.52980470152;48869;48945.51054489481;49273.753631231615;49365.25952110721;49399;12869.099163058496;13132.146410483288;13203.339833008504;13231.933840330928;13287.20276783396;9940.403575785476;10228.897711022795;10242.48787560619;10360.222983276284;10395.94802026;16093.758593621105;16099.758503622455;16184.83815161857;16231.756523652155;16300.184990750653;6353.68231588428;6446.871062578723;6454.677266136674;6585.80242592723;6633.4693224541925;737.8266107464741;754.7547047209679;762.5462849604477;767.4359345880773;780.9609519524115;26849.463010739677;27870.5819412709;27990.510675490073;27992.300192494942;28109.578356324673;843.8312337532518;907.7957459571676;911.1844898815523;912.5209265135724;912.5847739278745;14082.859171408154;14933.70132597342;15082.622934426727;15269.9236503819;15282.159481228417;362847;365833;366785;367677;367977;49758.50241497611;50315.496845031084;50465.24302135471;50628.49371506238;50732.23901641478;1137.4995002199005;1172.372780562395;1184.3782014442486;1187.8574571051702;1189.4885199364358;26196.345091372867;26934.191974240803;26965.595516067668;27576.448471030868;27636.309092272855;41840.58159418367;42458.57541424546;42591.57408426;42598.78700606477;42632.78683606562;291354;291896;292844;293048;294162;22167.667484987414;22877;22946.246450426057;23597.882010589838;24048.87975560181;36091;36491.27017459689;37273.81363093167;37295;37618.623813761515;31562;32031.519527207576;32169.839150804095;32442.513362299112;32499.837500812344;31011.534826977164;31485.370292594478;31564;31576;32475.512867307483;31047.53428698526;31310.843445782626;31474.842625786725;31587.36825263528;34564.82717586396;26516.734832652197;27204.863975679997;29520.704792951794;29717.40565188641;30205.244868877573;23348.416289592897;23587.64618530689;23731;23971;24037.639435408833 08:18:32 INFO - PROCESS | 30530 | |2;jquery.html;358.6449415079073;375.07543904275957;376.25877022266127;378.80870160568907;401.09753055624844;15593.610159745998;16644.251008704607;16670.91664541677;16764.245608947596;16794.916025419887;15785.13181775002;15913.124778137199;16194.352225910949;16253.349866005376;16329.510114696579;4958.999999999991;5152.583039664085;5187.170052791555;5189;5194.610404219679;5068.163752980772;5151.510606492396;5445.237666726662;5466.508014278714;5542.695151766651;5488.945110548903;5498.45015498451;5503.587230957674;5512.090505066659;5519.751611177487;5352.785888564472;5472.589555783293;5485.506304432601;5525.806596769134;5537.390887002426;5323.760430780624;5346.91979620306;5347.491988261109;5356.6518176318805;5362.892742145135;12336.629901102891;17680.939143651292;18196.818031819777;18950.336738214097;19177.32879349216;2098.790120987904;2147.914083436661;2161.7730138335564;2179.9564008719735;2214.660130620983;8813.471191728453;9103.271738260923;9370.953145234298;9381.577828997712;9687.17658998986;1647.365764180787;1681.9092803397655;1685.983140168595;1713.1091832247287;1718.9398371056952;57851.79845385136;63948.680256598884;64835;65702.67148664226;66481.33518664849;9727.124558789743;9876.308658393844;9892.950535247277;10076.244281678903;10531.315464494937;13431.19412835233;13551.577084406192;13569.728605427836;13570.117942333716;13580.38888250031;6822.624755638488;7040.401565866856;7056.964715176494;7260.491765576465;7267.1279446465705;6646.163004117191;6680.565763225375;6822.624755638389;6837.316268373223;6931.202911665122;4222.619964203236;4271.423357846713;4296.763677997677;4357.3899654048455;4406.427164468599;1685.1153144599184;1738.1309345327336;1747.632997070604;1792.5608225984718;1864.2077117225126;909.1635695160468;923.2475532441039;930.55798495714;930.6277489004452;943.613118621362;15606;15756.842431575767;15768.842311576967;16353.672926541403;16565.91717041407;924.5700749151677;928.4243768863348;933.6638810028385;934.0892629686002;934.238595544629;9131.13254240846;9159.90840091604;9265.517517197217;9394;9433.90566094344;356501;359304;360226;364173;367102;73570.63214684;74201.6289918547;74226;75049.24950750422;77472.61263693645;900.7252787899754;928.2852203803169;945.8108378324363;947.7630592351912;951.9428834269827;15134.243287835785;15268.3892644293;15331.390204028863;15331.923340383673;15933.68132637364;36856.631433686394;37085.62914370822;37275.81362093172;37768.811155944044;37842;47910.76044619754;48066.27900581424;48166;48439;50894;6701.966490167518;7037.331453511908;7060;7184.6048467334795;7735.4198435118715;11169.944150279196;11833.881661183623;11893.167478276437;11988.220765650205;12150.149489536001;9216.447013179231;9266.258699304175;9836.754081148028;10117.898821011695;10199.235057370579;9647.9035209647;9899.109080182818;10268;10309.845352319871;10501.684949451223;9058.456492610465;9215.585298661443;9522.333436659368;9548.474833884204;9602.183814375856;6794.8641027180165;6984.755533556505;6993.335633114846;7348.96325518369;7695.615219239127;4921.4832442593015;5099.56653684441;7882.566458844819;9320.983953799863;9477.336586439158 08:18:32 INFO - PROCESS | 30530 | |3;mootools.html;1316.2694704439036;1336.7126067895406;1344.6503908983664;1347.528365072225;1350.1021820489375;6465.159529261189;6720.764773232938;6949.687264073116;7442.665080071396;7487.101547814256;7029.89455158173;7265.600391978439;7288.271172882709;7374.63126843657;7388.076490438695;2069.5860827834454;2119.205298013245;2119.4383488375515;2119.7562280337806;2120.9151633934625;2104.4738815296178;2119.2370746531237;2141.9892900535474;2159.9352019439443;2191.991683825442;2125.936221913345;2132.744070711517;2134.4770531219874;2153.364757396572;2157.870527768339;2045.2125931516325;2058.83529317655;2078.8856612886284;2079.7712251652306;2083.8853863037525;2050.7026481160146;2058.3207541511265;2093.152273329304;2095.1514636572215;2108.5466624675614;7393.408527317802;7475.9252407476315;7585.696572137108;7592.240775922363;7606.657700403495;4525.389072475206;4665.86002419928;4667.206574882244;4688.109259240768;4694.530546945312;2664.706882242952;2884.120343295294;2900.8404537750416;2942.1173647905543;2962.896298629538;989.0455710239581;998.5107297424282;1024.9231307651955;1059.8569193158903;1111.0445017285128;9719.125278724878;9802.754931126708;9854.556544955494;9858.90141098587;9889.653862114792;3744.382176940774;3904.941425878614;3944.053427177457;3966.4050392440786;3996.040950171996;7862.921370786219;7906.130325664172;7922.920770792333;7932.365410767125;7935.008123984502;4452.821887124479;4492.168948744493;4496.392986946786;4496.977515112469;4500.189965806121;3985.661218796377;3991.201759648024;4051.554329023805;4066.8373265069067;4070.104576993116;3139.654637989819;3196.712295893334;3212.421764082441;3307.4377355849565;3339.482380231068;893.6112790935964;922.460360688991;961.5192403798101;967.8693376394237;970.9271804614682;643.3598569423453;660.745612939022;665.065582856088;667.1560475997867;671.3051991189096;4610.239310513794;4647.372604698322;4746.762661866962;4758.405199350082;5022.146235140035;813.3940214540205;816.7835523586255;817.1787353709602;818.5743413424985;819.9590020498952;3251.4797632378704;3307.6196237433005;3335.849886755102;3339.699427051577;3360.5967283925597;8581.871271930926;8758;8814;8875.866861997076;8883.37816352862;8757.386982911135;8763.69327073562;8800.735977920545;8829.60266787996;8853.070427605138;6341.270753863365;6603.339666033358;6613.173353330833;6734.56225345351;6756.054152418666;4689.882752931204;4778.092162489116;4796.95203047979;4867.878303042452;5055.418626857959;7870.881936771068;7971.1630278819885;8048.154943731058;8077.15189905075;8078.878816817635;8030.277275045274;8044.31623312025;8177.386695997943;8179.591020448835;8192;6181.196444462191;6322.367763223825;6363;6364.427201551883;6376.298607153302;6748.932510675027;6811.557248779011;6811.69347379379;6814.386705196358;6844.315568443116;6282.560220784684;6340.841478963062;6374.58565193261;6387.105805187371;6491.545591808528;5993.790217342372;6049.455549000435;6062.090686397076;6062.42406971337;6207.317195108444;5401.729913504388;5483.424240454695;5485.862853428696;5489.094299440707;5499.9175012375645;4146.771927544014;4250.893727656833;4314.180305741899;4315.611594956469;4329.307310830252;4221.683373747042;4246.639035682002;4285.442892423965;4290.334998075304;4333.1766964276685 08:18:32 INFO - PROCESS | 30530 | |4;prototype.html;356.68433436408776;360.482707315003;362.8312834531942;365.0381245418322;370.4924253772334;4986.326845875806;5007.871654546812;5013.699178049315;5026.648134630577;5027.773750181242;4876.463589005207;4923.384576927884;4923.60611151108;4953.430355509117;4986.202207646777;3708.7589306695045;3711.6845068169237;3903.668188204006;3925.234579257046;3943.5662077171633;3913.139109395943;3913.3934240192816;3928.292907276689;3932.9410058849;3949.19041596472;3915.9804200978956;3935.291647503448;3935.7638541687447;3948.7828169450668;3956.2483128205695;3847.769133851978;3907.8632247871187;3934.9016274593077;3942.3495123304765;3954.169624378884;3509.946681191506;3518;3523.612402635708;3525.964740352589;3544.680978711928;4753.595944344735;4765.927666275061;4778.641601879873;4781.235002399634;4809.302651115569;4426.203283408985;4446.3108218226225;4494.9775251123865;4499.977500112478;4544.454665440136;5116.744162791845;5116.846494605168;5154.226865970097;5160.793568257265;5164.1995490699;3831.1954489557224;3841.980790096032;3844.730868839182;3854.710896682732;3878.631530004645;5450.591205659552;5457.263269458612;5475.495682763035;5494.148406996962;5496.395396506381;3518.20840310928;3718.535183102112;3736.4768932348948;3754.699624030071;3759.774413535197;3808.6000969898314;3809.904752381213;3811.942820857689;3815.2178803345246;3834.178765086617;4362.302031674917;4362.498312694017;4368.301071828492;4380.51062638698;4390.200017992672;5037.876516559756;5139.331886854685;5182.896342073137;5199.922001169985;5234.92147617786;1256.4911210959576;1262.9557965471165;1263.4946021591436;1271.8346614939999;1276.7063575377529;846.6063280574563;866.635049796573;867.1155421470065;879.445949052093;881.5592203898051;4297.763623000765;4413.713108647928;4462.286034234507;4463.509014008457;4557.931631025537;5345.839624811262;5392.379876314274;5393.164059570773;5398.568114550826;5404.13557322723;4571.839985600554;4589.839355622537;4590.42619672541;4591.816327346869;4592.46380287177;2655.9589270285414;2780.291025788411;2796.860156992142;2801.341684704093;2808.5085110106056;4887.73117478535;4892.2574230713535;4906.718375955198;4932.630052746058;4957.429895561984;5124.4114324559505;5324.672079950031;5333.599880053991;5351.688836235069;5370.597205209625;4956.628252881048;4996.250562415594;5028.245763135559;5028.245763135632;5048.53592458183;5367;5372.5433338166695;5373.140297552372;5383.434739352311;5411.702356370437;5177.705573606599;5231.372235331784;5263.394709608291;5296.390915044665;5311.380029091164;5025.924611130909;5034.421041580265;5043.9243411348125;5050.292958985671;5053.29253904461;4023.75857448554;4090.5091389033505;4096;4106.897327566835;4117.835286588503;5068.29043933857;5321.414644389191;5405.621606487508;5424.810131645373;5426.9377636497875;5195.220716892496;5210.348706411699;5229.679153737328;5232.26748255237;5239.607029472881;5200.947990520046;5222.451642577475;5230.607704422107;5261.5264626183825;5265.552428043506;4875.829345972874;5159.974200128975;5198.662086964335;5216.66091704038;5224.242484839753;5078.492150784892;5260.921086183786;5270.920936186037;5277.525022747971;5291.3121294231505;5137.588992880485;5156.819511317086;5159.226116082617;5167.870803229949;5177.508136727005 08:18:32 INFO - PROCESS | 30530 | |5;yui.html;672.8519725660353;681.5842336174935;728.9794287996804;746.8020974441774;781.3397678961279;12202.145849790519;12796.104272700915;13329.933350333247;13339.733205335888;13351.933240333808;13124.212547247173;13295.202287862736;13298.335083245824;13300.401481933312;13346.199228046324;811.8782182672617;821.4947807098621;824.0111865761081;824.7731873734741;826.3265438667497;676.6582875647791;818.6520728690313;818.7175424478545;819.7663665855232;821.7863355527576;724.149124778386;834.9081601023883;873.4497266721957;873.9126087391242;874.3617159473588;857.5155037403847;861.0313397427893;861.91811777881;861.9612117454698;863.6113748813059;627.8712863862943;628.8239292997968;631.728356806573;631.8673078653488;631.9210098737658;12428.813567796491;12857.549985750455;12959.352032398436;13004.544840930617;13047.739045219138;12037.844263919142;12807.167534110253;12842.807357889638;13027.674308142277;13095.083344165912;9922.454265015422;10067.395956242648;10191.490425478696;10196.439195844225;10374.221933354953;3098.9535156972665;3105.7825952183357;3187.729043031345;3260.2664400509934;3262;64772.352276477104;65510;66017.66991165062;66889.33110668928;68290.31709682939;10135.847962280572;10299.227557933185;10369.896301036893;10530.262881598215;10660.520276587573;18089.7286540702;18159.546011349823;18275.086245687664;18782.43652690394;18860.339888103852;6405.871882562323;6530.2816690164045;6578;6607.339266073354;6651.600903945779;3459.152507635645;3612.277544491112;3622.3841946869097;3654.543182102237;3671.7980511071614;2716.456708658276;2795.2033670404244;2823.5623478360885;2827.8020538562105;2847.1031625038045;477.5964310157911;479.90401919616215;484.5227450960801;486.78824711250013;487.665948825056;568.1307599372883;582.0785260621435;586.4399498478942;590.5511811023567;611.6330201878837;7483;7937.722179723797;8171.673133074611;8173.305269052078;8216.137305582828;604.1481511069459;619.2537991720056;624.7282432142033;627.1971875998729;632.5319263744796;3822.5665375484195;3936.2717897189114;4019.9598004019585;4027.8993025174605;4084.4690190275073;53784.73107634437;63524;68060.6596967012;69689;70564;58841.411585883594;60968.695156524824;61301.38698613046;61572;64253.357466424735;54618.180727289124;54674.72662636662;54762;55128.4550894612;55743;7380.77857664271;7664.616769161631;7711.575863327571;7940.6029698515995;7942.523448593103;37966.24067518579;38252;38298.80850595729;38503.03742406462;39443.80278098706;45158.77420612876;47708.284375735086;47760.761196193795;47984.28023579579;48904.26643600278;8844.406728897371;8928.464292142493;9038.096190381173;9101.135392137736;9207.033261507446;10809.837852432063;10886.074683651977;10912.454377281263;11636.650900473;11648.126390520914;10439.425831579032;10544.841827372442;10710.357378557312;11087.611933582608;11200.663980080612;10174.593016279561;10234.6417875374;10288.639897603547;10418.270721049454;10559.63041293551;9867.802643946938;9895.65365212214;11435.828462573234;11464.25482343645;11465.615610378378;9318.72043838686;9625.663101791404;9893.307468477138;10038.297319187586;10459;8634.179752923463;9561.995990421185;9601.087896649808;9639.132478077006;9649.758756030875 08:18:32 INFO - PROCESS | 30530 | __end_tp_report 08:18:32 INFO - PROCESS | 30530 | __start_cc_report 08:18:32 INFO - PROCESS | 30530 | _x_x_mozilla_cycle_collect,331 08:18:32 INFO - PROCESS | 30530 | __end_cc_report 08:18:32 INFO - PROCESS | 30530 | __startTimestamp1483028312101__endTimestamp 08:18:32 INFO - PROCESS | 30530 | 08:18:32 INFO - PROCESS | 30530 | ------- Summary: start ------- 08:18:32 INFO - PROCESS | 30530 | Number of tests: 6 08:18:32 INFO - PROCESS | 30530 | 08:18:32 INFO - PROCESS | 30530 | [#0] dojo.html Cycles:165 Average:4772.59 Median:4923.88 stddev:515.09 (10.5%) stddev-sans-first:488.65 08:18:32 INFO - PROCESS | 30530 | Values: 2636.2 2649.2 2649.6 2676.5 2677.3 4733.8 4801.1 4813.0 4825.9 4834.8 4772.6 4854.7 4907.3 4910.9 4981.0 4399.8 4455.0 4477.6 4532.7 4559.9 4051.9 4515.2 4530.0 4547.7 4560.2 4311.3 4450.7 4471.3 4482.9 4563.8 4360.7 4419.5 4444.4 4458.7 4533.3 4414.0 4428.0 4428.2 4438.3 4444.7 4829.2 4831.5 4868.8 4871.1 4880.8 4967.8 5014.7 5151.3 5200.2 5202.0 5261.5 5270.5 5273.6 5276.9 5315.3 4934.0 4945.7 4950.3 4950.7 4988.3 5176.2 5191.8 5198.5 5273.8 5385.8 5004.5 5041.2 5063.7 5064.0 5064.2 5124.0 5132.4 5133.3 5137.1 5144.6 5087.0 5117.8 5151.6 5157.5 5284.2 5200.5 5216.0 5222.2 5223.9 5224.3 4393.9 4394.0 4396.2 4405.0 4442.9 3693.5 3720.7 3752.9 3755.1 3773.7 4444.5 4455.5 4469.8 4479.0 4506.0 5206.5 5215.3 5217.3 5226.3 5263.0 4336.3 4365.7 4367.7 4411.0 4465.2 4559.8 4570.5 4571.6 4580.4 4583.8 4815.5 4823.6 4836.4 4843.1 4848.5 5124.2 5138.8 5149.1 5149.8 5153.6 4824.3 4827.4 4829.4 4829.7 4839.9 5024.3 5039.3 5057.8 5118.1 5119.0 5239.1 5241.3 5243.4 5256.1 5287.2 5076.3 5086.6 5093.3 5098.0 5143.8 4924.9 4937.0 4983.4 5052.0 5066.9 4884.9 4941.1 4948.3 4954.7 4963.9 4986.9 5023.7 5041.5 5048.6 5069.6 4786.7 4837.5 4923.9 4931.0 4983.0 08:18:32 INFO - PROCESS | 30530 | 08:18:32 INFO - PROCESS | 30530 | [#1] ext.html Cycles:180 Average:44383.75 Median:199515.00 stddev:79049.56 (39.6%) stddev-sans-first:79202.62 08:18:32 INFO - PROCESS | 30530 | Values: 490.8 502.6 510.4 512.1 514.8 36183.0 39150.2 39153.2 43477.8 44020.6 40102.0 40451.6 40811.0 40878.0 41059.4 7562.1 7831.3 7858.3 9410.4 9739.2 9390.8 9646.9 9650.6 9662.8 9667.1 9675.5 9675.8 9677.2 9693.3 9694.3 9584.6 9625.1 9647.1 9653.1 9688.3 9528.8 9593.1 9605.2 9606.9 9609.5 34305.7 34333.7 34465.7 34616.3 34650.7 3630.5 3685.5 3709.1 3746.9 3775.6 25652.0 25686.9 25710.5 25880.5 27034.7 3363.7 3365.1 3378.5 3415.2 3418.4 225814.0 226556.0 227253.0 227930.9 228468.0 46624.8 46690.0 46733.5 46804.8 47019.5 48869.0 48945.5 49273.8 49365.3 49399.0 12869.1 13132.1 13203.3 13231.9 13287.2 9940.4 10228.9 10242.5 10360.2 10395.9 16093.8 16099.8 16184.8 16231.8 16300.2 6353.7 6446.9 6454.7 6585.8 6633.5 737.8 754.8 762.5 767.4 781.0 26849.5 27870.6 27990.5 27992.3 28109.6 843.8 907.8 911.2 912.5 912.6 14082.9 14933.7 15082.6 15269.9 15282.2 362847.0 365833.0 366785.0 367677.0 367977.0 49758.5 50315.5 50465.2 50628.5 50732.2 1137.5 1172.4 1184.4 1187.9 1189.5 26196.3 26934.2 26965.6 27576.4 27636.3 41840.6 42458.6 42591.6 42598.8 42632.8 291354.0 291896.0 292844.0 293048.0 294162.0 22167.7 22877.0 22946.2 23597.9 24048.9 36091.0 36491.3 37273.8 37295.0 37618.6 31562.0 32031.5 32169.8 32442.5 32499.8 31011.5 31485.4 31564.0 31576.0 32475.5 31047.5 31310.8 31474.8 31587.4 34564.8 26516.7 27204.9 29520.7 29717.4 30205.2 23348.4 23587.6 23731.0 23971.0 24037.6 08:18:32 INFO - PROCESS | 30530 | 08:18:32 INFO - PROCESS | 30530 | [#2] jquery.html Cycles:180 Average:22945.36 Median:5259.19 stddev:59751.42 (1136.1%) stddev-sans-first:59894.97 08:18:32 INFO - PROCESS | 30530 | Values: 358.6 375.1 376.3 378.8 401.1 15593.6 16644.3 16670.9 16764.2 16794.9 15785.1 15913.1 16194.4 16253.3 16329.5 4959.0 5152.6 5187.2 5189.0 5194.6 5068.2 5151.5 5445.2 5466.5 5542.7 5488.9 5498.5 5503.6 5512.1 5519.8 5352.8 5472.6 5485.5 5525.8 5537.4 5323.8 5346.9 5347.5 5356.7 5362.9 12336.6 17680.9 18196.8 18950.3 19177.3 2098.8 2147.9 2161.8 2180.0 2214.7 8813.5 9103.3 9371.0 9381.6 9687.2 1647.4 1681.9 1686.0 1713.1 1718.9 57851.8 63948.7 64835.0 65702.7 66481.3 9727.1 9876.3 9893.0 10076.2 10531.3 13431.2 13551.6 13569.7 13570.1 13580.4 6822.6 7040.4 7057.0 7260.5 7267.1 6646.2 6680.6 6822.6 6837.3 6931.2 4222.6 4271.4 4296.8 4357.4 4406.4 1685.1 1738.1 1747.6 1792.6 1864.2 909.2 923.2 930.6 930.6 943.6 15606.0 15756.8 15768.8 16353.7 16565.9 924.6 928.4 933.7 934.1 934.2 9131.1 9159.9 9265.5 9394.0 9433.9 356501.0 359304.0 360226.0 364173.0 367102.0 73570.6 74201.6 74226.0 75049.2 77472.6 900.7 928.3 945.8 947.8 951.9 15134.2 15268.4 15331.4 15331.9 15933.7 36856.6 37085.6 37275.8 37768.8 37842.0 47910.8 48066.3 48166.0 48439.0 50894.0 6702.0 7037.3 7060.0 7184.6 7735.4 11169.9 11833.9 11893.2 11988.2 12150.1 9216.4 9266.3 9836.8 10117.9 10199.2 9647.9 9899.1 10268.0 10309.8 10501.7 9058.5 9215.6 9522.3 9548.5 9602.2 6794.9 6984.8 6993.3 7349.0 7695.6 4921.5 5099.6 7882.6 9321.0 9477.3 08:18:32 INFO - PROCESS | 30530 | 08:18:32 INFO - PROCESS | 30530 | [#3] mootools.html Cycles:180 Average:4747.79 Median:5487.48 stddev:2598.02 (47.3%) stddev-sans-first:2592.51 08:18:32 INFO - PROCESS | 30530 | Values: 1316.3 1336.7 1344.7 1347.5 1350.1 6465.2 6720.8 6949.7 7442.7 7487.1 7029.9 7265.6 7288.3 7374.6 7388.1 2069.6 2119.2 2119.4 2119.8 2120.9 2104.5 2119.2 2142.0 2159.9 2192.0 2125.9 2132.7 2134.5 2153.4 2157.9 2045.2 2058.8 2078.9 2079.8 2083.9 2050.7 2058.3 2093.2 2095.2 2108.5 7393.4 7475.9 7585.7 7592.2 7606.7 4525.4 4665.9 4667.2 4688.1 4694.5 2664.7 2884.1 2900.8 2942.1 2962.9 989.0 998.5 1024.9 1059.9 1111.0 9719.1 9802.8 9854.6 9858.9 9889.7 3744.4 3904.9 3944.1 3966.4 3996.0 7862.9 7906.1 7922.9 7932.4 7935.0 4452.8 4492.2 4496.4 4497.0 4500.2 3985.7 3991.2 4051.6 4066.8 4070.1 3139.7 3196.7 3212.4 3307.4 3339.5 893.6 922.5 961.5 967.9 970.9 643.4 660.7 665.1 667.2 671.3 4610.2 4647.4 4746.8 4758.4 5022.1 813.4 816.8 817.2 818.6 820.0 3251.5 3307.6 3335.8 3339.7 3360.6 8581.9 8758.0 8814.0 8875.9 8883.4 8757.4 8763.7 8800.7 8829.6 8853.1 6341.3 6603.3 6613.2 6734.6 6756.1 4689.9 4778.1 4797.0 4867.9 5055.4 7870.9 7971.2 8048.2 8077.2 8078.9 8030.3 8044.3 8177.4 8179.6 8192.0 6181.2 6322.4 6363.0 6364.4 6376.3 6748.9 6811.6 6811.7 6814.4 6844.3 6282.6 6340.8 6374.6 6387.1 6491.5 5993.8 6049.5 6062.1 6062.4 6207.3 5401.7 5483.4 5485.9 5489.1 5499.9 4146.8 4250.9 4314.2 4315.6 4329.3 4221.7 4246.6 4285.4 4290.3 4333.2 08:18:32 INFO - PROCESS | 30530 | 08:18:32 INFO - PROCESS | 30530 | [#4] prototype.html Cycles:180 Average:4329.32 Median:4923.50 stddev:1249.26 (25.4%) stddev-sans-first:1216.66 08:18:32 INFO - PROCESS | 30530 | Values: 356.7 360.5 362.8 365.0 370.5 4986.3 5007.9 5013.7 5026.6 5027.8 4876.5 4923.4 4923.6 4953.4 4986.2 3708.8 3711.7 3903.7 3925.2 3943.6 3913.1 3913.4 3928.3 3932.9 3949.2 3916.0 3935.3 3935.8 3948.8 3956.2 3847.8 3907.9 3934.9 3942.3 3954.2 3509.9 3518.0 3523.6 3526.0 3544.7 4753.6 4765.9 4778.6 4781.2 4809.3 4426.2 4446.3 4495.0 4500.0 4544.5 5116.7 5116.8 5154.2 5160.8 5164.2 3831.2 3842.0 3844.7 3854.7 3878.6 5450.6 5457.3 5475.5 5494.1 5496.4 3518.2 3718.5 3736.5 3754.7 3759.8 3808.6 3809.9 3811.9 3815.2 3834.2 4362.3 4362.5 4368.3 4380.5 4390.2 5037.9 5139.3 5182.9 5199.9 5234.9 1256.5 1263.0 1263.5 1271.8 1276.7 846.6 866.6 867.1 879.4 881.6 4297.8 4413.7 4462.3 4463.5 4557.9 5345.8 5392.4 5393.2 5398.6 5404.1 4571.8 4589.8 4590.4 4591.8 4592.5 2656.0 2780.3 2796.9 2801.3 2808.5 4887.7 4892.3 4906.7 4932.6 4957.4 5124.4 5324.7 5333.6 5351.7 5370.6 4956.6 4996.3 5028.2 5028.2 5048.5 5367.0 5372.5 5373.1 5383.4 5411.7 5177.7 5231.4 5263.4 5296.4 5311.4 5025.9 5034.4 5043.9 5050.3 5053.3 4023.8 4090.5 4096.0 4106.9 4117.8 5068.3 5321.4 5405.6 5424.8 5426.9 5195.2 5210.3 5229.7 5232.3 5239.6 5200.9 5222.5 5230.6 5261.5 5265.6 4875.8 5160.0 5198.7 5216.7 5224.2 5078.5 5260.9 5270.9 5277.5 5291.3 5137.6 5156.8 5159.2 5167.9 5177.5 08:18:32 INFO - PROCESS | 30530 | 08:18:32 INFO - PROCESS | 30530 | [#5] yui.html Cycles:180 Average:14953.24 Median:54646.45 stddev:19302.59 (35.3%) stddev-sans-first:19326.95 08:18:32 INFO - PROCESS | 30530 | Values: 672.9 681.6 729.0 746.8 781.3 12202.1 12796.1 13329.9 13339.7 13351.9 13124.2 13295.2 13298.3 13300.4 13346.2 811.9 821.5 824.0 824.8 826.3 676.7 818.7 818.7 819.8 821.8 724.1 834.9 873.4 873.9 874.4 857.5 861.0 861.9 862.0 863.6 627.9 628.8 631.7 631.9 631.9 12428.8 12857.5 12959.4 13004.5 13047.7 12037.8 12807.2 12842.8 13027.7 13095.1 9922.5 10067.4 10191.5 10196.4 10374.2 3099.0 3105.8 3187.7 3260.3 3262.0 64772.4 65510.0 66017.7 66889.3 68290.3 10135.8 10299.2 10369.9 10530.3 10660.5 18089.7 18159.5 18275.1 18782.4 18860.3 6405.9 6530.3 6578.0 6607.3 6651.6 3459.2 3612.3 3622.4 3654.5 3671.8 2716.5 2795.2 2823.6 2827.8 2847.1 477.6 479.9 484.5 486.8 487.7 568.1 582.1 586.4 590.6 611.6 7483.0 7937.7 8171.7 8173.3 8216.1 604.1 619.3 624.7 627.2 632.5 3822.6 3936.3 4020.0 4027.9 4084.5 53784.7 63524.0 68060.7 69689.0 70564.0 58841.4 60968.7 61301.4 61572.0 64253.4 54618.2 54674.7 54762.0 55128.5 55743.0 7380.8 7664.6 7711.6 7940.6 7942.5 37966.2 38252.0 38298.8 38503.0 39443.8 45158.8 47708.3 47760.8 47984.3 48904.3 8844.4 8928.5 9038.1 9101.1 9207.0 10809.8 10886.1 10912.5 11636.7 11648.1 10439.4 10544.8 10710.4 11087.6 11200.7 10174.6 10234.6 10288.6 10418.3 10559.6 9867.8 9895.7 11435.8 11464.3 11465.6 9318.7 9625.7 9893.3 10038.3 10459.0 8634.2 9562.0 9601.1 9639.1 9649.8 08:18:32 INFO - PROCESS | 30530 | -------- Summary: end -------- 08:18:32 INFO - PROCESS | 30530 | 08:18:32 INFO - TEST-INFO | 30530: exit 0 08:18:32 INFO - TEST-OK | dromaeo_css | took 1119602ms 08:18:32 INFO - TEST-START | kraken 08:18:32 INFO - operating with platform_type : linux_ 08:18:32 INFO - Initialising browser for kraken test... 08:18:32 INFO - TEST-INFO | started process 30883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa0Gu4f/profile http://localhost:38275/getInfo.html) 08:18:33 INFO - PROCESS | 30883 | 1483028313481 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 08:18:37 INFO - PROCESS | 30883 | __metrics Screen width/height:1600/1200 08:18:37 INFO - PROCESS | 30883 | colorDepth:24 08:18:37 INFO - PROCESS | 30883 | Browser inner width/height: 1024/697 08:18:37 INFO - PROCESS | 30883 | __metrics 08:18:37 ERROR - PROCESS | 30883 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 08:18:38 INFO - TEST-INFO | 30883: exit 0 08:18:38 INFO - Browser initialized. 08:18:38 INFO - Running cycle 1/1 for kraken test... 08:18:38 INFO - TEST-INFO | started process 31007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa0Gu4f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:18:50 INFO - PROCESS | 31007 | RSS: Main: 158363648 08:18:50 INFO - PROCESS | 31007 | 08:18:53 INFO - PROCESS | 31007 | Cycle 1(1): loaded http://localhost:38275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38275/tests/kraken/driver.html?testName=audio-beat-detection) 08:18:54 INFO - PROCESS | 31007 | RSS: Main: 164786176 08:18:54 INFO - PROCESS | 31007 | 08:18:57 INFO - PROCESS | 31007 | Cycle 1(1): loaded http://localhost:38275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38275/tests/kraken/driver.html?testName=audio-dft) 08:18:58 INFO - PROCESS | 31007 | RSS: Main: 163311616 08:18:58 INFO - PROCESS | 31007 | 08:19:01 INFO - PROCESS | 31007 | Cycle 1(1): loaded http://localhost:38275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38275/tests/kraken/driver.html?testName=audio-fft) 08:19:01 INFO - PROCESS | 31007 | RSS: Main: 159891456 08:19:01 INFO - PROCESS | 31007 | 08:19:03 INFO - PROCESS | 31007 | Cycle 1(1): loaded http://localhost:38275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38275/tests/kraken/driver.html?testName=audio-oscillator) 08:19:04 INFO - PROCESS | 31007 | RSS: Main: 160227328 08:19:04 INFO - PROCESS | 31007 | 08:19:06 INFO - PROCESS | 31007 | Cycle 1(1): loaded http://localhost:38275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:19:07 INFO - PROCESS | 31007 | RSS: Main: 160489472 08:19:07 INFO - PROCESS | 31007 | 08:19:10 INFO - PROCESS | 31007 | Cycle 1(1): loaded http://localhost:38275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38275/tests/kraken/driver.html?testName=imaging-darkroom) 08:19:11 INFO - PROCESS | 31007 | RSS: Main: 164524032 08:19:11 INFO - PROCESS | 31007 | 08:19:14 INFO - PROCESS | 31007 | Cycle 1(1): loaded http://localhost:38275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38275/tests/kraken/driver.html?testName=imaging-desaturate) 08:19:15 INFO - PROCESS | 31007 | RSS: Main: 162185216 08:19:15 INFO - PROCESS | 31007 | 08:19:18 INFO - PROCESS | 31007 | Cycle 1(1): loaded http://localhost:38275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38275/tests/kraken/driver.html?testName=json-parse-financial) 08:19:18 INFO - PROCESS | 31007 | RSS: Main: 162852864 08:19:18 INFO - PROCESS | 31007 | 08:19:20 INFO - PROCESS | 31007 | Cycle 1(1): loaded http://localhost:38275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:19:21 INFO - PROCESS | 31007 | RSS: Main: 163340288 08:19:21 INFO - PROCESS | 31007 | 08:19:23 INFO - PROCESS | 31007 | Cycle 1(1): loaded http://localhost:38275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38275/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:19:23 INFO - PROCESS | 31007 | RSS: Main: 163377152 08:19:23 INFO - PROCESS | 31007 | 08:19:25 INFO - PROCESS | 31007 | Cycle 1(1): loaded http://localhost:38275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:19:26 INFO - PROCESS | 31007 | RSS: Main: 163590144 08:19:26 INFO - PROCESS | 31007 | 08:19:29 INFO - PROCESS | 31007 | Cycle 1(1): loaded http://localhost:38275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:19:30 INFO - PROCESS | 31007 | RSS: Main: 163598336 08:19:30 INFO - PROCESS | 31007 | 08:19:33 INFO - PROCESS | 31007 | Cycle 1(1): loaded http://localhost:38275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:19:33 INFO - PROCESS | 31007 | RSS: Main: 163463168 08:19:33 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | Cycle 1(1): loaded http://localhost:38275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38275/tests/kraken/driver.html?testName=ai-astar) 08:19:35 INFO - PROCESS | 31007 | RSS: Main: 165076992 08:19:35 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | __start_tp_report 08:19:35 INFO - PROCESS | 31007 | _x_x_mozilla_page_load 08:19:35 INFO - PROCESS | 31007 | _x_x_mozilla_page_load_details 08:19:35 INFO - PROCESS | 31007 | |i|pagename|runs| 08:19:35 INFO - PROCESS | 31007 | |0;ai-astar;108;118;115;116;115;114;116;116;116;115 08:19:35 INFO - PROCESS | 31007 | |1;audio-beat-detection;157;129;127;186;139;127;128;127;152;130 08:19:35 INFO - PROCESS | 31007 | |2;audio-dft;165;165;168;171;163;164;162;164;162;163 08:19:35 INFO - PROCESS | 31007 | |3;audio-fft;76;78;78;108;79;77;77;76;92;77 08:19:35 INFO - PROCESS | 31007 | |4;audio-oscillator;85;85;113;86;84;85;97;86;85;107 08:19:35 INFO - PROCESS | 31007 | |5;imaging-gaussian-blur;118;118;118;119;118;122;118;118;120;119 08:19:35 INFO - PROCESS | 31007 | |6;imaging-darkroom;152;152;150;151;150;151;150;151;150;151 08:19:35 INFO - PROCESS | 31007 | |7;imaging-desaturate;95;96;96;96;95;96;95;97;96;95 08:19:35 INFO - PROCESS | 31007 | |8;json-parse-financial;70;69;72;72;81;72;72;71;71;72 08:19:35 INFO - PROCESS | 31007 | |9;json-stringify-tinderbox;68;67;68;67;68;67;67;68;67;67 08:19:35 INFO - PROCESS | 31007 | |10;stanford-crypto-aes;86;86;84;85;85;91;86;85;85;86 08:19:35 INFO - PROCESS | 31007 | |11;stanford-crypto-ccm;136;149;133;135;144;137;147;145;190;145 08:19:35 INFO - PROCESS | 31007 | |12;stanford-crypto-pbkdf2;176;182;182;185;181;175;180;182;179;186 08:19:35 INFO - PROCESS | 31007 | |13;stanford-crypto-sha256-iterative;70;72;70;70;72;69;68;70;69;71 08:19:35 INFO - PROCESS | 31007 | __end_tp_report 08:19:35 INFO - PROCESS | 31007 | __start_cc_report 08:19:35 INFO - PROCESS | 31007 | _x_x_mozilla_cycle_collect,806 08:19:35 INFO - PROCESS | 31007 | __end_cc_report 08:19:35 INFO - PROCESS | 31007 | __startTimestamp1483028375858__endTimestamp 08:19:35 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | ------- Summary: start ------- 08:19:35 INFO - PROCESS | 31007 | Number of tests: 14 08:19:35 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | [#0] ai-astar Cycles:10 Average:114.90 Median:116.00 stddev:2.64 (2.3%) stddev-sans-first:1.12 08:19:35 INFO - PROCESS | 31007 | Values: 108.0 118.0 115.0 116.0 115.0 114.0 116.0 116.0 116.0 115.0 08:19:35 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:134.50 stddev:19.50 (14.5%) stddev-sans-first:19.71 08:19:35 INFO - PROCESS | 31007 | Values: 157.0 129.0 127.0 186.0 139.0 127.0 128.0 127.0 152.0 130.0 08:19:35 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:2.83 (1.7%) stddev-sans-first:3.00 08:19:35 INFO - PROCESS | 31007 | Values: 165.0 165.0 168.0 171.0 163.0 164.0 162.0 164.0 162.0 163.0 08:19:35 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.50 stddev:10.35 (13.4%) stddev-sans-first:10.76 08:19:35 INFO - PROCESS | 31007 | Values: 76.0 78.0 78.0 108.0 79.0 77.0 77.0 76.0 92.0 77.0 08:19:35 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:85.00 stddev:10.64 (12.5%) stddev-sans-first:11.03 08:19:35 INFO - PROCESS | 31007 | Values: 85.0 85.0 113.0 86.0 84.0 85.0 97.0 86.0 85.0 107.0 08:19:35 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | [#5] imaging-gaussian-blur Cycles:10 Average:118.80 Median:118.50 stddev:1.32 (1.1%) stddev-sans-first:1.36 08:19:35 INFO - PROCESS | 31007 | Values: 118.0 118.0 118.0 119.0 118.0 122.0 118.0 118.0 120.0 119.0 08:19:35 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 08:19:35 INFO - PROCESS | 31007 | Values: 152.0 152.0 150.0 151.0 150.0 151.0 150.0 151.0 150.0 151.0 08:19:35 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 08:19:35 INFO - PROCESS | 31007 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 95.0 97.0 96.0 95.0 08:19:35 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | [#8] json-parse-financial Cycles:10 Average:72.20 Median:72.00 stddev:3.26 (4.5%) stddev-sans-first:3.36 08:19:35 INFO - PROCESS | 31007 | Values: 70.0 69.0 72.0 72.0 81.0 72.0 72.0 71.0 71.0 72.0 08:19:35 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 08:19:35 INFO - PROCESS | 31007 | Values: 68.0 67.0 68.0 67.0 68.0 67.0 67.0 68.0 67.0 67.0 08:19:35 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:1.91 (2.2%) stddev-sans-first:2.03 08:19:35 INFO - PROCESS | 31007 | Values: 86.0 86.0 84.0 85.0 85.0 91.0 86.0 85.0 85.0 86.0 08:19:35 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | [#11] stanford-crypto-ccm Cycles:10 Average:146.10 Median:145.00 stddev:16.41 (11.3%) stddev-sans-first:16.99 08:19:35 INFO - PROCESS | 31007 | Values: 136.0 149.0 133.0 135.0 144.0 137.0 147.0 145.0 190.0 145.0 08:19:35 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:182.00 stddev:3.49 (1.9%) stddev-sans-first:3.24 08:19:35 INFO - PROCESS | 31007 | Values: 176.0 182.0 182.0 185.0 181.0 175.0 180.0 182.0 179.0 186.0 08:19:35 INFO - PROCESS | 31007 | 08:19:35 INFO - PROCESS | 31007 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:1.29 (1.8%) stddev-sans-first:1.36 08:19:35 INFO - PROCESS | 31007 | Values: 70.0 72.0 70.0 70.0 72.0 69.0 68.0 70.0 69.0 71.0 08:19:35 INFO - PROCESS | 31007 | -------- Summary: end -------- 08:19:35 INFO - PROCESS | 31007 | 08:19:36 INFO - TEST-INFO | 31007: exit 0 08:19:37 INFO - TEST-OK | kraken | took 64066ms 08:19:37 INFO - SUITE-END | took 1183s 08:19:37 INFO - Completed test suite (00:19:44) 08:19:37 INFO - javascript benchmark 08:19:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6264.639811636876, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2636.2486691292984, 2649.205238428471, 2649.562822134348, 2676.51822671919, 2677.2905180127264, 4733.763311834403, 4801.135795556794, 4813.013332266885, 4825.855224343267, 4834.782434790434, 4772.57046865782, 4854.7329896855745, 4907.26391041344, 4910.9263361049525, 4981.028699403618, 4399.846005389812, 4454.97772511137, 4477.597016268535, 4532.66005049621, 4559.863204103882, 4051.9392209116886, 4515.164694531506, 4530.0, 4547.704399214041, 4560.247559152735, 4311.310190369557, 4450.710703804275, 4471.3293006049025, 4482.887927801815, 4563.817447302104, 4360.672949528798, 4419.491758447787, 4444.444444444444, 4458.71018383804, 4533.320001999694, 4413.977930110329, 4427.977860110679, 4428.22506061438, 4438.289873620238, 4444.711093778894, 4829.227323628203, 4831.516848315176, 4868.780904859254, 4871.12319782439, 4880.804767809319, 4967.751612419364, 5014.674046186986, 5151.278820965068, 5200.167973124319, 5202.03762303975, 5261.500157485033, 5270.49930256625, 5273.630845840793, 5276.894462110737, 5315.335583052119, 4933.975330123327, 4945.703257804544, 4950.331705219821, 4950.727709975914, 4988.326575912241, 5176.249443830623, 5191.766370513336, 5198.4801519847715, 5273.815416460406, 5385.838424847261, 5004.524570165829, 5041.168207245837, 5063.746812659352, 5063.974680126649, 5064.240363945438, 5123.974380128076, 5132.358455193101, 5133.281340612317, 5137.101007323703, 5144.588432925357, 5087.033463641897, 5117.8464646060675, 5151.562117220078, 5157.510036546522, 5284.233786100994, 5200.453952335026, 5216.035033518811, 5222.2427747976335, 5223.869403264949, 5224.320838290998, 4393.890152746143, 4393.978030109829, 4396.208682437192, 4404.977975110104, 4442.911141777146, 3693.4829123922673, 3720.6651401374006, 3752.9437058444146, 3755.080005398695, 3773.716971227169, 4444.511103778582, 4455.487618923865, 4469.754163520973, 4478.992226749021, 4505.954940450619, 5206.479352064764, 5215.29593504872, 5217.34783152106, 5226.3205783248695, 5262.973685131627, 4336.306191009423, 4365.716228445141, 4367.737935723867, 4411.029573493826, 4465.151621192028, 4559.817607295738, 4570.4743954445, 4571.565701258375, 4580.358749775034, 4583.770811459413, 4815.470298267188, 4823.614110871192, 4836.443808962014, 4843.055604157155, 4848.466668666514, 5124.180131178993, 5138.76875540609, 5149.124648809786, 5149.794008239778, 5153.613478989166, 4824.252240902666, 4827.372441582572, 4829.420469543677, 4829.73436460998, 4839.879003024953, 5024.346834911438, 5039.294498770102, 5057.8229761958155, 5118.078745825638, 5118.97440512795, 5239.135542635422, 5241.344831896013, 5243.449437809128, 5256.05391029603, 5287.154055351125, 5076.289319495348, 5086.61850361217, 5093.337866077386, 5098.0, 5143.819966301162, 4924.8768780780765, 4937.0372777308085, 4983.401991761012, 5051.974740126276, 5066.873328166826, 4884.926726099183, 4941.110600092018, 4948.331975183448, 4954.653174277766, 4963.900721985612, 4986.8753281168265, 5023.723695196799, 5041.521055499722, 5048.621353398436, 5069.6197785167, 4786.664933454625, 4837.516248375135, 4923.876903077452, 4930.950690493192, 4983.0], "value": 4738.642905695832, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.78650786907684, 502.5728131088573, 510.42832028128504, 512.1421618788529, 514.7837908078607, 36183.0, 39150.21699566011, 39153.21693566131, 43477.7826110869, 44020.55979440205, 40102.0, 40451.59548404515, 40811.0, 40878.0, 41059.38410923839, 7562.130355009175, 7831.334336581397, 7858.253465920757, 9410.38832475887, 9739.220862330996, 9390.765230869214, 9646.855297170512, 9650.613975440974, 9662.806743865118, 9667.12995830375, 9675.467849268287, 9675.806483870318, 9677.225821934264, 9693.273004524654, 9694.321397502177, 9584.568694408734, 9625.085616866387, 9647.131758141766, 9653.082957119062, 9688.321817472779, 9528.809423811485, 9593.088656577615, 9605.18355939746, 9606.903930960741, 9609.471479068648, 34305.6569434305, 34333.65666343355, 34465.65534344675, 34616.30767384638, 34650.653493465245, 3630.528031355907, 3685.4656074869263, 3709.1098136447326, 3746.9017350283657, 3775.6224377562025, 25652.0, 25686.87156564224, 25710.48579028409, 25880.482390352277, 27034.729652703616, 3363.697267245935, 3365.074604483762, 3378.45944648855, 3415.1803567143957, 3418.3505134024704, 225814.0, 226556.0, 227253.0, 227930.86034569886, 228468.0, 46624.76687616608, 46690.0, 46733.532664672915, 46804.76597617058, 47019.52980470152, 48869.0, 48945.51054489481, 49273.753631231615, 49365.25952110721, 49399.0, 12869.099163058496, 13132.146410483288, 13203.339833008504, 13231.933840330928, 13287.20276783396, 9940.403575785476, 10228.897711022795, 10242.48787560619, 10360.222983276284, 10395.94802026, 16093.758593621105, 16099.758503622455, 16184.83815161857, 16231.756523652155, 16300.184990750653, 6353.68231588428, 6446.871062578723, 6454.677266136674, 6585.80242592723, 6633.4693224541925, 737.8266107464741, 754.7547047209679, 762.5462849604477, 767.4359345880773, 780.9609519524115, 26849.463010739677, 27870.5819412709, 27990.510675490073, 27992.300192494942, 28109.578356324673, 843.8312337532518, 907.7957459571676, 911.1844898815523, 912.5209265135724, 912.5847739278745, 14082.859171408154, 14933.70132597342, 15082.622934426727, 15269.9236503819, 15282.159481228417, 362847.0, 365833.0, 366785.0, 367677.0, 367977.0, 49758.50241497611, 50315.496845031084, 50465.24302135471, 50628.49371506238, 50732.23901641478, 1137.4995002199005, 1172.372780562395, 1184.3782014442486, 1187.8574571051702, 1189.4885199364358, 26196.345091372867, 26934.191974240803, 26965.595516067668, 27576.448471030868, 27636.309092272855, 41840.58159418367, 42458.57541424546, 42591.57408426, 42598.78700606477, 42632.78683606562, 291354.0, 291896.0, 292844.0, 293048.0, 294162.0, 22167.667484987414, 22877.0, 22946.246450426057, 23597.882010589838, 24048.87975560181, 36091.0, 36491.27017459689, 37273.81363093167, 37295.0, 37618.623813761515, 31562.0, 32031.519527207576, 32169.839150804095, 32442.513362299112, 32499.837500812344, 31011.534826977164, 31485.370292594478, 31564.0, 31576.0, 32475.512867307483, 31047.53428698526, 31310.843445782626, 31474.842625786725, 31587.36825263528, 34564.82717586396, 26516.734832652197, 27204.863975679997, 29520.704792951794, 29717.40565188641, 30205.244868877573, 23348.416289592897, 23587.64618530689, 23731.0, 23971.0, 24037.639435408833], "value": 16998.796494046346, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.6449415079073, 375.07543904275957, 376.25877022266127, 378.80870160568907, 401.09753055624844, 15593.610159745998, 16644.251008704607, 16670.91664541677, 16764.245608947596, 16794.916025419887, 15785.13181775002, 15913.124778137199, 16194.352225910949, 16253.349866005376, 16329.510114696579, 4958.999999999991, 5152.583039664085, 5187.170052791555, 5189.0, 5194.610404219679, 5068.163752980772, 5151.510606492396, 5445.237666726662, 5466.508014278714, 5542.695151766651, 5488.945110548903, 5498.45015498451, 5503.587230957674, 5512.090505066659, 5519.751611177487, 5352.785888564472, 5472.589555783293, 5485.506304432601, 5525.806596769134, 5537.390887002426, 5323.760430780624, 5346.91979620306, 5347.491988261109, 5356.6518176318805, 5362.892742145135, 12336.629901102891, 17680.939143651292, 18196.818031819777, 18950.336738214097, 19177.32879349216, 2098.790120987904, 2147.914083436661, 2161.7730138335564, 2179.9564008719735, 2214.660130620983, 8813.471191728453, 9103.271738260923, 9370.953145234298, 9381.577828997712, 9687.17658998986, 1647.365764180787, 1681.9092803397655, 1685.983140168595, 1713.1091832247287, 1718.9398371056952, 57851.79845385136, 63948.680256598884, 64835.0, 65702.67148664226, 66481.33518664849, 9727.124558789743, 9876.308658393844, 9892.950535247277, 10076.244281678903, 10531.315464494937, 13431.19412835233, 13551.577084406192, 13569.728605427836, 13570.117942333716, 13580.38888250031, 6822.624755638488, 7040.401565866856, 7056.964715176494, 7260.491765576465, 7267.1279446465705, 6646.163004117191, 6680.565763225375, 6822.624755638389, 6837.316268373223, 6931.202911665122, 4222.619964203236, 4271.423357846713, 4296.763677997677, 4357.3899654048455, 4406.427164468599, 1685.1153144599184, 1738.1309345327336, 1747.632997070604, 1792.5608225984718, 1864.2077117225126, 909.1635695160468, 923.2475532441039, 930.55798495714, 930.6277489004452, 943.613118621362, 15606.0, 15756.842431575767, 15768.842311576967, 16353.672926541403, 16565.91717041407, 924.5700749151677, 928.4243768863348, 933.6638810028385, 934.0892629686002, 934.238595544629, 9131.13254240846, 9159.90840091604, 9265.517517197217, 9394.0, 9433.90566094344, 356501.0, 359304.0, 360226.0, 364173.0, 367102.0, 73570.63214684, 74201.6289918547, 74226.0, 75049.24950750422, 77472.61263693645, 900.7252787899754, 928.2852203803169, 945.8108378324363, 947.7630592351912, 951.9428834269827, 15134.243287835785, 15268.3892644293, 15331.390204028863, 15331.923340383673, 15933.68132637364, 36856.631433686394, 37085.62914370822, 37275.81362093172, 37768.811155944044, 37842.0, 47910.76044619754, 48066.27900581424, 48166.0, 48439.0, 50894.0, 6701.966490167518, 7037.331453511908, 7060.0, 7184.6048467334795, 7735.4198435118715, 11169.944150279196, 11833.881661183623, 11893.167478276437, 11988.220765650205, 12150.149489536001, 9216.447013179231, 9266.258699304175, 9836.754081148028, 10117.898821011695, 10199.235057370579, 9647.9035209647, 9899.109080182818, 10268.0, 10309.845352319871, 10501.684949451223, 9058.456492610465, 9215.585298661443, 9522.333436659368, 9548.474833884204, 9602.183814375856, 6794.8641027180165, 6984.755533556505, 6993.335633114846, 7348.96325518369, 7695.615219239127, 4921.4832442593015, 5099.56653684441, 7882.566458844819, 9320.983953799863, 9477.336586439158], "value": 7988.261642839008, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.2694704439036, 1336.7126067895406, 1344.6503908983664, 1347.528365072225, 1350.1021820489375, 6465.159529261189, 6720.764773232938, 6949.687264073116, 7442.665080071396, 7487.101547814256, 7029.89455158173, 7265.600391978439, 7288.271172882709, 7374.63126843657, 7388.076490438695, 2069.5860827834454, 2119.205298013245, 2119.4383488375515, 2119.7562280337806, 2120.9151633934625, 2104.4738815296178, 2119.2370746531237, 2141.9892900535474, 2159.9352019439443, 2191.991683825442, 2125.936221913345, 2132.744070711517, 2134.4770531219874, 2153.364757396572, 2157.870527768339, 2045.2125931516325, 2058.83529317655, 2078.8856612886284, 2079.7712251652306, 2083.8853863037525, 2050.7026481160146, 2058.3207541511265, 2093.152273329304, 2095.1514636572215, 2108.5466624675614, 7393.408527317802, 7475.9252407476315, 7585.696572137108, 7592.240775922363, 7606.657700403495, 4525.389072475206, 4665.86002419928, 4667.206574882244, 4688.109259240768, 4694.530546945312, 2664.706882242952, 2884.120343295294, 2900.8404537750416, 2942.1173647905543, 2962.896298629538, 989.0455710239581, 998.5107297424282, 1024.9231307651955, 1059.8569193158903, 1111.0445017285128, 9719.125278724878, 9802.754931126708, 9854.556544955494, 9858.90141098587, 9889.653862114792, 3744.382176940774, 3904.941425878614, 3944.053427177457, 3966.4050392440786, 3996.040950171996, 7862.921370786219, 7906.130325664172, 7922.920770792333, 7932.365410767125, 7935.008123984502, 4452.821887124479, 4492.168948744493, 4496.392986946786, 4496.977515112469, 4500.189965806121, 3985.661218796377, 3991.201759648024, 4051.554329023805, 4066.8373265069067, 4070.104576993116, 3139.654637989819, 3196.712295893334, 3212.421764082441, 3307.4377355849565, 3339.482380231068, 893.6112790935964, 922.460360688991, 961.5192403798101, 967.8693376394237, 970.9271804614682, 643.3598569423453, 660.745612939022, 665.065582856088, 667.1560475997867, 671.3051991189096, 4610.239310513794, 4647.372604698322, 4746.762661866962, 4758.405199350082, 5022.146235140035, 813.3940214540205, 816.7835523586255, 817.1787353709602, 818.5743413424985, 819.9590020498952, 3251.4797632378704, 3307.6196237433005, 3335.849886755102, 3339.699427051577, 3360.5967283925597, 8581.871271930926, 8758.0, 8814.0, 8875.866861997076, 8883.37816352862, 8757.386982911135, 8763.69327073562, 8800.735977920545, 8829.60266787996, 8853.070427605138, 6341.270753863365, 6603.339666033358, 6613.173353330833, 6734.56225345351, 6756.054152418666, 4689.882752931204, 4778.092162489116, 4796.95203047979, 4867.878303042452, 5055.418626857959, 7870.881936771068, 7971.1630278819885, 8048.154943731058, 8077.15189905075, 8078.878816817635, 8030.277275045274, 8044.31623312025, 8177.386695997943, 8179.591020448835, 8192.0, 6181.196444462191, 6322.367763223825, 6363.0, 6364.427201551883, 6376.298607153302, 6748.932510675027, 6811.557248779011, 6811.69347379379, 6814.386705196358, 6844.315568443116, 6282.560220784684, 6340.841478963062, 6374.58565193261, 6387.105805187371, 6491.545591808528, 5993.790217342372, 6049.455549000435, 6062.090686397076, 6062.42406971337, 6207.317195108444, 5401.729913504388, 5483.424240454695, 5485.862853428696, 5489.094299440707, 5499.9175012375645, 4146.771927544014, 4250.893727656833, 4314.180305741899, 4315.611594956469, 4329.307310830252, 4221.683373747042, 4246.639035682002, 4285.442892423965, 4290.334998075304, 4333.1766964276685], "value": 3845.484676468359, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.68433436408776, 360.482707315003, 362.8312834531942, 365.0381245418322, 370.4924253772334, 4986.326845875806, 5007.871654546812, 5013.699178049315, 5026.648134630577, 5027.773750181242, 4876.463589005207, 4923.384576927884, 4923.60611151108, 4953.430355509117, 4986.202207646777, 3708.7589306695045, 3711.6845068169237, 3903.668188204006, 3925.234579257046, 3943.5662077171633, 3913.139109395943, 3913.3934240192816, 3928.292907276689, 3932.9410058849, 3949.19041596472, 3915.9804200978956, 3935.291647503448, 3935.7638541687447, 3948.7828169450668, 3956.2483128205695, 3847.769133851978, 3907.8632247871187, 3934.9016274593077, 3942.3495123304765, 3954.169624378884, 3509.946681191506, 3518.0, 3523.612402635708, 3525.964740352589, 3544.680978711928, 4753.595944344735, 4765.927666275061, 4778.641601879873, 4781.235002399634, 4809.302651115569, 4426.203283408985, 4446.3108218226225, 4494.9775251123865, 4499.977500112478, 4544.454665440136, 5116.744162791845, 5116.846494605168, 5154.226865970097, 5160.793568257265, 5164.1995490699, 3831.1954489557224, 3841.980790096032, 3844.730868839182, 3854.710896682732, 3878.631530004645, 5450.591205659552, 5457.263269458612, 5475.495682763035, 5494.148406996962, 5496.395396506381, 3518.20840310928, 3718.535183102112, 3736.4768932348948, 3754.699624030071, 3759.774413535197, 3808.6000969898314, 3809.904752381213, 3811.942820857689, 3815.2178803345246, 3834.178765086617, 4362.302031674917, 4362.498312694017, 4368.301071828492, 4380.51062638698, 4390.200017992672, 5037.876516559756, 5139.331886854685, 5182.896342073137, 5199.922001169985, 5234.92147617786, 1256.4911210959576, 1262.9557965471165, 1263.4946021591436, 1271.8346614939999, 1276.7063575377529, 846.6063280574563, 866.635049796573, 867.1155421470065, 879.445949052093, 881.5592203898051, 4297.763623000765, 4413.713108647928, 4462.286034234507, 4463.509014008457, 4557.931631025537, 5345.839624811262, 5392.379876314274, 5393.164059570773, 5398.568114550826, 5404.13557322723, 4571.839985600554, 4589.839355622537, 4590.42619672541, 4591.816327346869, 4592.46380287177, 2655.9589270285414, 2780.291025788411, 2796.860156992142, 2801.341684704093, 2808.5085110106056, 4887.73117478535, 4892.2574230713535, 4906.718375955198, 4932.630052746058, 4957.429895561984, 5124.4114324559505, 5324.672079950031, 5333.599880053991, 5351.688836235069, 5370.597205209625, 4956.628252881048, 4996.250562415594, 5028.245763135559, 5028.245763135632, 5048.53592458183, 5367.0, 5372.5433338166695, 5373.140297552372, 5383.434739352311, 5411.702356370437, 5177.705573606599, 5231.372235331784, 5263.394709608291, 5296.390915044665, 5311.380029091164, 5025.924611130909, 5034.421041580265, 5043.9243411348125, 5050.292958985671, 5053.29253904461, 4023.75857448554, 4090.5091389033505, 4096.0, 4106.897327566835, 4117.835286588503, 5068.29043933857, 5321.414644389191, 5405.621606487508, 5424.810131645373, 5426.9377636497875, 5195.220716892496, 5210.348706411699, 5229.679153737328, 5232.26748255237, 5239.607029472881, 5200.947990520046, 5222.451642577475, 5230.607704422107, 5261.5264626183825, 5265.552428043506, 4875.829345972874, 5159.974200128975, 5198.662086964335, 5216.66091704038, 5224.242484839753, 5078.492150784892, 5260.921086183786, 5270.920936186037, 5277.525022747971, 5291.3121294231505, 5137.588992880485, 5156.819511317086, 5159.226116082617, 5167.870803229949, 5177.508136727005], "value": 3942.401755655354, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.8519725660353, 681.5842336174935, 728.9794287996804, 746.8020974441774, 781.3397678961279, 12202.145849790519, 12796.104272700915, 13329.933350333247, 13339.733205335888, 13351.933240333808, 13124.212547247173, 13295.202287862736, 13298.335083245824, 13300.401481933312, 13346.199228046324, 811.8782182672617, 821.4947807098621, 824.0111865761081, 824.7731873734741, 826.3265438667497, 676.6582875647791, 818.6520728690313, 818.7175424478545, 819.7663665855232, 821.7863355527576, 724.149124778386, 834.9081601023883, 873.4497266721957, 873.9126087391242, 874.3617159473588, 857.5155037403847, 861.0313397427893, 861.91811777881, 861.9612117454698, 863.6113748813059, 627.8712863862943, 628.8239292997968, 631.728356806573, 631.8673078653488, 631.9210098737658, 12428.813567796491, 12857.549985750455, 12959.352032398436, 13004.544840930617, 13047.739045219138, 12037.844263919142, 12807.167534110253, 12842.807357889638, 13027.674308142277, 13095.083344165912, 9922.454265015422, 10067.395956242648, 10191.490425478696, 10196.439195844225, 10374.221933354953, 3098.9535156972665, 3105.7825952183357, 3187.729043031345, 3260.2664400509934, 3262.0, 64772.352276477104, 65510.0, 66017.66991165062, 66889.33110668928, 68290.31709682939, 10135.847962280572, 10299.227557933185, 10369.896301036893, 10530.262881598215, 10660.520276587573, 18089.7286540702, 18159.546011349823, 18275.086245687664, 18782.43652690394, 18860.339888103852, 6405.871882562323, 6530.2816690164045, 6578.0, 6607.339266073354, 6651.600903945779, 3459.152507635645, 3612.277544491112, 3622.3841946869097, 3654.543182102237, 3671.7980511071614, 2716.456708658276, 2795.2033670404244, 2823.5623478360885, 2827.8020538562105, 2847.1031625038045, 477.5964310157911, 479.90401919616215, 484.5227450960801, 486.78824711250013, 487.665948825056, 568.1307599372883, 582.0785260621435, 586.4399498478942, 590.5511811023567, 611.6330201878837, 7483.0, 7937.722179723797, 8171.673133074611, 8173.305269052078, 8216.137305582828, 604.1481511069459, 619.2537991720056, 624.7282432142033, 627.1971875998729, 632.5319263744796, 3822.5665375484195, 3936.2717897189114, 4019.9598004019585, 4027.8993025174605, 4084.4690190275073, 53784.73107634437, 63524.0, 68060.6596967012, 69689.0, 70564.0, 58841.411585883594, 60968.695156524824, 61301.38698613046, 61572.0, 64253.357466424735, 54618.180727289124, 54674.72662636662, 54762.0, 55128.4550894612, 55743.0, 7380.77857664271, 7664.616769161631, 7711.575863327571, 7940.6029698515995, 7942.523448593103, 37966.24067518579, 38252.0, 38298.80850595729, 38503.03742406462, 39443.80278098706, 45158.77420612876, 47708.284375735086, 47760.761196193795, 47984.28023579579, 48904.26643600278, 8844.406728897371, 8928.464292142493, 9038.096190381173, 9101.135392137736, 9207.033261507446, 10809.837852432063, 10886.074683651977, 10912.454377281263, 11636.650900473, 11648.126390520914, 10439.425831579032, 10544.841827372442, 10710.357378557312, 11087.611933582608, 11200.663980080612, 10174.593016279561, 10234.6417875374, 10288.639897603547, 10418.270721049454, 10559.63041293551, 9867.802643946938, 9895.65365212214, 11435.828462573234, 11464.25482343645, 11465.615610378378, 9318.72043838686, 9625.663101791404, 9893.307468477138, 10038.297319187586, 10459.0, 8634.179752923463, 9561.995990421185, 9601.087896649808, 9639.132478077006, 9649.758756030875], "value": 6195.715116636871, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 115.0, 116.0, 115.0, 114.0, 116.0, 116.0, 116.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 129.0, 127.0, 186.0, 139.0, 127.0, 128.0, 127.0, 152.0, 130.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 168.0, 171.0, 163.0, 164.0, 162.0, 164.0, 162.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 78.0, 108.0, 79.0, 77.0, 77.0, 76.0, 92.0, 77.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 113.0, 86.0, 84.0, 85.0, 97.0, 86.0, 85.0, 107.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 118.0, 122.0, 118.0, 118.0, 120.0, 119.0], "value": 118.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 150.0, 151.0, 150.0, 151.0, 150.0, 151.0, 150.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 97.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 72.0, 72.0, 81.0, 72.0, 72.0, 71.0, 71.0, 72.0], "value": 72.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 68.0, 67.0, 67.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 84.0, 85.0, 85.0, 91.0, 86.0, 85.0, 85.0, 86.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 149.0, 133.0, 135.0, 144.0, 137.0, 147.0, 145.0, 190.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 182.0, 182.0, 185.0, 181.0, 175.0, 180.0, 182.0, 179.0, 186.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 70.0, 70.0, 72.0, 69.0, 68.0, 70.0, 69.0, 71.0], "value": 70.1, "unit": "score"}]}]} 08:19:37 INFO - Return code: 0 08:19:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:19:37 ERROR - # TBPL SUCCESS # 08:19:37 INFO - Running post-action listener: _resource_record_post_action 08:19:37 INFO - [mozharness: 2016-12-29 16:19:37.689436Z] Finished run-tests step (success) 08:19:37 INFO - Running post-run listener: _resource_record_post_run 08:19:37 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393764864; Read time: 20; Write time: 249812 08:19:37 INFO - TinderboxPrint: CPU usage
13.4% 08:19:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 08:19:37 INFO - TinderboxPrint: I/O write bytes / time
393,764,864 / 249,812 08:19:37 INFO - TinderboxPrint: CPU idle
8,284.7 (86.5%) 08:19:37 INFO - TinderboxPrint: CPU user
1,230.1 (12.8%) 08:19:37 INFO - TinderboxPrint: Swap in / out
0 / 0 08:19:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110673920; Read time: 0; Write time: 83652 08:19:37 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 283090944; Read time: 0; Write time: 166160 08:19:38 INFO - Running post-run listener: _upload_blobber_files 08:19:38 INFO - Blob upload gear active. 08:19:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:19:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:19:38 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'] 08:19:38 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 08:19:38 INFO - (blobuploader) - INFO - Open directory for files ... 08:19:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:19:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:19:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:39 INFO - (blobuploader) - INFO - Done attempting. 08:19:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:19:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:19:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:42 INFO - (blobuploader) - INFO - Done attempting. 08:19:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:19:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:19:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:43 INFO - (blobuploader) - INFO - Done attempting. 08:19:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:19:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:19:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:44 INFO - (blobuploader) - INFO - Done attempting. 08:19:44 INFO - (blobuploader) - INFO - Iteration through files over. 08:19:44 INFO - Return code: 0 08:19:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:19:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:19:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/604d12867e4cd69c48922c8440e29a7e19f0d31da6473bbfa1fc6a4164d88d83f62845ce58d5705fd5a59d0e4066eca9641bae1d47550fc728a5f60c2ee68139", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3de13be046581bc959c077026e6a019ba95465676c12173b7d40bf0e27eca0ca84fffcf2dbdb3d69aa0f024f8dd724843ed06a48eab269adb356d590f3905866", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27ba85afc9f9273aaa97f8a9ab1ad768d9914942525b166c0d239f4b5858a6308787862d81ab76f733f646e22c7301e1713464ecd1281bf78e1d3ffb9a503b4d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dcfd50273adf1be7981b1498c4dd645b7bea6c91595cd0f3536593101c7564322115b016a7925b3974c45162ed5e5b490b64001051bb6f5ff45e06dcd61834e0"} 08:19:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:19:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:19:44 INFO - Contents: 08:19:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/604d12867e4cd69c48922c8440e29a7e19f0d31da6473bbfa1fc6a4164d88d83f62845ce58d5705fd5a59d0e4066eca9641bae1d47550fc728a5f60c2ee68139", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3de13be046581bc959c077026e6a019ba95465676c12173b7d40bf0e27eca0ca84fffcf2dbdb3d69aa0f024f8dd724843ed06a48eab269adb356d590f3905866", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27ba85afc9f9273aaa97f8a9ab1ad768d9914942525b166c0d239f4b5858a6308787862d81ab76f733f646e22c7301e1713464ecd1281bf78e1d3ffb9a503b4d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dcfd50273adf1be7981b1498c4dd645b7bea6c91595cd0f3536593101c7564322115b016a7925b3974c45162ed5e5b490b64001051bb6f5ff45e06dcd61834e0"} 08:19:44 INFO - Running post-run listener: copy_logs_to_upload_dir 08:19:44 INFO - Copying logs to upload dir... 08:19:44 INFO - mkdir: /builds/slave/test/build/upload/logs 08:19:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.204574 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-12-29 08:19:44.250961) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 08:19:44.254437) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451 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/604d12867e4cd69c48922c8440e29a7e19f0d31da6473bbfa1fc6a4164d88d83f62845ce58d5705fd5a59d0e4066eca9641bae1d47550fc728a5f60c2ee68139", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3de13be046581bc959c077026e6a019ba95465676c12173b7d40bf0e27eca0ca84fffcf2dbdb3d69aa0f024f8dd724843ed06a48eab269adb356d590f3905866", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27ba85afc9f9273aaa97f8a9ab1ad768d9914942525b166c0d239f4b5858a6308787862d81ab76f733f646e22c7301e1713464ecd1281bf78e1d3ffb9a503b4d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dcfd50273adf1be7981b1498c4dd645b7bea6c91595cd0f3536593101c7564322115b016a7925b3974c45162ed5e5b490b64001051bb6f5ff45e06dcd61834e0"} build_url:https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011910 build_url: 'https://queue.taskcluster.net/v1/task/bcErNxcWTe6DM5ZYZ3qyag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/604d12867e4cd69c48922c8440e29a7e19f0d31da6473bbfa1fc6a4164d88d83f62845ce58d5705fd5a59d0e4066eca9641bae1d47550fc728a5f60c2ee68139", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3de13be046581bc959c077026e6a019ba95465676c12173b7d40bf0e27eca0ca84fffcf2dbdb3d69aa0f024f8dd724843ed06a48eab269adb356d590f3905866", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27ba85afc9f9273aaa97f8a9ab1ad768d9914942525b166c0d239f4b5858a6308787862d81ab76f733f646e22c7301e1713464ecd1281bf78e1d3ffb9a503b4d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dcfd50273adf1be7981b1498c4dd645b7bea6c91595cd0f3536593101c7564322115b016a7925b3974c45162ed5e5b490b64001051bb6f5ff45e06dcd61834e0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 08:19:44.280314) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 08:19:44.280640) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1483026017.623898-2077512451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 08:19:44.362847) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 08:19:44.363166) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 08:19:44.363476) ========= ========= Total master_lag: 0.17 =========