builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1487954435.67 results: success (0) buildid: 20170224065322 builduid: 2473b1bc356c463ea003dd7054c787e2 revision: 6d4e454134d2a383419a49f4daf634771d254d94 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-24 08:40:35.675119) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-24 08:40:35.675556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-24 08:40:35.675831) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-24 08:40:35.693945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 08:40:35.694289) ========= 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=32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-24 08:40:35-- 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% 22.3M=0.001s 2017-02-24 08:40:35 (22.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081017 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 08:40:35.790829) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 08:40:35.791318) ========= 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=32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022501 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 08:40:35.843271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 08:40:35.843853) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6d4e454134d2a383419a49f4daf634771d254d94 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6d4e454134d2a383419a49f4daf634771d254d94 --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=32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-24 08:40:36,114 truncating revision to first 12 chars 2017-02-24 08:40:36,114 Setting DEBUG logging. 2017-02-24 08:40:36,114 attempt 1/10 2017-02-24 08:40:36,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6d4e454134d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-24 08:40:36,422 unpacking tar archive at: mozilla-beta-6d4e454134d2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680652 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 08:40:36.538035) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-24 08:40:36.538325) ========= script_repo_revision: 6d4e454134d2a383419a49f4daf634771d254d94 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-24 08:40:36.538723) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-24 08:40:36.539013) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-24 08:40:36.549673) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-24 08:40:36.549935) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:40:36 INFO - MultiFileLogger online at 20170224 08:40:36 in /builds/slave/test 08:40:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:40:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:36 INFO - {'append_to_log': False, 08:40:36 INFO - 'base_work_dir': '/builds/slave/test', 08:40:36 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:40:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:36 INFO - 'branch': 'Mozilla-Beta', 08:40:36 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:36 INFO - 'config_files': ('talos/linux_config.py',), 08:40:36 INFO - 'default_actions': ('clobber', 08:40:36 INFO - 'read-buildbot-config', 08:40:36 INFO - 'download-and-extract', 08:40:36 INFO - 'populate-webroot', 08:40:36 INFO - 'create-virtualenv', 08:40:36 INFO - 'install', 08:40:36 INFO - 'run-tests'), 08:40:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:36 INFO - 'download_minidump_stackwalk': True, 08:40:36 INFO - 'download_symbols': 'ondemand', 08:40:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:36 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:36 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:36 INFO - 'installer_path': 'installer.exe', 08:40:36 INFO - 'log_level': 'info', 08:40:36 INFO - 'log_name': 'talos', 08:40:36 INFO - 'log_to_console': True, 08:40:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:40:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:40:36 INFO - 'opt_config_files': (), 08:40:36 INFO - 'pip_index': False, 08:40:36 INFO - 'sps_profile': False, 08:40:36 INFO - 'sps_profile_interval': 0, 08:40:36 INFO - 'suite': 'dromaeojs-e10s', 08:40:36 INFO - 'system_bits': '32', 08:40:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:36 INFO - 'title': 'talos-linux64-ix-008', 08:40:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:36 INFO - 'use_talos_json': True, 08:40:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:36 INFO - 'work_dir': 'build'} 08:40:36 INFO - [mozharness: 2017-02-24 16:40:36.921242Z] Running clobber step. 08:40:36 INFO - Running pre-action listener: _resource_record_pre_action 08:40:36 INFO - Running main action method: clobber 08:40:36 INFO - rmtree: /builds/slave/test/build 08:40:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:37 INFO - Running post-action listener: _resource_record_post_action 08:40:37 INFO - [mozharness: 2017-02-24 16:40:37.886058Z] Finished clobber step (success) 08:40:37 INFO - [mozharness: 2017-02-24 16:40:37.886157Z] Running read-buildbot-config step. 08:40:37 INFO - Running pre-action listener: _resource_record_pre_action 08:40:37 INFO - Running main action method: read_buildbot_config 08:40:37 INFO - Using buildbot properties: 08:40:37 INFO - { 08:40:37 INFO - "project": "", 08:40:37 INFO - "product": "firefox", 08:40:37 INFO - "script_repo_revision": "production", 08:40:37 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:40:37 INFO - "repository": "", 08:40:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 08:40:37 INFO - "buildid": "20170224065322", 08:40:37 INFO - "pgo_build": "True", 08:40:37 INFO - "basedir": "/builds/slave/test", 08:40:37 INFO - "buildnumber": 416, 08:40:37 INFO - "slavename": "talos-linux64-ix-008", 08:40:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:40:37 INFO - "platform": "ubuntu64_hw", 08:40:37 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:40:37 INFO - "branch": "mozilla-beta", 08:40:37 INFO - "repo_path": "releases/mozilla-beta", 08:40:37 INFO - "revision": "6d4e454134d2a383419a49f4daf634771d254d94", 08:40:37 INFO - "stage_platform": "linux64-pgo", 08:40:37 INFO - "builduid": "2473b1bc356c463ea003dd7054c787e2", 08:40:37 INFO - "slavebuilddir": "test" 08:40:37 INFO - } 08:40:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 08:40:37 INFO - Running post-action listener: _resource_record_post_action 08:40:37 INFO - [mozharness: 2017-02-24 16:40:37.888594Z] Finished read-buildbot-config step (success) 08:40:37 INFO - [mozharness: 2017-02-24 16:40:37.888683Z] Running download-and-extract step. 08:40:37 INFO - Running pre-action listener: _resource_record_pre_action 08:40:37 INFO - Running main action method: download_and_extract 08:40:37 INFO - mkdir: /builds/slave/test/build/tests 08:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:37 INFO - trying https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 08:40:37 INFO - Downloading https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 08:40:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:40:38 INFO - Downloaded 1327 bytes. 08:40:38 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 08:40:38 INFO - Using the following test package requirements: 08:40:38 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 08:40:38 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:40:38 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:40:38 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:40:38 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 08:40:38 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:40:38 INFO - u'jsshell-linux-x86_64.zip'], 08:40:38 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:40:38 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:40:38 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 08:40:38 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:40:38 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 08:40:38 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:40:38 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 08:40:38 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:40:38 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:40:38 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:40:38 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:40:38 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:40:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 08:40:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:40:38 INFO - Fetch https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 08:40:39 INFO - Http code: 200 08:40:39 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 08:40:39 INFO - x-amz-cf-id: x5_uBJPIElyVwNJSMcMdZCVZnIMGO-prhaf5QSvVQ-wyVtTuURYPIw== 08:40:39 INFO - x-amz-version-id: _fxIur2UgGGrvGFxBRx0mfy6WD8gBOtB 08:40:39 INFO - Expected file size: 21964236 08:40:39 INFO - Obtained file size: 21964236 08:40:43 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:40:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 08:40:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:40:43 INFO - Fetch https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 08:40:44 INFO - Http code: 200 08:40:44 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 08:40:44 INFO - x-amz-cf-id: x6_wtoQ8bSZhzRrZYT0bnxCt3dkiu_40_NoTIbTeBGkvhaxIHhTztA== 08:40:44 INFO - x-amz-version-id: _fxIur2UgGGrvGFxBRx0mfy6WD8gBOtB 08:40:44 INFO - Expected file size: 21964236 08:40:44 INFO - Obtained file size: 21964236 08:40:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 08:40:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:40:48 INFO - Fetch https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 08:40:49 INFO - Http code: 200 08:40:49 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 08:40:49 INFO - x-amz-cf-id: 5ruglkBLO7vAz6Nrk2NIOG4JrAQ2qxM-7OBtX5a_5YuDEC5jUcr94Q== 08:40:49 INFO - x-amz-version-id: TJVL7T2f41bW7QzRskOs.dur.TvaHoWX 08:40:50 INFO - Expected file size: 14402992 08:40:50 INFO - Obtained file size: 14402992 08:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:50 INFO - trying https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 08:40:50 INFO - Downloading https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 08:40:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:40:54 INFO - Downloaded 57755758 bytes. 08:40:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 08:40:54 INFO - mkdir: /builds/slave/test/properties 08:40:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:54 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:54 INFO - Contents: 08:40:54 INFO - build_url:https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 08:40:54 INFO - Running post-action listener: _resource_record_post_action 08:40:54 INFO - Running post-action listener: set_extra_try_arguments 08:40:54 INFO - [mozharness: 2017-02-24 16:40:54.974544Z] Finished download-and-extract step (success) 08:40:54 INFO - [mozharness: 2017-02-24 16:40:54.974771Z] Running populate-webroot step. 08:40:54 INFO - Running pre-action listener: _resource_record_pre_action 08:40:54 INFO - Running main action method: populate_webroot 08:40:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:54 INFO - '--tppagecycles', 08:40:54 INFO - '7'], 08:40:54 INFO - 'tests': ['tsvgm']}}, 08:40:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:54 INFO - 'talos_options': ['--disable-e10s'], 08:40:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:54 INFO - 'talos_options': ['--disable-e10s'], 08:40:54 INFO - 'tests': ['damp', 'tps']}, 08:40:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:54 INFO - 'tests': ['damp', 'tps']}, 08:40:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:54 INFO - 'tests': ['dromaeo_dom']}, 08:40:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:40:54 INFO - 'tests': ['basic_compositor_video']}, 08:40:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:40:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:54 INFO - 'tests': ['a11yr', 08:40:54 INFO - 'ts_paint', 08:40:54 INFO - 'tpaint', 08:40:54 INFO - 'sessionrestore', 08:40:54 INFO - 'sessionrestore_no_auto_restore', 08:40:54 INFO - 'tabpaint']}, 08:40:54 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:54 INFO - 'ts_paint', 08:40:54 INFO - 'tpaint', 08:40:54 INFO - 'sessionrestore', 08:40:54 INFO - 'sessionrestore_no_auto_restore', 08:40:54 INFO - 'tabpaint']}, 08:40:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:54 INFO - 'ts_paint', 08:40:54 INFO - 'tpaint', 08:40:54 INFO - 'sessionrestore', 08:40:54 INFO - 'sessionrestore_no_auto_restore', 08:40:54 INFO - 'tabpaint']}, 08:40:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:54 INFO - 'ts_paint', 08:40:54 INFO - 'tpaint', 08:40:54 INFO - 'sessionrestore', 08:40:54 INFO - 'sessionrestore_no_auto_restore', 08:40:54 INFO - 'tabpaint']}, 08:40:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:54 INFO - 'tests': ['a11yr', 08:40:54 INFO - 'ts_paint', 08:40:54 INFO - 'tpaint', 08:40:54 INFO - 'sessionrestore', 08:40:54 INFO - 'sessionrestore_no_auto_restore', 08:40:54 INFO - 'tabpaint']}, 08:40:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:54 INFO - 'tests': ['a11yr', 08:40:54 INFO - 'ts_paint', 08:40:54 INFO - 'tpaint', 08:40:54 INFO - 'sessionrestore', 08:40:54 INFO - 'sessionrestore_no_auto_restore', 08:40:54 INFO - 'tabpaint']}, 08:40:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:54 INFO - 'tests': ['tsvgx', 08:40:54 INFO - 'tsvgr_opacity', 08:40:54 INFO - 'tart', 08:40:54 INFO - 'tscrollx', 08:40:54 INFO - 'cart']}, 08:40:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:54 INFO - 'tsvgr_opacity', 08:40:54 INFO - 'tart', 08:40:54 INFO - 'tscrollx', 08:40:54 INFO - 'cart']}, 08:40:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:54 INFO - 'talos_options': ['--disable-e10s'], 08:40:54 INFO - 'tests': ['tp5o']}, 08:40:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:54 INFO - 'tests': ['tp5o']}, 08:40:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:54 INFO - 'talos_options': ['--disable-e10s', 08:40:54 INFO - '--xperf_path', 08:40:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:54 INFO - 'tests': ['tp5n']}, 08:40:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:54 INFO - 'talos_options': ['--xperf_path', 08:40:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:54 INFO - 'tests': ['tp5n']}}, 08:40:54 INFO - 'talos.zip': {'path': '', 08:40:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:54 INFO - Running post-action listener: _resource_record_post_action 08:40:54 INFO - [mozharness: 2017-02-24 16:40:54.997390Z] Finished populate-webroot step (success) 08:40:54 INFO - [mozharness: 2017-02-24 16:40:54.997482Z] Running create-virtualenv step. 08:40:54 INFO - Running pre-action listener: _resource_record_pre_action 08:40:54 INFO - Running main action method: create_virtualenv 08:40:54 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:40:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:55 INFO - Using real prefix '/usr' 08:40:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:55 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:57 INFO - Installing pip.................done. 08:40:57 INFO - Return code: 0 08:40:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:40:57 INFO - Reading from file tmpfile_stdout 08:40:57 INFO - Output received: 08:40:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:40:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:57 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 0x7f0e33354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148af60>, '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 0x148bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c1d0>, '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': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:40:57 INFO - Using env: {'DISPLAY': ':0', 08:40:57 INFO - 'HOME': '/home/cltbld', 08:40:57 INFO - 'LANG': 'en_US.UTF-8', 08:40:57 INFO - 'LANGUAGE': 'en_US:en', 08:40:57 INFO - 'LOGNAME': 'cltbld', 08:40:57 INFO - 'MAIL': '/var/mail/cltbld', 08:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:57 INFO - 'MOZ_NO_REMOTE': '1', 08:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:57 INFO - 'NO_EM_RESTART': '1', 08:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:57 INFO - 'PWD': '/builds/slave/test', 08:40:57 INFO - 'SHELL': '/bin/bash', 08:40:57 INFO - 'SHLVL': '1', 08:40:57 INFO - 'TERM': 'linux', 08:40:57 INFO - 'TMOUT': '86400', 08:40:57 INFO - 'USER': 'cltbld', 08:40:57 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 08:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:57 INFO - '_': '/tools/buildbot/bin/python'} 08:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:40:57 INFO - Cleaning up... 08:40:57 INFO - Return code: 0 08:40:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:58 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 0x7f0e33354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148af60>, '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 0x148bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c1d0>, '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': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:40:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:40:58 INFO - Using env: {'DISPLAY': ':0', 08:40:58 INFO - 'HOME': '/home/cltbld', 08:40:58 INFO - 'LANG': 'en_US.UTF-8', 08:40:58 INFO - 'LANGUAGE': 'en_US:en', 08:40:58 INFO - 'LOGNAME': 'cltbld', 08:40:58 INFO - 'MAIL': '/var/mail/cltbld', 08:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:58 INFO - 'MOZ_NO_REMOTE': '1', 08:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:58 INFO - 'NO_EM_RESTART': '1', 08:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:58 INFO - 'PWD': '/builds/slave/test', 08:40:58 INFO - 'SHELL': '/bin/bash', 08:40:58 INFO - 'SHLVL': '1', 08:40:58 INFO - 'TERM': 'linux', 08:40:58 INFO - 'TMOUT': '86400', 08:40:58 INFO - 'USER': 'cltbld', 08:40:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 08:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:58 INFO - '_': '/tools/buildbot/bin/python'} 08:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:58 INFO - Downloading/unpacking psutil>=3.1.1 08:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:41:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:00 INFO - Installing collected packages: psutil 08:41:00 INFO - Running setup.py install for psutil 08:41:00 INFO - building 'psutil._psutil_linux' extension 08:41:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:41:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:41:00 INFO - building 'psutil._psutil_posix' extension 08:41:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:41:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:41:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:00 INFO - Successfully installed psutil 08:41:00 INFO - Cleaning up... 08:41:00 INFO - Return code: 0 08:41:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:00 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 0x7f0e33354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148af60>, '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 0x148bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c1d0>, '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': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:41:00 INFO - Using env: {'DISPLAY': ':0', 08:41:00 INFO - 'HOME': '/home/cltbld', 08:41:00 INFO - 'LANG': 'en_US.UTF-8', 08:41:00 INFO - 'LANGUAGE': 'en_US:en', 08:41:00 INFO - 'LOGNAME': 'cltbld', 08:41:00 INFO - 'MAIL': '/var/mail/cltbld', 08:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:00 INFO - 'MOZ_NO_REMOTE': '1', 08:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:00 INFO - 'NO_EM_RESTART': '1', 08:41:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:00 INFO - 'PWD': '/builds/slave/test', 08:41:00 INFO - 'SHELL': '/bin/bash', 08:41:00 INFO - 'SHLVL': '1', 08:41:00 INFO - 'TERM': 'linux', 08:41:00 INFO - 'TMOUT': '86400', 08:41:00 INFO - 'USER': 'cltbld', 08:41:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 08:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:00 INFO - '_': '/tools/buildbot/bin/python'} 08:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:41:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:41:03 INFO - Installing collected packages: mozsystemmonitor 08:41:03 INFO - Running setup.py install for mozsystemmonitor 08:41:03 INFO - Successfully installed mozsystemmonitor 08:41:03 INFO - Cleaning up... 08:41:03 INFO - Return code: 0 08:41:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:03 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 0x7f0e33354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148af60>, '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 0x148bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c1d0>, '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': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:41:03 INFO - Using env: {'DISPLAY': ':0', 08:41:03 INFO - 'HOME': '/home/cltbld', 08:41:03 INFO - 'LANG': 'en_US.UTF-8', 08:41:03 INFO - 'LANGUAGE': 'en_US:en', 08:41:03 INFO - 'LOGNAME': 'cltbld', 08:41:03 INFO - 'MAIL': '/var/mail/cltbld', 08:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:03 INFO - 'MOZ_NO_REMOTE': '1', 08:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:03 INFO - 'NO_EM_RESTART': '1', 08:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:03 INFO - 'PWD': '/builds/slave/test', 08:41:03 INFO - 'SHELL': '/bin/bash', 08:41:03 INFO - 'SHLVL': '1', 08:41:03 INFO - 'TERM': 'linux', 08:41:03 INFO - 'TMOUT': '86400', 08:41:03 INFO - 'USER': 'cltbld', 08:41:03 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 08:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:03 INFO - '_': '/tools/buildbot/bin/python'} 08:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:03 INFO - Downloading/unpacking jsonschema==2.5.1 08:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:41:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:05 INFO - Downloading functools32-3.2.3-2.tar.gz 08:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:41:06 INFO - warning: no files found matching '*.txt' 08:41:06 INFO - no previously-included directories found matching 'build' 08:41:06 INFO - no previously-included directories found matching 'dist' 08:41:06 INFO - no previously-included directories found matching '.git*' 08:41:06 INFO - Installing collected packages: jsonschema, functools32 08:41:06 INFO - Running setup.py install for functools32 08:41:06 INFO - warning: no files found matching '*.txt' 08:41:06 INFO - no previously-included directories found matching 'build' 08:41:06 INFO - no previously-included directories found matching 'dist' 08:41:06 INFO - no previously-included directories found matching '.git*' 08:41:06 INFO - Successfully installed jsonschema functools32 08:41:06 INFO - Cleaning up... 08:41:06 INFO - Return code: 0 08:41:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:06 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 0x7f0e33354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148af60>, '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 0x148bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c1d0>, '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': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:41:06 INFO - Using env: {'DISPLAY': ':0', 08:41:06 INFO - 'HOME': '/home/cltbld', 08:41:06 INFO - 'LANG': 'en_US.UTF-8', 08:41:06 INFO - 'LANGUAGE': 'en_US:en', 08:41:06 INFO - 'LOGNAME': 'cltbld', 08:41:06 INFO - 'MAIL': '/var/mail/cltbld', 08:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:06 INFO - 'MOZ_NO_REMOTE': '1', 08:41:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:06 INFO - 'NO_EM_RESTART': '1', 08:41:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:06 INFO - 'PWD': '/builds/slave/test', 08:41:06 INFO - 'SHELL': '/bin/bash', 08:41:06 INFO - 'SHLVL': '1', 08:41:06 INFO - 'TERM': 'linux', 08:41:06 INFO - 'TMOUT': '86400', 08:41:06 INFO - 'USER': 'cltbld', 08:41:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 08:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:06 INFO - '_': '/tools/buildbot/bin/python'} 08:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:41:06 INFO - Cleaning up... 08:41:06 INFO - Return code: 0 08:41:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:06 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 0x7f0e33354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148af60>, '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 0x148bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c1d0>, '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': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:41:06 INFO - Using env: {'DISPLAY': ':0', 08:41:06 INFO - 'HOME': '/home/cltbld', 08:41:06 INFO - 'LANG': 'en_US.UTF-8', 08:41:06 INFO - 'LANGUAGE': 'en_US:en', 08:41:06 INFO - 'LOGNAME': 'cltbld', 08:41:06 INFO - 'MAIL': '/var/mail/cltbld', 08:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:06 INFO - 'MOZ_NO_REMOTE': '1', 08:41:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:06 INFO - 'NO_EM_RESTART': '1', 08:41:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:06 INFO - 'PWD': '/builds/slave/test', 08:41:06 INFO - 'SHELL': '/bin/bash', 08:41:06 INFO - 'SHLVL': '1', 08:41:06 INFO - 'TERM': 'linux', 08:41:06 INFO - 'TMOUT': '86400', 08:41:06 INFO - 'USER': 'cltbld', 08:41:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 08:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:06 INFO - '_': '/tools/buildbot/bin/python'} 08:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:06 INFO - Downloading/unpacking blobuploader==1.2.4 08:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:08 INFO - Downloading blobuploader-1.2.4.tar.gz 08:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:41:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:41:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:09 INFO - Downloading docopt-0.6.1.tar.gz 08:41:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:09 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:09 INFO - Running setup.py install for blobuploader 08:41:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:09 INFO - Running setup.py install for requests 08:41:09 INFO - Running setup.py install for docopt 08:41:10 INFO - Successfully installed blobuploader requests docopt 08:41:10 INFO - Cleaning up... 08:41:10 INFO - Return code: 0 08:41:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:10 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 0x7f0e33354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148af60>, '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 0x148bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c1d0>, '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': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:10 INFO - Using env: {'DISPLAY': ':0', 08:41:10 INFO - 'HOME': '/home/cltbld', 08:41:10 INFO - 'LANG': 'en_US.UTF-8', 08:41:10 INFO - 'LANGUAGE': 'en_US:en', 08:41:10 INFO - 'LOGNAME': 'cltbld', 08:41:10 INFO - 'MAIL': '/var/mail/cltbld', 08:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:10 INFO - 'MOZ_NO_REMOTE': '1', 08:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:10 INFO - 'NO_EM_RESTART': '1', 08:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:10 INFO - 'PWD': '/builds/slave/test', 08:41:10 INFO - 'SHELL': '/bin/bash', 08:41:10 INFO - 'SHLVL': '1', 08:41:10 INFO - 'TERM': 'linux', 08:41:10 INFO - 'TMOUT': '86400', 08:41:10 INFO - 'USER': 'cltbld', 08:41:10 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 08:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:10 INFO - '_': '/tools/buildbot/bin/python'} 08:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:10 INFO - Running setup.py (path:/tmp/pip-AICS2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:10 INFO - Running setup.py (path:/tmp/pip-dvrsT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:10 INFO - Running setup.py (path:/tmp/pip-9vU_K4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:10 INFO - Running setup.py (path:/tmp/pip-fT4Bc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:10 INFO - Running setup.py (path:/tmp/pip-0R_xFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:10 INFO - Running setup.py (path:/tmp/pip-i5UVc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:10 INFO - Running setup.py (path:/tmp/pip-firvUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:10 INFO - Running setup.py (path:/tmp/pip-EdWYXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:10 INFO - Running setup.py (path:/tmp/pip-BIuX6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:10 INFO - Running setup.py (path:/tmp/pip-5pk9kQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:11 INFO - Running setup.py (path:/tmp/pip-YLof5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:11 INFO - Running setup.py (path:/tmp/pip-kCq7F7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:11 INFO - Running setup.py (path:/tmp/pip-c8Q7kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:11 INFO - Running setup.py (path:/tmp/pip-qDkZdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:11 INFO - Running setup.py (path:/tmp/pip-Q58Hwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:11 INFO - Running setup.py (path:/tmp/pip-rC5JtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:11 INFO - Running setup.py (path:/tmp/pip-6Rp8cR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:11 INFO - Running setup.py install for manifestparser 08:41:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:11 INFO - Running setup.py install for mozcrash 08:41:11 INFO - Running setup.py install for mozdebug 08:41:11 INFO - Running setup.py install for mozdevice 08:41:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:41:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:11 INFO - Running setup.py install for mozfile 08:41:12 INFO - Running setup.py install for mozhttpd 08:41:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:12 INFO - Running setup.py install for mozinfo 08:41:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:12 INFO - Running setup.py install for mozInstall 08:41:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:12 INFO - Running setup.py install for mozleak 08:41:12 INFO - Running setup.py install for mozlog 08:41:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:12 INFO - Running setup.py install for moznetwork 08:41:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:12 INFO - Running setup.py install for mozprocess 08:41:12 INFO - Running setup.py install for mozprofile 08:41:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:41:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:41:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:41:12 INFO - Running setup.py install for mozrunner 08:41:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:41:13 INFO - Running setup.py install for mozscreenshot 08:41:13 INFO - Running setup.py install for moztest 08:41:13 INFO - Running setup.py install for mozversion 08:41:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:41:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:13 INFO - Cleaning up... 08:41:13 INFO - Return code: 0 08:41:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:13 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 0x7f0e33354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148af60>, '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 0x148bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c1d0>, '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': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:13 INFO - Using env: {'DISPLAY': ':0', 08:41:13 INFO - 'HOME': '/home/cltbld', 08:41:13 INFO - 'LANG': 'en_US.UTF-8', 08:41:13 INFO - 'LANGUAGE': 'en_US:en', 08:41:13 INFO - 'LOGNAME': 'cltbld', 08:41:13 INFO - 'MAIL': '/var/mail/cltbld', 08:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:13 INFO - 'MOZ_NO_REMOTE': '1', 08:41:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:13 INFO - 'NO_EM_RESTART': '1', 08:41:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:13 INFO - 'PWD': '/builds/slave/test', 08:41:13 INFO - 'SHELL': '/bin/bash', 08:41:13 INFO - 'SHLVL': '1', 08:41:13 INFO - 'TERM': 'linux', 08:41:13 INFO - 'TMOUT': '86400', 08:41:13 INFO - 'USER': 'cltbld', 08:41:13 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 08:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:13 INFO - '_': '/tools/buildbot/bin/python'} 08:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:13 INFO - Running setup.py (path:/tmp/pip-Soo79o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:13 INFO - Running setup.py (path:/tmp/pip-Sza5b0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:13 INFO - Running setup.py (path:/tmp/pip-k6msXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:13 INFO - Running setup.py (path:/tmp/pip-shPNdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:13 INFO - Running setup.py (path:/tmp/pip-JnpRI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:13 INFO - Running setup.py (path:/tmp/pip-R5U9WK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:14 INFO - Running setup.py (path:/tmp/pip-zEv0TJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:14 INFO - Running setup.py (path:/tmp/pip-nFQ31c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:14 INFO - Running setup.py (path:/tmp/pip-A9FVxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:14 INFO - Running setup.py (path:/tmp/pip-gLQVWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:14 INFO - Running setup.py (path:/tmp/pip-5HoQev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:14 INFO - Running setup.py (path:/tmp/pip-BDFvJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:14 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)) 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:14 INFO - Running setup.py (path:/tmp/pip-faHF60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:14 INFO - Running setup.py (path:/tmp/pip-kMMgKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:14 INFO - Running setup.py (path:/tmp/pip-A04Eoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:14 INFO - Running setup.py (path:/tmp/pip-xminGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:14 INFO - Running setup.py (path:/tmp/pip-8SN6bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:14 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:14 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:16 INFO - Downloading blessings-1.6.tar.gz 08:41:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:16 INFO - Installing collected packages: blessings 08:41:16 INFO - Running setup.py install for blessings 08:41:17 INFO - Successfully installed blessings 08:41:17 INFO - Cleaning up... 08:41:17 INFO - Return code: 0 08:41:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:41:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:17 INFO - Reading from file tmpfile_stdout 08:41:17 INFO - Current package versions: 08:41:17 INFO - argparse == 1.2.1 08:41:17 INFO - blessings == 1.6 08:41:17 INFO - blobuploader == 1.2.4 08:41:17 INFO - docopt == 0.6.1 08:41:17 INFO - functools32 == 3.2.3-2 08:41:17 INFO - jsonschema == 2.5.1 08:41:17 INFO - manifestparser == 1.1 08:41:17 INFO - mozInstall == 1.12 08:41:17 INFO - mozcrash == 1.0 08:41:17 INFO - mozdebug == 0.1 08:41:17 INFO - mozdevice == 0.48 08:41:17 INFO - mozfile == 1.2 08:41:17 INFO - mozhttpd == 0.7 08:41:17 INFO - mozinfo == 0.9 08:41:17 INFO - mozleak == 0.1 08:41:17 INFO - mozlog == 3.4 08:41:17 INFO - moznetwork == 0.27 08:41:17 INFO - mozprocess == 0.23 08:41:17 INFO - mozprofile == 0.28 08:41:17 INFO - mozrunner == 6.13 08:41:17 INFO - mozscreenshot == 0.1 08:41:17 INFO - mozsystemmonitor == 0.3 08:41:17 INFO - moztest == 0.8 08:41:17 INFO - mozversion == 1.4 08:41:17 INFO - psutil == 3.1.1 08:41:17 INFO - requests == 1.2.3 08:41:17 INFO - wsgiref == 0.1.2 08:41:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:17 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 0x7f0e33354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148af60>, '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 0x148bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c1d0>, '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': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:17 INFO - Using env: {'DISPLAY': ':0', 08:41:17 INFO - 'HOME': '/home/cltbld', 08:41:17 INFO - 'LANG': 'en_US.UTF-8', 08:41:17 INFO - 'LANGUAGE': 'en_US:en', 08:41:17 INFO - 'LOGNAME': 'cltbld', 08:41:17 INFO - 'MAIL': '/var/mail/cltbld', 08:41:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:17 INFO - 'MOZ_NO_REMOTE': '1', 08:41:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:17 INFO - 'NO_EM_RESTART': '1', 08:41:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:17 INFO - 'PWD': '/builds/slave/test', 08:41:17 INFO - 'SHELL': '/bin/bash', 08:41:17 INFO - 'SHLVL': '1', 08:41:17 INFO - 'TERM': 'linux', 08:41:17 INFO - 'TMOUT': '86400', 08:41:17 INFO - 'USER': 'cltbld', 08:41:17 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 08:41:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:17 INFO - '_': '/tools/buildbot/bin/python'} 08:41:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:17 INFO - Cleaning up... 08:41:17 INFO - Return code: 0 08:41:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e33354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x148dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148af60>, '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 0x148bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c1d0>, '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': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:41: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', 'jsonschema'] in /builds/slave/test/build 08:41: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 jsonschema 08:41:17 INFO - Using env: {'DISPLAY': ':0', 08:41:17 INFO - 'HOME': '/home/cltbld', 08:41:17 INFO - 'LANG': 'en_US.UTF-8', 08:41:17 INFO - 'LANGUAGE': 'en_US:en', 08:41:17 INFO - 'LOGNAME': 'cltbld', 08:41:17 INFO - 'MAIL': '/var/mail/cltbld', 08:41:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:17 INFO - 'MOZ_NO_REMOTE': '1', 08:41:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:17 INFO - 'NO_EM_RESTART': '1', 08:41:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:17 INFO - 'PWD': '/builds/slave/test', 08:41:17 INFO - 'SHELL': '/bin/bash', 08:41:17 INFO - 'SHLVL': '1', 08:41:17 INFO - 'TERM': 'linux', 08:41:17 INFO - 'TMOUT': '86400', 08:41:17 INFO - 'USER': 'cltbld', 08:41:17 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 08:41:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:17 INFO - '_': '/tools/buildbot/bin/python'} 08:41:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:41:17 INFO - Cleaning up... 08:41:17 INFO - Return code: 0 08:41:17 INFO - Running post-action listener: _resource_record_post_action 08:41:17 INFO - Running post-action listener: _start_resource_monitoring 08:41:17 INFO - Starting resource monitoring. 08:41:17 INFO - [mozharness: 2017-02-24 16:41:17.876741Z] Finished create-virtualenv step (success) 08:41:17 INFO - [mozharness: 2017-02-24 16:41:17.877256Z] Running install step. 08:41:17 INFO - Running pre-action listener: _resource_record_pre_action 08:41:17 INFO - Running main action method: install 08:41:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:18 INFO - Reading from file tmpfile_stdout 08:41:18 INFO - Detecting whether we're running mozinstall >=1.0... 08:41:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:41:18 INFO - Reading from file tmpfile_stdout 08:41:18 INFO - Output received: 08:41:18 INFO - Usage: mozinstall [options] installer 08:41:18 INFO - Options: 08:41:18 INFO - -h, --help show this help message and exit 08:41:18 INFO - -d DEST, --destination=DEST 08:41:18 INFO - Directory to install application into. [default: 08:41:18 INFO - "/builds/slave/test"] 08:41:18 INFO - --app=APP Application being installed. [default: firefox] 08:41:18 INFO - mkdir: /builds/slave/test/build/application 08:41:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:41:31 INFO - Reading from file tmpfile_stdout 08:41:31 INFO - Output received: 08:41:31 INFO - /builds/slave/test/build/application/firefox/firefox 08:41:31 INFO - Running post-action listener: _resource_record_post_action 08:41:31 INFO - [mozharness: 2017-02-24 16:41:31.816937Z] Finished install step (success) 08:41:31 INFO - [mozharness: 2017-02-24 16:41:31.817180Z] Running run-tests step. 08:41:31 INFO - Running pre-action listener: _resource_record_pre_action 08:41:31 INFO - Running main action method: run_tests 08:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:31 INFO - Python 2.7.3 08:41:31 INFO - Return code: 0 08:41:31 INFO - grabbing minidump binary from tooltool 08:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:31 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 0x148af60>, '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 0x148bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x148c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:41:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:41:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:41:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:31 INFO - Return code: 0 08:41:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:41:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:41:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:41:31 INFO - Using env: {'DISPLAY': ':0', 08:41:31 INFO - 'HOME': '/home/cltbld', 08:41:31 INFO - 'LANG': 'en_US.UTF-8', 08:41:31 INFO - 'LANGUAGE': 'en_US:en', 08:41:31 INFO - 'LOGNAME': 'cltbld', 08:41:31 INFO - 'MAIL': '/var/mail/cltbld', 08:41:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:31 INFO - 'MOZ_NO_REMOTE': '1', 08:41:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:31 INFO - 'NO_EM_RESTART': '1', 08:41:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:31 INFO - 'PWD': '/builds/slave/test', 08:41:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:31 INFO - 'SHELL': '/bin/bash', 08:41:31 INFO - 'SHLVL': '1', 08:41:31 INFO - 'TERM': 'linux', 08:41:31 INFO - 'TMOUT': '86400', 08:41:31 INFO - 'USER': 'cltbld', 08:41:31 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855', 08:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:31 INFO - '_': '/tools/buildbot/bin/python'} 08:41:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:41:32 INFO - mozversion application_buildid: 20170224065322 08:41:32 INFO - mozversion application_changeset: 6d4e454134d2a383419a49f4daf634771d254d94 08:41:32 INFO - mozversion application_display_name: Firefox 08:41:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:32 INFO - mozversion application_name: Firefox 08:41:32 INFO - mozversion application_remotingname: firefox 08:41:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:41:32 INFO - mozversion application_vendor: Mozilla 08:41:32 INFO - mozversion application_version: 52.0 08:41:32 INFO - mozversion platform_buildid: 20170224065322 08:41:32 INFO - mozversion platform_changeset: 6d4e454134d2a383419a49f4daf634771d254d94 08:41:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:41:32 INFO - mozversion platform_version: 52.0 08:41:32 INFO - using testdate: 1487954492 08:41:32 INFO - actual date: 1487954492 08:41:32 INFO - starting webserver on 'localhost:53072' 08:41:32 INFO - SUITE-START | Running 2 tests 08:41:32 INFO - TEST-START | dromaeo_css 08:41:32 INFO - operating with platform_type : linux_ 08:41:32 INFO - Initialising browser for dromaeo_css test... 08:41:32 INFO - TEST-INFO | started process 29390 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqxqed_/profile http://localhost:53072/getInfo.html) 08:41:36 INFO - PROCESS | 29390 | __metrics Screen width/height:1600/1200 08:41:36 INFO - PROCESS | 29390 | colorDepth:24 08:41:36 INFO - PROCESS | 29390 | Browser inner width/height: 1024/697 08:41:36 INFO - PROCESS | 29390 | __metrics 08:41:36 ERROR - PROCESS | 29390 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 08:41:37 INFO - TEST-INFO | 29390: exit 0 08:41:37 INFO - Browser initialized. 08:41:37 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:37 INFO - TEST-INFO | started process 29523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqxqed_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:49 INFO - PROCESS | 29523 | RSS: Main: 147214336 08:41:49 INFO - PROCESS | 29523 | 08:44:49 INFO - PROCESS | 29523 | Cycle 1(1): loaded http://localhost:53072/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53072/tests/dromaeo/cssquery-ext.html) 08:44:50 INFO - PROCESS | 29523 | RSS: Main: 154247168 08:44:50 INFO - PROCESS | 29523 | 08:47:52 INFO - PROCESS | 29523 | Cycle 1(1): loaded http://localhost:53072/tests/dromaeo/cssquery-ext.html (next: http://localhost:53072/tests/dromaeo/cssquery-jquery.html) 08:47:53 INFO - PROCESS | 29523 | RSS: Main: 152883200 08:47:53 INFO - PROCESS | 29523 | 08:50:55 INFO - PROCESS | 29523 | Cycle 1(1): loaded http://localhost:53072/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53072/tests/dromaeo/cssquery-mootools.html) 08:50:55 INFO - PROCESS | 29523 | RSS: Main: 151937024 08:50:55 INFO - PROCESS | 29523 | 08:53:57 INFO - PROCESS | 29523 | Cycle 1(1): loaded http://localhost:53072/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53072/tests/dromaeo/cssquery-prototype.html) 08:53:58 INFO - PROCESS | 29523 | RSS: Main: 154046464 08:53:58 INFO - PROCESS | 29523 | 08:57:00 INFO - PROCESS | 29523 | Cycle 1(1): loaded http://localhost:53072/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53072/tests/dromaeo/cssquery-yui.html) 08:57:01 INFO - PROCESS | 29523 | RSS: Main: 154636288 08:57:01 INFO - PROCESS | 29523 | 09:00:03 INFO - PROCESS | 29523 | Cycle 1(1): loaded http://localhost:53072/tests/dromaeo/cssquery-yui.html (next: http://localhost:53072/tests/dromaeo/cssquery-dojo.html) 09:00:03 INFO - PROCESS | 29523 | RSS: Main: 155246592 09:00:03 INFO - PROCESS | 29523 | 09:00:03 INFO - PROCESS | 29523 | __start_tp_report 09:00:03 INFO - PROCESS | 29523 | _x_x_mozilla_page_load 09:00:03 INFO - PROCESS | 29523 | _x_x_mozilla_page_load_details 09:00:03 INFO - PROCESS | 29523 | |i|pagename|runs| 09:00:03 INFO - PROCESS | 29523 | |0;dojo.html;3210.5184222366643;3227.7579181561373;3233.6927991840766;3241.594800649919;3259.669336424456;5581.944180558193;5665.943340566593;5671.06427439472;5700.344460387047;5712.343080545738;5635.802746903859;5682.772689092431;5684.403137670547;5690.118031705082;5714.828555143342;5087.5421212090905;5096;5154.046501397253;5191.351081114861;5201.323827902367;5249.737513124348;5253.343332083489;5253.553447956928;5258;5260.579153667697;5116.97660467906;5128.948710512885;5208.0885844977165;5229.921551176735;5247.291615631898;5187.144121219994;5195.454477279869;5235.816746413876;5240.52835244826;5343.118385466432;5231.8168864089575;5303.257543943851;5323.334583177103;5329.600279979017;5331.786728530854;5810.506106980912;5821.708914554298;5848.298204215479;5883.470487656132;5903.734331955073;5997.460228579449;6038.909416358758;6056.757729690807;6062.818115456544;6092.786752463642;6123.050927106306;6132.724027418777;6135.478484328837;6139.539534534883;6140.692965351759;5783.797567085132;5795.652260864362;5797.855053623609;5804.100364443518;5806.419358064202;6054.606450580698;6059.394060593993;6116.510679145657;6146.815595532141;6350.269718982284;6032.788852390146;6037.154798328237;6040.456358927718;6047.818565443044;6064.393560643988;5984.820455386345;6125.081237814364;6127.908081378783;6133.509319254449;6135.202423684892;5991.58058935879;6023.1266466363;6036.486898613579;6038.516918646497;6119.388061193845;6062.333143354227;6105.48103411215;6122.20411346531;6135.601185922901;6139.079138129317;4664.720116792935;4688.97655511727;4709.152352576501;4728.338032675429;4751.667383283137;4094.28350038742;4127.6491498222385;4128.855490057834;4130.421740956269;4194.538600753915;5761.510271626875;5883.02930016551;5893.02765043763;5911.586188966817;5922.526197904243;6177.7837775677635;6185.443310102112;6197.380261973857;6200.3799620037635;6230.065490176419;5730.885382292414;5783.855403614859;5809.535237181015;5826.126081087871;5856.799356131983;5315.229291752674;5339.7063161526485;5344.839654810362;5370.3287089113865;5385.030694474954;6387.680615969276;6418.19772528434;6438.356164383524;6466.450351720063;6470.870582588322;6038.9396106038375;6090.878182436415;6130.049842274276;6138.725610151984;6187.319394866651;6468.579542329921;6481.8703625928165;6491.545591808528;6525.804225873231;6529.7061632227615;6106.053561697944;6111.847203819762;6130.141780150871;6148.385161483816;6155.815325540241;5951.28584569837;5975.521958243417;6124.5712800103565;6209.379062093754;6228.439440450381;5973.133895585029;6083.543734219863;6088.147659327787;6097.939020609737;6114.6942652868065;6025.246844144482;6046.758129674764;6052.334243233329;6066.393360663898;6069.848253793691;5658.17956396312;5669.4047125051275;5957;6008.309044459943;6023.909641355471;5953.255843019622;6032.517398608013;6046.939530604814;6121.6054024712375;6124.167343420691;5932.911006334994;5933.317668468008;5936.1095835625;5948.613340132878;5969.582129250911 09:00:03 INFO - PROCESS | 29523 | |1;ext.html;571.1404336473606;606.3390903914732;618.7432215630514;640.1166390381273;658.3054877104653;41144;42293.57706422935;43914.34128488075;43986.7800660997;44031.779841100826;44659.77670111653;45062.774686126606;45151.0969780605;45199.774001130034;45384.09231815362;8871.86692199616;10744.78510429791;11108;11114.11087113029;11304.265222760536;10863.130949524018;10871;10903.672889813319;10921.12630989519;10964.780704385908;10971.615993440231;10980.560777568928;10980.670579882617;11001.064909482704;11040.171987100959;10847.51186196623;10893.509792059376;10917.072048875816;10957.890421095806;10958.835617465744;10736.677899663022;10800.837987430195;10843.67468975924;10854.24020318578;10864.674059778219;42473;42574.361384578944;42680.57319426797;43016.784916075216;43036.78481607603;3560.9821950890077;3655.597884232732;3692.7045836333027;3748.1566647504364;3751.0809851586264;32216.838915805507;32364;32639;33057.6694233057;33490.83254583736;4399.6480281577715;4532.682712210147;4606.5393460654;4621.3299071634765;4629.189891768927;344907;346299;346443.267783662;346828;348777;62917.685411572646;62977;63019.68490157612;63081;63327.050094248625;65856.67071664611;65874.34125658778;66195.66902165458;66196.66901665558;66474.33525664778;14553;14690.779638305434;16376.918115409348;16972.405965791386;16999.74500382495;12328.445219965122;12395.814062789066;12445.564405245774;12582.748345033231;12714.173578717538;20152.69770953437;20180;20200.191992320437;20346.287879924428;20500.282490112775;7461.552306861606;7474.962625186948;7487.8502429951095;7489.962550187214;7622.237776222333;921.2767977138049;978.2711879649706;1035.3382820573022;1055.6305293147336;1056.1920131099714;30361.544576831366;31046.534301985488;31526.36947261042;31687.683123168936;31753.682463175533;1043.3531210649446;1071.0574694269148;1092.3773449134076;1094.480121942087;1112.777444511101;16202.108884011257;16391.508254752378;16436.917815410845;16726.916365418096;16789.656827453775;464994;468372;471492;471672;473309;59436.70281648564;59643;59974.40025599688;59981.40018599846;60007.69996150079;1307.1568838099372;1308.8560258371572;1338.618493729302;1358.599213232099;1359.4494229836932;30026.099217023526;30885.845570772002;30886.76452941857;30986.845065774527;31422;51106.488935110174;51407.45777626677;51523.48476515187;51680.224796628834;51697;379751;380396;380611;380621;381112;29500.852495737385;45948.310775339065;46459.767701161276;46751;47215.29177062416;45770.54229457796;46781.29828052514;47367.76316118535;48875.26687099625;49139.262911055645;41441.58558414377;41488.377674334304;41803.163936720484;42590.14819703527;43362.349564755925;41574.584254157075;42005.159896801284;42625.36061959135;43447.565524344354;43933.78033109814;41191.588084118775;41613;42026.159476810906;42487.30050798057;42580.5741942589;35434;37048.62951370559;37066.54404782083;37384.81307593445;37841;28426.57360139641;28588.714112858604;28896.2775930595;29106.417871642872;29139 09:00:03 INFO - PROCESS | 29523 | |2;jquery.html;419.39397570510613;422.58586585146554;424.57542457542456;427.3589615576636;443.32171777180906;18127.81872181278;19317.903410482962;19680.90159549202;20052.298169564066;20319.18723251068;19436.222551097973;19643;19877.900610496963;19890;20303.695444568344;5661.490465858072;5946.821595352147;5949.940500595004;5953.047512398017;5959.612625179371;4190.664746820247;5126.307948426952;5826.563007774413;5940.821775346746;6556.541042127053;6584.341565843401;6588.308227636101;6590.93409065908;6600.042993765901;6606.900896486556;5981.043033114703;6000.669963152047;6005.939940600625;6011.819645410645;6593.109930159415;5801.8549536261935;5836.416358364172;5839.941600583982;5841.532677385799;5844.678542680151;14043.64890877726;14446.205458699767;14585.562433127023;14661.340239689132;14741.410343586243;2398.052769156191;2450.987745061281;2876.6116574262624;3064.5709600655928;3106.0526539405473;10390.324628899098;10814.891851081467;10859.511321990529;10984.176186786022;10988.505517251742;1949.9415017549495;1980.6236815005102;2001.949951251216;2021.3935819254166;2071.275053731197;76831.615841921;80784.59607701983;81708;82610.17389826085;84418.57790711007;11193.216474846682;11375.293705944174;11521.135914806424;11645.941770291094;11667.124965627612;16381.508554743377;16390.754138687927;16398.26207820651;16407.753883691756;16416.261268242957;7681.462297639112;7980.880286795703;8081.515109093356;8185.3451723861945;8192.795180120545;7550.244975502405;7560.848783024308;7728.188540203198;7746.38028957682;7808.960955195188;4860.441049279378;4946.901061978812;5000.574951129195;5004.049230646166;5091.3126727892;2016.757989041295;2061.9278325258842;2089.2583132987875;2102.10660469303;2160.79472450117;965.3435663748718;966.2028826218258;989.2135752077116;1024.6208902705898;1035.8239099353127;17929.7310540342;19042;19176.520586985436;19258.518537036685;19576.804231957783;965.2567523007245;971.0580736685545;973.2262851033446;983.9950800245953;1000.5047501486811;10265.640702575374;10803.189760767973;10846.891531084588;10888.891111088788;10942.343459392461;432668;436363;441077;441421;442338;86951;87395.56302218576;88526.55736721405;88791.55604221938;89656.55171724099;987.7925635616457;1026.4662375564815;1064.2337516987602;1082.4858192358568;1085.4355735017905;16840.326386944875;17021.91489042547;17094.316227350766;17714.114294284976;17998.10009499546;39005.219895602495;40072.59927400688;41435.585644144376;42716.57283427126;43502.56497434985;58764.412355875895;60073.09890351561;60104;60250.397496026235;60872;5580.693061881473;6570.8357291066195;8394;8761.5181165034;8944.463332200088;9336.486493242664;9372.859407108763;9629.229661626912;9781;9978.60085596568;8492.70275540353;8995.370324077252;9045.366824322498;9097.681581144629;9134.954325228331;8853.911460885567;8912.598933047899;9067.90932090697;9113.681021164228;9249.630014799333;8314.667413303641;8580.485170889517;8792.120787921413;9068.274538036809;9449.574769135268;12087.09346798976;12566.246025238515;12583.433745481658;12602.621921342374;12762.042846786713;11467.655970320904;11585.362805045803;11601.12991525622;11746.530138794695;11846.749117667616 09:00:03 INFO - PROCESS | 29523 | |3;mootools.html;1327.2633688302994;1380.2339701465683;1432.8208973878266;1517.8861585381098;1528.403922470236;8649.610767515462;8923.91076089239;9211;9232.492212928286;9254;9091.818163636723;9335.206507446876;9350.62597496101;9353.438793672385;9380.484073375961;2459.7417271186537;2490.962635560459;2493.127405408111;2495.4135778092223;2499.3751562109474;2375.2161786610463;2466.2971053249826;2484.0312278211513;2487.067349743846;2489.166129346671;2448.338948483917;2480.193936970483;2480.60310350344;2484.776370126688;2493.2769496845895;2360.4688944987324;2366.3374255208482;2377.9286621401384;2378.785909268157;2383.9046438142454;2320.709911261092;2380.726216485109;2396.101461951768;2399.8560086394696;2405.314485371678;8865.68970086044;8890.466572005636;8953.418027828171;8956.8656470153;8966.372353935227;5387.0841956867425;5522.088855338864;5541.612087153901;5553.8333849984565;5555.8888822223325;3464.1512829356716;3557.8932632021083;3591.6408359164134;3593.1556084320164;3597.892063238107;1153.809621412466;1161.4076820821442;1189.0309397840733;1191.6901605582525;1233.340163012784;12641.620751377473;12701.237925724394;12810.55163069288;12862.099653024292;12863.871361286454;4523.977380113079;4707.082118986765;4815.735134567562;4819.349387832668;4833.540813622701;9995.500224988722;10017.849732254022;10060.798784024279;10065.245106617032;10090.899091008996;5503.036968530491;5505.697186654773;5505.944940550623;5510.614257001971;5512.173174023848;4955.207166853286;5092.592592592584;5146.202338637517;5160.845174644766;5186.81846135391;3961.088949541622;4072.083781149218;4074.3684728867074;4128.566500517462;4150.937735933963;1277.5145444730942;1284.9357532123543;1284.9421776020101;1286.9871301286867;1292.3796577642784;771.733751855609;785.3520845302648;860.6901515454431;871.6252011635058;900.2662829793697;5793.24687790593;6020.608660437058;6108.816735497942;6124.693765311717;6259.6870156492905;930.6742640075919;962.4658314635304;990.3760630802549;1010.4796030044533;1023.5956797065118;3967.563568007517;4102.651274641629;4256.936145957813;4269.380939763779;4317.179735850178;10825.512851921683;10851.294665846695;11022.724431889266;11030.944845275882;11380.658580242605;10498.212634052325;10915.181361397768;10940.726481838017;10950.945245273882;10951.507182176822;8476.321894248445;8647.178518040777;8673.566321683891;8737.956310218407;8758.56207189638;5940.257467816523;6089.208402907594;6132.63204207749;6165.876682466236;6207.503399728102;9652.420854748738;10147.238957078102;10220.744481388025;10250.923653016325;10304.330218535772;10110.342827716175;10315.690529284133;10337.534810933375;10396.532156052845;10493.055624993787;7526.924730752841;7613;7681.347085497795;7854.371650267851;7868.645910934136;8275.255227029596;8404.621792019496;8406.907102076691;8415.4109212357;8432.409731318749;7674.577898215429;7701.268379503938;7719.691212351443;7866.213378662317;7899.170587088273;7585.127710313384;7599.16409194977;7632.988502320563;7748.263914928073;7816.7264145754625;7196.784096477114;7229.421646268181;7278.199398066315;7302.123745150616;7309.451791115794;5012.423571289349;5088.847334579968;5101.7194054327365;5192.532672059533;5225.555827754683;5140.537351638371;5208.296879921162;5243.318368612208;5350.892982140414;5521.475459831309 09:00:03 INFO - PROCESS | 29523 | |4;prototype.html;348.73147676289256;355.57686353239643;359.29936623584007;362.86211239728897;365.846344535295;5530.9303336648145;5566.638168519048;5595.524380427663;5601.4958653721105;5645.266115404992;5503.3395992480955;5535.81690527946;5572.5263352615075;5589.8602534936645;5601.691906945116;4354.586314300144;4383.539728328527;4383.583559561836;4397.714148580332;4399.318105693606;4290.742555446667;4349.608125399874;4361.825526978917;4373.759443230637;4379.75911324877;4280.507741609724;4307.6123148916595;4308.74147551148;4326.502452217988;4330.675199360045;4307.117041006586;4307.1601037797645;4328.761918094504;4333.458317710286;4337.566243375669;3716.5168528091176;3825.158465137693;3825.387937929918;3831.9616803832164;3840.3855383138844;5462.453754624546;5468.781248750045;5478.945210547883;5480.287562616874;5487.64330318528;4983.234304960745;4987.852793857397;4998.425181104183;5011.2483127530795;5060.898782024339;5567.55459563238;5731.398203188647;5905.793297234619;5910.615809972338;5934.940650593482;4222.3244280914905;4222.641075508585;4223.493180818322;4226.344916537942;4233.491980962304;5998.40015998401;6050.515958723336;6054.909176362358;6078.240219972504;6112.266528016622;4244.893877653021;4331.848385306499;4350.71720338177;4355.891102722394;4357.629601483846;4383.693141480129;4387.802548885308;4389.648828093745;4403.163398954189;4427.867163985085;4952.217201807346;5027.899442011212;5028.723420211851;5032.421271553818;5051.26756620288;5658.292713410824;5850.391142435864;5854.560907931922;5864.67744274069;5895.67573783446;1440.6974535347485;1469.434267806902;1475.159159279222;1476.2028504607392;1484.9183294918882;1004.437514991607;1017.5319353097658;1024.99487502562;1028.6759670703705;1048.727330893973;5476.288082549323;5500.889982200333;5501.202325662756;5521.171824226398;5533.557315414838;5798.9130163047585;5821.27234095738;5866.442687944638;5869.236999190078;5891.617044892068;5387.9461205388225;5491.697956612425;5501.202325662756;5695.86082783445;5737.51231145349;3103.2552187474844;3114.345987342683;3134.9373012540077;3144.905652830373;3151.196444906534;6008.188894499187;6069.544784141207;6076.665783381868;6106.419890110433;6130.662813545208;6194.389458740759;6224.346443623445;6234.501239900797;6239.438450539383;6243.469305109116;6342.334054924258;6343.302236753953;6365.2998170201245;6366.6180029198395;6398.872022559616;5941.970290148694;6033.42682445167;6069.332373439007;6072.512234502575;6076.665783381956;6002.789902353396;6016.21789167423;6017.428344307284;6019.247594050744;6029;6099.695015249308;6257.499400047895;6336;6346.270178929482;6347.841303967438;4333.913321733611;4344.1528901865095;4344.6089851913475;4359.04101097758;4366.737995720267;5929.762809487572;6061;6073.726682299395;6101;6155.753769849156;5924.31870334917;5930.822075337746;5936.673482958478;5946.791862284799;5949.137375080676;5928.584999050025;5949.881002380015;5974.372690867396;5983.401659834156;5990.31111422192;5706.372299047184;5826.621269617631;5868.794592189253;5877.706114694333;5885.970570147293;5944.791932282349;5966.701664916824;5967.91048134287;5970.820875373745;5994.310654274815;5687.1753595729215;5799.4780469757925;5823.621464604787;5843.883122337615;5843.970780146072 09:00:03 INFO - PROCESS | 29523 | |5;yui.html;747.3722073458297;770.3836930455634;785.9646315915783;831.0941074229089;895.6417433026788;12945.870541294584;13174;13212.14121082129;13370.264635445046;13383.79924301135;13528.661783455418;13547.18716876988;13634.454621815115;14384.1369517829;14525.201113938729;824.7031068815222;843.7131375332385;847.8092429203441;848.1899785704668;849.1508491508491;814.2020819596798;828.1883753921161;854.9145085491432;855.5123579559654;858.0604238358987;886.4769785826361;888.5557221389305;892.205936716323;892.5715656484891;892.937494375394;878.3236907581127;882.805782727802;885.4156256870499;886.0430734806394;886.246690313235;640.4940097323156;645.9741610335628;646.8512242184324;648.0764910003273;649.1787888321277;14161.22113283769;14182.219977901212;14208.644783880485;14216.50242241527;14301.141931484144;13200.405981730844;13823;14118.858811411857;14199.532276403726;14471.42114315426;10603.46982650872;11190.496427660693;11302.378369189692;11551.364674942875;11634.301941883514;3807.0862992881785;3813.656770890633;3836.8848934532007;3850.576436592001;3871.632194941476;62004.37995620076;62293.37706622921;62933.37066629321;63989.3601063988;63995;10739.731506712395;11119.610813621484;11191.440427978569;11235.382053986945;11310;20180.29368972079;20327.18691252363;20351.185952562028;20608.27871024507;20814.37556873296;7789.86136687393;8273.793155171168;8328.375371847014;8340.708075217339;8407.579621018924;4785.665003449725;4801.615870730333;4839.540243676845;4871.878203044952;4917.557419832232;3296.571445712042;3356.8992930212135;3373.2916087621384;3381.1040074380307;3397.303552771676;634.6667999300312;644.4715333426545;650.9283978762332;663.9070530125787;670.7451168555917;690.7237105157876;711.6797441151502;714.0752725220851;715.8389362393419;721.5778769419843;9905.504724763732;9911.80176396468;9917.900820991843;9963.701088967342;9979.251556133318;728.8375041808307;735.8307589254501;751.597895126105;761.1285078584989;778.1090651204453;4328.437303150633;4434.1178234148065;4616.515265897099;4643.976780116078;4690.108879312919;88324.55837720771;90067;91071.54464227769;92434;94400.52799735958;45310.32034519485;52955.735221323645;62321;63093.05360419597;80152.59923700462;65173.67413162999;66332;66685.66657166684;67105.32894671186;67777.32222677808;10096.139447123174;10299.948500257451;10321.48392580383;10559;10575.524101415302;32563.02310930676;41219.1756164869;45013.77493112513;45689.77155114203;49303;55243.72378138084;60269.39730602638;62240.06639900496;63681.36318636754;65508.344916550224;12180.57367992116;12278.201916875374;12404.75190496167;12437.62687119388;12784.232946023269;13888.513902013381;13975.510857119953;14077.436902523785;14138.929305353407;14576.052556583789;13331.417187825193;13335.466581336637;13344.733105337644;13705.109167904453;14073.296335182995;12198.695032624255;12667.176633518791;13080.672983175116;13669.316534173053;13780.862191377957;13356.198628082346;13371.866281337063;13409.32953352348;13798.793018104938;13834;10413.061693994146;11088.611898583833;11093.50079246452;11131.165162612675;11566.826497602711;10540.10409115203;10545.894541054491;10681.626143084955;10738.570457181626;10776.407297598707 09:00:03 INFO - PROCESS | 29523 | __end_tp_report 09:00:03 INFO - PROCESS | 29523 | __start_cc_report 09:00:03 INFO - PROCESS | 29523 | _x_x_mozilla_cycle_collect,305 09:00:03 INFO - PROCESS | 29523 | __end_cc_report 09:00:03 INFO - PROCESS | 29523 | __startTimestamp1487955603750__endTimestamp 09:00:03 INFO - PROCESS | 29523 | 09:00:03 INFO - PROCESS | 29523 | ------- Summary: start ------- 09:00:03 INFO - PROCESS | 29523 | Number of tests: 6 09:00:03 INFO - PROCESS | 29523 | 09:00:03 INFO - PROCESS | 29523 | [#0] dojo.html Cycles:165 Average:5707.04 Median:5953.26 stddev:663.35 (11.1%) stddev-sans-first:635.81 09:00:03 INFO - PROCESS | 29523 | Values: 3210.5 3227.8 3233.7 3241.6 3259.7 5581.9 5665.9 5671.1 5700.3 5712.3 5635.8 5682.8 5684.4 5690.1 5714.8 5087.5 5096.0 5154.0 5191.4 5201.3 5249.7 5253.3 5253.6 5258.0 5260.6 5117.0 5128.9 5208.1 5229.9 5247.3 5187.1 5195.5 5235.8 5240.5 5343.1 5231.8 5303.3 5323.3 5329.6 5331.8 5810.5 5821.7 5848.3 5883.5 5903.7 5997.5 6038.9 6056.8 6062.8 6092.8 6123.1 6132.7 6135.5 6139.5 6140.7 5783.8 5795.7 5797.9 5804.1 5806.4 6054.6 6059.4 6116.5 6146.8 6350.3 6032.8 6037.2 6040.5 6047.8 6064.4 5984.8 6125.1 6127.9 6133.5 6135.2 5991.6 6023.1 6036.5 6038.5 6119.4 6062.3 6105.5 6122.2 6135.6 6139.1 4664.7 4689.0 4709.2 4728.3 4751.7 4094.3 4127.6 4128.9 4130.4 4194.5 5761.5 5883.0 5893.0 5911.6 5922.5 6177.8 6185.4 6197.4 6200.4 6230.1 5730.9 5783.9 5809.5 5826.1 5856.8 5315.2 5339.7 5344.8 5370.3 5385.0 6387.7 6418.2 6438.4 6466.5 6470.9 6038.9 6090.9 6130.0 6138.7 6187.3 6468.6 6481.9 6491.5 6525.8 6529.7 6106.1 6111.8 6130.1 6148.4 6155.8 5951.3 5975.5 6124.6 6209.4 6228.4 5973.1 6083.5 6088.1 6097.9 6114.7 6025.2 6046.8 6052.3 6066.4 6069.8 5658.2 5669.4 5957.0 6008.3 6023.9 5953.3 6032.5 6046.9 6121.6 6124.2 5932.9 5933.3 5936.1 5948.6 5969.6 09:00:03 INFO - PROCESS | 29523 | 09:00:03 INFO - PROCESS | 29523 | [#1] ext.html Cycles:180 Average:57945.00 Median:3749.62 stddev:105936.55 (2825.3%) stddev-sans-first:106146.15 09:00:03 INFO - PROCESS | 29523 | Values: 571.1 606.3 618.7 640.1 658.3 41144.0 42293.6 43914.3 43986.8 44031.8 44659.8 45062.8 45151.1 45199.8 45384.1 8871.9 10744.8 11108.0 11114.1 11304.3 10863.1 10871.0 10903.7 10921.1 10964.8 10971.6 10980.6 10980.7 11001.1 11040.2 10847.5 10893.5 10917.1 10957.9 10958.8 10736.7 10800.8 10843.7 10854.2 10864.7 42473.0 42574.4 42680.6 43016.8 43036.8 3561.0 3655.6 3692.7 3748.2 3751.1 32216.8 32364.0 32639.0 33057.7 33490.8 4399.6 4532.7 4606.5 4621.3 4629.2 344907.0 346299.0 346443.3 346828.0 348777.0 62917.7 62977.0 63019.7 63081.0 63327.1 65856.7 65874.3 66195.7 66196.7 66474.3 14553.0 14690.8 16376.9 16972.4 16999.7 12328.4 12395.8 12445.6 12582.7 12714.2 20152.7 20180.0 20200.2 20346.3 20500.3 7461.6 7475.0 7487.9 7490.0 7622.2 921.3 978.3 1035.3 1055.6 1056.2 30361.5 31046.5 31526.4 31687.7 31753.7 1043.4 1071.1 1092.4 1094.5 1112.8 16202.1 16391.5 16436.9 16726.9 16789.7 464994.0 468372.0 471492.0 471672.0 473309.0 59436.7 59643.0 59974.4 59981.4 60007.7 1307.2 1308.9 1338.6 1358.6 1359.4 30026.1 30885.8 30886.8 30986.8 31422.0 51106.5 51407.5 51523.5 51680.2 51697.0 379751.0 380396.0 380611.0 380621.0 381112.0 29500.9 45948.3 46459.8 46751.0 47215.3 45770.5 46781.3 47367.8 48875.3 49139.3 41441.6 41488.4 41803.2 42590.1 43362.3 41574.6 42005.2 42625.4 43447.6 43933.8 41191.6 41613.0 42026.2 42487.3 42580.6 35434.0 37048.6 37066.5 37384.8 37841.0 28426.6 28588.7 28896.3 29106.4 29139.0 09:00:03 INFO - PROCESS | 29523 | 09:00:03 INFO - PROCESS | 29523 | [#2] jquery.html Cycles:180 Average:27180.76 Median:441879.50 stddev:72653.22 (16.4%) stddev-sans-first:72829.24 09:00:03 INFO - PROCESS | 29523 | Values: 419.4 422.6 424.6 427.4 443.3 18127.8 19317.9 19680.9 20052.3 20319.2 19436.2 19643.0 19877.9 19890.0 20303.7 5661.5 5946.8 5949.9 5953.0 5959.6 4190.7 5126.3 5826.6 5940.8 6556.5 6584.3 6588.3 6590.9 6600.0 6606.9 5981.0 6000.7 6005.9 6011.8 6593.1 5801.9 5836.4 5839.9 5841.5 5844.7 14043.6 14446.2 14585.6 14661.3 14741.4 2398.1 2451.0 2876.6 3064.6 3106.1 10390.3 10814.9 10859.5 10984.2 10988.5 1949.9 1980.6 2001.9 2021.4 2071.3 76831.6 80784.6 81708.0 82610.2 84418.6 11193.2 11375.3 11521.1 11645.9 11667.1 16381.5 16390.8 16398.3 16407.8 16416.3 7681.5 7980.9 8081.5 8185.3 8192.8 7550.2 7560.8 7728.2 7746.4 7809.0 4860.4 4946.9 5000.6 5004.0 5091.3 2016.8 2061.9 2089.3 2102.1 2160.8 965.3 966.2 989.2 1024.6 1035.8 17929.7 19042.0 19176.5 19258.5 19576.8 965.3 971.1 973.2 984.0 1000.5 10265.6 10803.2 10846.9 10888.9 10942.3 432668.0 436363.0 441077.0 441421.0 442338.0 86951.0 87395.6 88526.6 88791.6 89656.6 987.8 1026.5 1064.2 1082.5 1085.4 16840.3 17021.9 17094.3 17714.1 17998.1 39005.2 40072.6 41435.6 42716.6 43502.6 58764.4 60073.1 60104.0 60250.4 60872.0 5580.7 6570.8 8394.0 8761.5 8944.5 9336.5 9372.9 9629.2 9781.0 9978.6 8492.7 8995.4 9045.4 9097.7 9135.0 8853.9 8912.6 9067.9 9113.7 9249.6 8314.7 8580.5 8792.1 9068.3 9449.6 12087.1 12566.2 12583.4 12602.6 12762.0 11467.7 11585.4 11601.1 11746.5 11846.7 09:00:03 INFO - PROCESS | 29523 | 09:00:03 INFO - PROCESS | 29523 | [#3] mootools.html Cycles:180 Average:5918.74 Median:4983.82 stddev:3332.44 (66.9%) stddev-sans-first:3323.92 09:00:03 INFO - PROCESS | 29523 | Values: 1327.3 1380.2 1432.8 1517.9 1528.4 8649.6 8923.9 9211.0 9232.5 9254.0 9091.8 9335.2 9350.6 9353.4 9380.5 2459.7 2491.0 2493.1 2495.4 2499.4 2375.2 2466.3 2484.0 2487.1 2489.2 2448.3 2480.2 2480.6 2484.8 2493.3 2360.5 2366.3 2377.9 2378.8 2383.9 2320.7 2380.7 2396.1 2399.9 2405.3 8865.7 8890.5 8953.4 8956.9 8966.4 5387.1 5522.1 5541.6 5553.8 5555.9 3464.2 3557.9 3591.6 3593.2 3597.9 1153.8 1161.4 1189.0 1191.7 1233.3 12641.6 12701.2 12810.6 12862.1 12863.9 4524.0 4707.1 4815.7 4819.3 4833.5 9995.5 10017.8 10060.8 10065.2 10090.9 5503.0 5505.7 5505.9 5510.6 5512.2 4955.2 5092.6 5146.2 5160.8 5186.8 3961.1 4072.1 4074.4 4128.6 4150.9 1277.5 1284.9 1284.9 1287.0 1292.4 771.7 785.4 860.7 871.6 900.3 5793.2 6020.6 6108.8 6124.7 6259.7 930.7 962.5 990.4 1010.5 1023.6 3967.6 4102.7 4256.9 4269.4 4317.2 10825.5 10851.3 11022.7 11030.9 11380.7 10498.2 10915.2 10940.7 10950.9 10951.5 8476.3 8647.2 8673.6 8738.0 8758.6 5940.3 6089.2 6132.6 6165.9 6207.5 9652.4 10147.2 10220.7 10250.9 10304.3 10110.3 10315.7 10337.5 10396.5 10493.1 7526.9 7613.0 7681.3 7854.4 7868.6 8275.3 8404.6 8406.9 8415.4 8432.4 7674.6 7701.3 7719.7 7866.2 7899.2 7585.1 7599.2 7633.0 7748.3 7816.7 7196.8 7229.4 7278.2 7302.1 7309.5 5012.4 5088.8 5101.7 5192.5 5225.6 5140.5 5208.3 5243.3 5350.9 5521.5 09:00:03 INFO - PROCESS | 29523 | 09:00:03 INFO - PROCESS | 29523 | [#4] prototype.html Cycles:180 Average:4952.64 Median:5551.23 stddev:1461.18 (26.3%) stddev-sans-first:1423.84 09:00:03 INFO - PROCESS | 29523 | Values: 348.7 355.6 359.3 362.9 365.8 5530.9 5566.6 5595.5 5601.5 5645.3 5503.3 5535.8 5572.5 5589.9 5601.7 4354.6 4383.5 4383.6 4397.7 4399.3 4290.7 4349.6 4361.8 4373.8 4379.8 4280.5 4307.6 4308.7 4326.5 4330.7 4307.1 4307.2 4328.8 4333.5 4337.6 3716.5 3825.2 3825.4 3832.0 3840.4 5462.5 5468.8 5478.9 5480.3 5487.6 4983.2 4987.9 4998.4 5011.2 5060.9 5567.6 5731.4 5905.8 5910.6 5934.9 4222.3 4222.6 4223.5 4226.3 4233.5 5998.4 6050.5 6054.9 6078.2 6112.3 4244.9 4331.8 4350.7 4355.9 4357.6 4383.7 4387.8 4389.6 4403.2 4427.9 4952.2 5027.9 5028.7 5032.4 5051.3 5658.3 5850.4 5854.6 5864.7 5895.7 1440.7 1469.4 1475.2 1476.2 1484.9 1004.4 1017.5 1025.0 1028.7 1048.7 5476.3 5500.9 5501.2 5521.2 5533.6 5798.9 5821.3 5866.4 5869.2 5891.6 5387.9 5491.7 5501.2 5695.9 5737.5 3103.3 3114.3 3134.9 3144.9 3151.2 6008.2 6069.5 6076.7 6106.4 6130.7 6194.4 6224.3 6234.5 6239.4 6243.5 6342.3 6343.3 6365.3 6366.6 6398.9 5942.0 6033.4 6069.3 6072.5 6076.7 6002.8 6016.2 6017.4 6019.2 6029.0 6099.7 6257.5 6336.0 6346.3 6347.8 4333.9 4344.2 4344.6 4359.0 4366.7 5929.8 6061.0 6073.7 6101.0 6155.8 5924.3 5930.8 5936.7 5946.8 5949.1 5928.6 5949.9 5974.4 5983.4 5990.3 5706.4 5826.6 5868.8 5877.7 5886.0 5944.8 5966.7 5967.9 5970.8 5994.3 5687.2 5799.5 5823.6 5843.9 5844.0 09:00:03 INFO - PROCESS | 29523 | 09:00:03 INFO - PROCESS | 29523 | [#5] yui.html Cycles:180 Average:17349.39 Median:45500.05 stddev:22605.89 (49.7%) stddev-sans-first:22634.93 09:00:03 INFO - PROCESS | 29523 | Values: 747.4 770.4 786.0 831.1 895.6 12945.9 13174.0 13212.1 13370.3 13383.8 13528.7 13547.2 13634.5 14384.1 14525.2 824.7 843.7 847.8 848.2 849.2 814.2 828.2 854.9 855.5 858.1 886.5 888.6 892.2 892.6 892.9 878.3 882.8 885.4 886.0 886.2 640.5 646.0 646.9 648.1 649.2 14161.2 14182.2 14208.6 14216.5 14301.1 13200.4 13823.0 14118.9 14199.5 14471.4 10603.5 11190.5 11302.4 11551.4 11634.3 3807.1 3813.7 3836.9 3850.6 3871.6 62004.4 62293.4 62933.4 63989.4 63995.0 10739.7 11119.6 11191.4 11235.4 11310.0 20180.3 20327.2 20351.2 20608.3 20814.4 7789.9 8273.8 8328.4 8340.7 8407.6 4785.7 4801.6 4839.5 4871.9 4917.6 3296.6 3356.9 3373.3 3381.1 3397.3 634.7 644.5 650.9 663.9 670.7 690.7 711.7 714.1 715.8 721.6 9905.5 9911.8 9917.9 9963.7 9979.3 728.8 735.8 751.6 761.1 778.1 4328.4 4434.1 4616.5 4644.0 4690.1 88324.6 90067.0 91071.5 92434.0 94400.5 45310.3 52955.7 62321.0 63093.1 80152.6 65173.7 66332.0 66685.7 67105.3 67777.3 10096.1 10299.9 10321.5 10559.0 10575.5 32563.0 41219.2 45013.8 45689.8 49303.0 55243.7 60269.4 62240.1 63681.4 65508.3 12180.6 12278.2 12404.8 12437.6 12784.2 13888.5 13975.5 14077.4 14138.9 14576.1 13331.4 13335.5 13344.7 13705.1 14073.3 12198.7 12667.2 13080.7 13669.3 13780.9 13356.2 13371.9 13409.3 13798.8 13834.0 10413.1 11088.6 11093.5 11131.2 11566.8 10540.1 10545.9 10681.6 10738.6 10776.4 09:00:03 INFO - PROCESS | 29523 | -------- Summary: end -------- 09:00:03 INFO - PROCESS | 29523 | 09:00:04 INFO - TEST-INFO | 29523: exit 0 09:00:04 INFO - TEST-OK | dromaeo_css | took 1112410ms 09:00:04 INFO - TEST-START | kraken 09:00:04 INFO - operating with platform_type : linux_ 09:00:04 INFO - Initialising browser for kraken test... 09:00:04 INFO - TEST-INFO | started process 29881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPJGt_9/profile http://localhost:53072/getInfo.html) 09:00:08 INFO - PROCESS | 29881 | __metrics Screen width/height:1600/1200 09:00:08 INFO - PROCESS | 29881 | colorDepth:24 09:00:08 INFO - PROCESS | 29881 | Browser inner width/height: 1024/697 09:00:08 INFO - PROCESS | 29881 | __metrics 09:00:09 ERROR - PROCESS | 29881 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 09:00:10 INFO - TEST-INFO | 29881: exit 0 09:00:10 INFO - Browser initialized. 09:00:10 INFO - Running cycle 1/1 for kraken test... 09:00:10 INFO - TEST-INFO | started process 30013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPJGt_9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:22 INFO - PROCESS | 30013 | RSS: Main: 147128320 09:00:22 INFO - PROCESS | 30013 | 09:00:24 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:53072/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53072/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:25 INFO - PROCESS | 30013 | RSS: Main: 153939968 09:00:25 INFO - PROCESS | 30013 | 09:00:28 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:53072/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53072/tests/kraken/driver.html?testName=audio-dft) 09:00:28 INFO - PROCESS | 30013 | RSS: Main: 152793088 09:00:28 INFO - PROCESS | 30013 | 09:00:31 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:53072/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53072/tests/kraken/driver.html?testName=audio-fft) 09:00:32 INFO - PROCESS | 30013 | RSS: Main: 153038848 09:00:32 INFO - PROCESS | 30013 | 09:00:34 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:53072/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53072/tests/kraken/driver.html?testName=audio-oscillator) 09:00:34 INFO - PROCESS | 30013 | RSS: Main: 152879104 09:00:34 INFO - PROCESS | 30013 | 09:00:36 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:53072/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53072/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:37 INFO - PROCESS | 30013 | RSS: Main: 153038848 09:00:37 INFO - PROCESS | 30013 | 09:00:40 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:53072/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53072/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:41 INFO - PROCESS | 30013 | RSS: Main: 154603520 09:00:41 INFO - PROCESS | 30013 | 09:00:44 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:53072/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53072/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:45 INFO - PROCESS | 30013 | RSS: Main: 155521024 09:00:45 INFO - PROCESS | 30013 | 09:00:47 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:53072/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53072/tests/kraken/driver.html?testName=json-parse-financial) 09:00:48 INFO - PROCESS | 30013 | RSS: Main: 155148288 09:00:48 INFO - PROCESS | 30013 | 09:00:49 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:53072/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53072/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:00:50 INFO - PROCESS | 30013 | RSS: Main: 154243072 09:00:50 INFO - PROCESS | 30013 | 09:00:52 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:53072/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53072/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:00:52 INFO - PROCESS | 30013 | RSS: Main: 154492928 09:00:52 INFO - PROCESS | 30013 | 09:00:54 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:53072/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53072/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:00:55 INFO - PROCESS | 30013 | RSS: Main: 154832896 09:00:55 INFO - PROCESS | 30013 | 09:00:58 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:53072/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53072/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:00:58 INFO - PROCESS | 30013 | RSS: Main: 155136000 09:00:58 INFO - PROCESS | 30013 | 09:01:01 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:53072/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53072/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:01:02 INFO - PROCESS | 30013 | RSS: Main: 154988544 09:01:02 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:53072/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53072/tests/kraken/driver.html?testName=ai-astar) 09:01:03 INFO - PROCESS | 30013 | RSS: Main: 156835840 09:01:03 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | __start_tp_report 09:01:03 INFO - PROCESS | 30013 | _x_x_mozilla_page_load 09:01:03 INFO - PROCESS | 30013 | _x_x_mozilla_page_load_details 09:01:03 INFO - PROCESS | 30013 | |i|pagename|runs| 09:01:03 INFO - PROCESS | 30013 | |0;ai-astar;101;112;112;110;109;110;111;109;110;110 09:01:03 INFO - PROCESS | 30013 | |1;audio-beat-detection;144;118;120;158;119;120;119;123;145;122 09:01:03 INFO - PROCESS | 30013 | |2;audio-dft;164;163;169;163;161;162;161;161;162;161 09:01:03 INFO - PROCESS | 30013 | |3;audio-fft;74;75;75;113;76;74;75;77;102;78 09:01:03 INFO - PROCESS | 30013 | |4;audio-oscillator;82;81;112;81;82;83;99;82;83;112 09:01:03 INFO - PROCESS | 30013 | |5;imaging-gaussian-blur;117;117;117;117;118;118;117;118;117;117 09:01:03 INFO - PROCESS | 30013 | |6;imaging-darkroom;147;146;148;147;146;146;147;147;148;147 09:01:03 INFO - PROCESS | 30013 | |7;imaging-desaturate;85;85;85;85;87;87;85;85;85;85 09:01:03 INFO - PROCESS | 30013 | |8;json-parse-financial;55;55;57;57;54;56;55;56;55;54 09:01:03 INFO - PROCESS | 30013 | |9;json-stringify-tinderbox;60;59;60;59;60;60;60;60;60;61 09:01:03 INFO - PROCESS | 30013 | |10;stanford-crypto-aes;75;75;75;75;75;80;75;78;73;73 09:01:03 INFO - PROCESS | 30013 | |11;stanford-crypto-ccm;124;121;133;123;122;130;122;121;160;122 09:01:03 INFO - PROCESS | 30013 | |12;stanford-crypto-pbkdf2;167;157;158;157;156;165;157;158;158;156 09:01:03 INFO - PROCESS | 30013 | |13;stanford-crypto-sha256-iterative;63;64;63;69;63;65;63;63;63;62 09:01:03 INFO - PROCESS | 30013 | __end_tp_report 09:01:03 INFO - PROCESS | 30013 | __start_cc_report 09:01:03 INFO - PROCESS | 30013 | _x_x_mozilla_cycle_collect,791 09:01:03 INFO - PROCESS | 30013 | __end_cc_report 09:01:03 INFO - PROCESS | 30013 | __startTimestamp1487955663972__endTimestamp 09:01:03 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | ------- Summary: start ------- 09:01:03 INFO - PROCESS | 30013 | Number of tests: 14 09:01:03 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:3.13 (2.8%) stddev-sans-first:1.12 09:01:03 INFO - PROCESS | 30013 | Values: 101.0 112.0 112.0 110.0 109.0 110.0 111.0 109.0 110.0 110.0 09:01:03 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | [#1] audio-beat-detection Cycles:10 Average:128.80 Median:122.50 stddev:14.49 (11.8%) stddev-sans-first:14.29 09:01:03 INFO - PROCESS | 30013 | Values: 144.0 118.0 120.0 158.0 119.0 120.0 119.0 123.0 145.0 122.0 09:01:03 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:2.45 (1.5%) stddev-sans-first:2.55 09:01:03 INFO - PROCESS | 30013 | Values: 164.0 163.0 169.0 163.0 161.0 162.0 161.0 161.0 162.0 161.0 09:01:03 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:13.80 (18.4%) stddev-sans-first:14.33 09:01:03 INFO - PROCESS | 30013 | Values: 74.0 75.0 75.0 113.0 76.0 74.0 75.0 77.0 102.0 78.0 09:01:03 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:82.00 stddev:12.91 (15.7%) stddev-sans-first:13.39 09:01:03 INFO - PROCESS | 30013 | Values: 82.0 81.0 112.0 81.0 82.0 83.0 99.0 82.0 83.0 112.0 09:01:03 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:01:03 INFO - PROCESS | 30013 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 117.0 09:01:03 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 09:01:03 INFO - PROCESS | 30013 | Values: 147.0 146.0 148.0 147.0 146.0 146.0 147.0 147.0 148.0 147.0 09:01:03 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.00 stddev:0.84 (1.0%) stddev-sans-first:0.88 09:01:03 INFO - PROCESS | 30013 | Values: 85.0 85.0 85.0 85.0 87.0 87.0 85.0 85.0 85.0 85.0 09:01:03 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:1.07 (1.9%) stddev-sans-first:1.13 09:01:03 INFO - PROCESS | 30013 | Values: 55.0 55.0 57.0 57.0 54.0 56.0 55.0 56.0 55.0 54.0 09:01:03 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:01:03 INFO - PROCESS | 30013 | Values: 60.0 59.0 60.0 59.0 60.0 60.0 60.0 60.0 60.0 61.0 09:01:03 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.00 stddev:2.12 (2.8%) stddev-sans-first:2.24 09:01:03 INFO - PROCESS | 30013 | Values: 75.0 75.0 75.0 75.0 75.0 80.0 75.0 78.0 73.0 73.0 09:01:03 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:123.50 stddev:12.02 (9.7%) stddev-sans-first:12.67 09:01:03 INFO - PROCESS | 30013 | Values: 124.0 121.0 133.0 123.0 122.0 130.0 122.0 121.0 160.0 122.0 09:01:03 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.90 Median:158.00 stddev:3.84 (2.4%) stddev-sans-first:2.74 09:01:03 INFO - PROCESS | 30013 | Values: 167.0 157.0 158.0 157.0 156.0 165.0 157.0 158.0 158.0 156.0 09:01:03 INFO - PROCESS | 30013 | 09:01:03 INFO - PROCESS | 30013 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.00 stddev:1.99 (3.2%) stddev-sans-first:2.09 09:01:03 INFO - PROCESS | 30013 | Values: 63.0 64.0 63.0 69.0 63.0 65.0 63.0 63.0 63.0 62.0 09:01:03 INFO - PROCESS | 30013 | -------- Summary: end -------- 09:01:03 INFO - PROCESS | 30013 | 09:01:04 INFO - TEST-INFO | 30013: exit 0 09:01:04 INFO - TEST-OK | kraken | took 60391ms 09:01:04 INFO - SUITE-END | took 1172s 09:01:05 INFO - Completed test suite (00:19:33) 09:01:05 INFO - javascript benchmark 09:01:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7403.340471593181, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3210.5184222366643, 3227.7579181561373, 3233.6927991840766, 3241.594800649919, 3259.669336424456, 5581.944180558193, 5665.943340566593, 5671.06427439472, 5700.344460387047, 5712.343080545738, 5635.802746903859, 5682.772689092431, 5684.403137670547, 5690.118031705082, 5714.828555143342, 5087.5421212090905, 5096.0, 5154.046501397253, 5191.351081114861, 5201.323827902367, 5249.737513124348, 5253.343332083489, 5253.553447956928, 5258.0, 5260.579153667697, 5116.97660467906, 5128.948710512885, 5208.0885844977165, 5229.921551176735, 5247.291615631898, 5187.144121219994, 5195.454477279869, 5235.816746413876, 5240.52835244826, 5343.118385466432, 5231.8168864089575, 5303.257543943851, 5323.334583177103, 5329.600279979017, 5331.786728530854, 5810.506106980912, 5821.708914554298, 5848.298204215479, 5883.470487656132, 5903.734331955073, 5997.460228579449, 6038.909416358758, 6056.757729690807, 6062.818115456544, 6092.786752463642, 6123.050927106306, 6132.724027418777, 6135.478484328837, 6139.539534534883, 6140.692965351759, 5783.797567085132, 5795.652260864362, 5797.855053623609, 5804.100364443518, 5806.419358064202, 6054.606450580698, 6059.394060593993, 6116.510679145657, 6146.815595532141, 6350.269718982284, 6032.788852390146, 6037.154798328237, 6040.456358927718, 6047.818565443044, 6064.393560643988, 5984.820455386345, 6125.081237814364, 6127.908081378783, 6133.509319254449, 6135.202423684892, 5991.58058935879, 6023.1266466363, 6036.486898613579, 6038.516918646497, 6119.388061193845, 6062.333143354227, 6105.48103411215, 6122.20411346531, 6135.601185922901, 6139.079138129317, 4664.720116792935, 4688.97655511727, 4709.152352576501, 4728.338032675429, 4751.667383283137, 4094.28350038742, 4127.6491498222385, 4128.855490057834, 4130.421740956269, 4194.538600753915, 5761.510271626875, 5883.02930016551, 5893.02765043763, 5911.586188966817, 5922.526197904243, 6177.7837775677635, 6185.443310102112, 6197.380261973857, 6200.3799620037635, 6230.065490176419, 5730.885382292414, 5783.855403614859, 5809.535237181015, 5826.126081087871, 5856.799356131983, 5315.229291752674, 5339.7063161526485, 5344.839654810362, 5370.3287089113865, 5385.030694474954, 6387.680615969276, 6418.19772528434, 6438.356164383524, 6466.450351720063, 6470.870582588322, 6038.9396106038375, 6090.878182436415, 6130.049842274276, 6138.725610151984, 6187.319394866651, 6468.579542329921, 6481.8703625928165, 6491.545591808528, 6525.804225873231, 6529.7061632227615, 6106.053561697944, 6111.847203819762, 6130.141780150871, 6148.385161483816, 6155.815325540241, 5951.28584569837, 5975.521958243417, 6124.5712800103565, 6209.379062093754, 6228.439440450381, 5973.133895585029, 6083.543734219863, 6088.147659327787, 6097.939020609737, 6114.6942652868065, 6025.246844144482, 6046.758129674764, 6052.334243233329, 6066.393360663898, 6069.848253793691, 5658.17956396312, 5669.4047125051275, 5957.0, 6008.309044459943, 6023.909641355471, 5953.255843019622, 6032.517398608013, 6046.939530604814, 6121.6054024712375, 6124.167343420691, 5932.911006334994, 5933.317668468008, 5936.1095835625, 5948.613340132878, 5969.582129250911], "value": 5660.550511839533, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.1404336473606, 606.3390903914732, 618.7432215630514, 640.1166390381273, 658.3054877104653, 41144.0, 42293.57706422935, 43914.34128488075, 43986.7800660997, 44031.779841100826, 44659.77670111653, 45062.774686126606, 45151.0969780605, 45199.774001130034, 45384.09231815362, 8871.86692199616, 10744.78510429791, 11108.0, 11114.11087113029, 11304.265222760536, 10863.130949524018, 10871.0, 10903.672889813319, 10921.12630989519, 10964.780704385908, 10971.615993440231, 10980.560777568928, 10980.670579882617, 11001.064909482704, 11040.171987100959, 10847.51186196623, 10893.509792059376, 10917.072048875816, 10957.890421095806, 10958.835617465744, 10736.677899663022, 10800.837987430195, 10843.67468975924, 10854.24020318578, 10864.674059778219, 42473.0, 42574.361384578944, 42680.57319426797, 43016.784916075216, 43036.78481607603, 3560.9821950890077, 3655.597884232732, 3692.7045836333027, 3748.1566647504364, 3751.0809851586264, 32216.838915805507, 32364.0, 32639.0, 33057.6694233057, 33490.83254583736, 4399.6480281577715, 4532.682712210147, 4606.5393460654, 4621.3299071634765, 4629.189891768927, 344907.0, 346299.0, 346443.267783662, 346828.0, 348777.0, 62917.685411572646, 62977.0, 63019.68490157612, 63081.0, 63327.050094248625, 65856.67071664611, 65874.34125658778, 66195.66902165458, 66196.66901665558, 66474.33525664778, 14553.0, 14690.779638305434, 16376.918115409348, 16972.405965791386, 16999.74500382495, 12328.445219965122, 12395.814062789066, 12445.564405245774, 12582.748345033231, 12714.173578717538, 20152.69770953437, 20180.0, 20200.191992320437, 20346.287879924428, 20500.282490112775, 7461.552306861606, 7474.962625186948, 7487.8502429951095, 7489.962550187214, 7622.237776222333, 921.2767977138049, 978.2711879649706, 1035.3382820573022, 1055.6305293147336, 1056.1920131099714, 30361.544576831366, 31046.534301985488, 31526.36947261042, 31687.683123168936, 31753.682463175533, 1043.3531210649446, 1071.0574694269148, 1092.3773449134076, 1094.480121942087, 1112.777444511101, 16202.108884011257, 16391.508254752378, 16436.917815410845, 16726.916365418096, 16789.656827453775, 464994.0, 468372.0, 471492.0, 471672.0, 473309.0, 59436.70281648564, 59643.0, 59974.40025599688, 59981.40018599846, 60007.69996150079, 1307.1568838099372, 1308.8560258371572, 1338.618493729302, 1358.599213232099, 1359.4494229836932, 30026.099217023526, 30885.845570772002, 30886.76452941857, 30986.845065774527, 31422.0, 51106.488935110174, 51407.45777626677, 51523.48476515187, 51680.224796628834, 51697.0, 379751.0, 380396.0, 380611.0, 380621.0, 381112.0, 29500.852495737385, 45948.310775339065, 46459.767701161276, 46751.0, 47215.29177062416, 45770.54229457796, 46781.29828052514, 47367.76316118535, 48875.26687099625, 49139.262911055645, 41441.58558414377, 41488.377674334304, 41803.163936720484, 42590.14819703527, 43362.349564755925, 41574.584254157075, 42005.159896801284, 42625.36061959135, 43447.565524344354, 43933.78033109814, 41191.588084118775, 41613.0, 42026.159476810906, 42487.30050798057, 42580.5741942589, 35434.0, 37048.62951370559, 37066.54404782083, 37384.81307593445, 37841.0, 28426.57360139641, 28588.714112858604, 28896.2775930595, 29106.417871642872, 29139.0], "value": 20995.95648203397, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.39397570510613, 422.58586585146554, 424.57542457542456, 427.3589615576636, 443.32171777180906, 18127.81872181278, 19317.903410482962, 19680.90159549202, 20052.298169564066, 20319.18723251068, 19436.222551097973, 19643.0, 19877.900610496963, 19890.0, 20303.695444568344, 5661.490465858072, 5946.821595352147, 5949.940500595004, 5953.047512398017, 5959.612625179371, 4190.664746820247, 5126.307948426952, 5826.563007774413, 5940.821775346746, 6556.541042127053, 6584.341565843401, 6588.308227636101, 6590.93409065908, 6600.042993765901, 6606.900896486556, 5981.043033114703, 6000.669963152047, 6005.939940600625, 6011.819645410645, 6593.109930159415, 5801.8549536261935, 5836.416358364172, 5839.941600583982, 5841.532677385799, 5844.678542680151, 14043.64890877726, 14446.205458699767, 14585.562433127023, 14661.340239689132, 14741.410343586243, 2398.052769156191, 2450.987745061281, 2876.6116574262624, 3064.5709600655928, 3106.0526539405473, 10390.324628899098, 10814.891851081467, 10859.511321990529, 10984.176186786022, 10988.505517251742, 1949.9415017549495, 1980.6236815005102, 2001.949951251216, 2021.3935819254166, 2071.275053731197, 76831.615841921, 80784.59607701983, 81708.0, 82610.17389826085, 84418.57790711007, 11193.216474846682, 11375.293705944174, 11521.135914806424, 11645.941770291094, 11667.124965627612, 16381.508554743377, 16390.754138687927, 16398.26207820651, 16407.753883691756, 16416.261268242957, 7681.462297639112, 7980.880286795703, 8081.515109093356, 8185.3451723861945, 8192.795180120545, 7550.244975502405, 7560.848783024308, 7728.188540203198, 7746.38028957682, 7808.960955195188, 4860.441049279378, 4946.901061978812, 5000.574951129195, 5004.049230646166, 5091.3126727892, 2016.757989041295, 2061.9278325258842, 2089.2583132987875, 2102.10660469303, 2160.79472450117, 965.3435663748718, 966.2028826218258, 989.2135752077116, 1024.6208902705898, 1035.8239099353127, 17929.7310540342, 19042.0, 19176.520586985436, 19258.518537036685, 19576.804231957783, 965.2567523007245, 971.0580736685545, 973.2262851033446, 983.9950800245953, 1000.5047501486811, 10265.640702575374, 10803.189760767973, 10846.891531084588, 10888.891111088788, 10942.343459392461, 432668.0, 436363.0, 441077.0, 441421.0, 442338.0, 86951.0, 87395.56302218576, 88526.55736721405, 88791.55604221938, 89656.55171724099, 987.7925635616457, 1026.4662375564815, 1064.2337516987602, 1082.4858192358568, 1085.4355735017905, 16840.326386944875, 17021.91489042547, 17094.316227350766, 17714.114294284976, 17998.10009499546, 39005.219895602495, 40072.59927400688, 41435.585644144376, 42716.57283427126, 43502.56497434985, 58764.412355875895, 60073.09890351561, 60104.0, 60250.397496026235, 60872.0, 5580.693061881473, 6570.8357291066195, 8394.0, 8761.5181165034, 8944.463332200088, 9336.486493242664, 9372.859407108763, 9629.229661626912, 9781.0, 9978.60085596568, 8492.70275540353, 8995.370324077252, 9045.366824322498, 9097.681581144629, 9134.954325228331, 8853.911460885567, 8912.598933047899, 9067.90932090697, 9113.681021164228, 9249.630014799333, 8314.667413303641, 8580.485170889517, 8792.120787921413, 9068.274538036809, 9449.574769135268, 12087.09346798976, 12566.246025238515, 12583.433745481658, 12602.621921342374, 12762.042846786713, 11467.655970320904, 11585.362805045803, 11601.12991525622, 11746.530138794695, 11846.749117667616], "value": 9064.479200468755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.2633688302994, 1380.2339701465683, 1432.8208973878266, 1517.8861585381098, 1528.403922470236, 8649.610767515462, 8923.91076089239, 9211.0, 9232.492212928286, 9254.0, 9091.818163636723, 9335.206507446876, 9350.62597496101, 9353.438793672385, 9380.484073375961, 2459.7417271186537, 2490.962635560459, 2493.127405408111, 2495.4135778092223, 2499.3751562109474, 2375.2161786610463, 2466.2971053249826, 2484.0312278211513, 2487.067349743846, 2489.166129346671, 2448.338948483917, 2480.193936970483, 2480.60310350344, 2484.776370126688, 2493.2769496845895, 2360.4688944987324, 2366.3374255208482, 2377.9286621401384, 2378.785909268157, 2383.9046438142454, 2320.709911261092, 2380.726216485109, 2396.101461951768, 2399.8560086394696, 2405.314485371678, 8865.68970086044, 8890.466572005636, 8953.418027828171, 8956.8656470153, 8966.372353935227, 5387.0841956867425, 5522.088855338864, 5541.612087153901, 5553.8333849984565, 5555.8888822223325, 3464.1512829356716, 3557.8932632021083, 3591.6408359164134, 3593.1556084320164, 3597.892063238107, 1153.809621412466, 1161.4076820821442, 1189.0309397840733, 1191.6901605582525, 1233.340163012784, 12641.620751377473, 12701.237925724394, 12810.55163069288, 12862.099653024292, 12863.871361286454, 4523.977380113079, 4707.082118986765, 4815.735134567562, 4819.349387832668, 4833.540813622701, 9995.500224988722, 10017.849732254022, 10060.798784024279, 10065.245106617032, 10090.899091008996, 5503.036968530491, 5505.697186654773, 5505.944940550623, 5510.614257001971, 5512.173174023848, 4955.207166853286, 5092.592592592584, 5146.202338637517, 5160.845174644766, 5186.81846135391, 3961.088949541622, 4072.083781149218, 4074.3684728867074, 4128.566500517462, 4150.937735933963, 1277.5145444730942, 1284.9357532123543, 1284.9421776020101, 1286.9871301286867, 1292.3796577642784, 771.733751855609, 785.3520845302648, 860.6901515454431, 871.6252011635058, 900.2662829793697, 5793.24687790593, 6020.608660437058, 6108.816735497942, 6124.693765311717, 6259.6870156492905, 930.6742640075919, 962.4658314635304, 990.3760630802549, 1010.4796030044533, 1023.5956797065118, 3967.563568007517, 4102.651274641629, 4256.936145957813, 4269.380939763779, 4317.179735850178, 10825.512851921683, 10851.294665846695, 11022.724431889266, 11030.944845275882, 11380.658580242605, 10498.212634052325, 10915.181361397768, 10940.726481838017, 10950.945245273882, 10951.507182176822, 8476.321894248445, 8647.178518040777, 8673.566321683891, 8737.956310218407, 8758.56207189638, 5940.257467816523, 6089.208402907594, 6132.63204207749, 6165.876682466236, 6207.503399728102, 9652.420854748738, 10147.238957078102, 10220.744481388025, 10250.923653016325, 10304.330218535772, 10110.342827716175, 10315.690529284133, 10337.534810933375, 10396.532156052845, 10493.055624993787, 7526.924730752841, 7613.0, 7681.347085497795, 7854.371650267851, 7868.645910934136, 8275.255227029596, 8404.621792019496, 8406.907102076691, 8415.4109212357, 8432.409731318749, 7674.577898215429, 7701.268379503938, 7719.691212351443, 7866.213378662317, 7899.170587088273, 7585.127710313384, 7599.16409194977, 7632.988502320563, 7748.263914928073, 7816.7264145754625, 7196.784096477114, 7229.421646268181, 7278.199398066315, 7302.123745150616, 7309.451791115794, 5012.423571289349, 5088.847334579968, 5101.7194054327365, 5192.532672059533, 5225.555827754683, 5140.537351638371, 5208.296879921162, 5243.318368612208, 5350.892982140414, 5521.475459831309], "value": 4734.059731105793, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.73147676289256, 355.57686353239643, 359.29936623584007, 362.86211239728897, 365.846344535295, 5530.9303336648145, 5566.638168519048, 5595.524380427663, 5601.4958653721105, 5645.266115404992, 5503.3395992480955, 5535.81690527946, 5572.5263352615075, 5589.8602534936645, 5601.691906945116, 4354.586314300144, 4383.539728328527, 4383.583559561836, 4397.714148580332, 4399.318105693606, 4290.742555446667, 4349.608125399874, 4361.825526978917, 4373.759443230637, 4379.75911324877, 4280.507741609724, 4307.6123148916595, 4308.74147551148, 4326.502452217988, 4330.675199360045, 4307.117041006586, 4307.1601037797645, 4328.761918094504, 4333.458317710286, 4337.566243375669, 3716.5168528091176, 3825.158465137693, 3825.387937929918, 3831.9616803832164, 3840.3855383138844, 5462.453754624546, 5468.781248750045, 5478.945210547883, 5480.287562616874, 5487.64330318528, 4983.234304960745, 4987.852793857397, 4998.425181104183, 5011.2483127530795, 5060.898782024339, 5567.55459563238, 5731.398203188647, 5905.793297234619, 5910.615809972338, 5934.940650593482, 4222.3244280914905, 4222.641075508585, 4223.493180818322, 4226.344916537942, 4233.491980962304, 5998.40015998401, 6050.515958723336, 6054.909176362358, 6078.240219972504, 6112.266528016622, 4244.893877653021, 4331.848385306499, 4350.71720338177, 4355.891102722394, 4357.629601483846, 4383.693141480129, 4387.802548885308, 4389.648828093745, 4403.163398954189, 4427.867163985085, 4952.217201807346, 5027.899442011212, 5028.723420211851, 5032.421271553818, 5051.26756620288, 5658.292713410824, 5850.391142435864, 5854.560907931922, 5864.67744274069, 5895.67573783446, 1440.6974535347485, 1469.434267806902, 1475.159159279222, 1476.2028504607392, 1484.9183294918882, 1004.437514991607, 1017.5319353097658, 1024.99487502562, 1028.6759670703705, 1048.727330893973, 5476.288082549323, 5500.889982200333, 5501.202325662756, 5521.171824226398, 5533.557315414838, 5798.9130163047585, 5821.27234095738, 5866.442687944638, 5869.236999190078, 5891.617044892068, 5387.9461205388225, 5491.697956612425, 5501.202325662756, 5695.86082783445, 5737.51231145349, 3103.2552187474844, 3114.345987342683, 3134.9373012540077, 3144.905652830373, 3151.196444906534, 6008.188894499187, 6069.544784141207, 6076.665783381868, 6106.419890110433, 6130.662813545208, 6194.389458740759, 6224.346443623445, 6234.501239900797, 6239.438450539383, 6243.469305109116, 6342.334054924258, 6343.302236753953, 6365.2998170201245, 6366.6180029198395, 6398.872022559616, 5941.970290148694, 6033.42682445167, 6069.332373439007, 6072.512234502575, 6076.665783381956, 6002.789902353396, 6016.21789167423, 6017.428344307284, 6019.247594050744, 6029.0, 6099.695015249308, 6257.499400047895, 6336.0, 6346.270178929482, 6347.841303967438, 4333.913321733611, 4344.1528901865095, 4344.6089851913475, 4359.04101097758, 4366.737995720267, 5929.762809487572, 6061.0, 6073.726682299395, 6101.0, 6155.753769849156, 5924.31870334917, 5930.822075337746, 5936.673482958478, 5946.791862284799, 5949.137375080676, 5928.584999050025, 5949.881002380015, 5974.372690867396, 5983.401659834156, 5990.31111422192, 5706.372299047184, 5826.621269617631, 5868.794592189253, 5877.706114694333, 5885.970570147293, 5944.791932282349, 5966.701664916824, 5967.91048134287, 5970.820875373745, 5994.310654274815, 5687.1753595729215, 5799.4780469757925, 5823.621464604787, 5843.883122337615, 5843.970780146072], "value": 4489.082053632254, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.3722073458297, 770.3836930455634, 785.9646315915783, 831.0941074229089, 895.6417433026788, 12945.870541294584, 13174.0, 13212.14121082129, 13370.264635445046, 13383.79924301135, 13528.661783455418, 13547.18716876988, 13634.454621815115, 14384.1369517829, 14525.201113938729, 824.7031068815222, 843.7131375332385, 847.8092429203441, 848.1899785704668, 849.1508491508491, 814.2020819596798, 828.1883753921161, 854.9145085491432, 855.5123579559654, 858.0604238358987, 886.4769785826361, 888.5557221389305, 892.205936716323, 892.5715656484891, 892.937494375394, 878.3236907581127, 882.805782727802, 885.4156256870499, 886.0430734806394, 886.246690313235, 640.4940097323156, 645.9741610335628, 646.8512242184324, 648.0764910003273, 649.1787888321277, 14161.22113283769, 14182.219977901212, 14208.644783880485, 14216.50242241527, 14301.141931484144, 13200.405981730844, 13823.0, 14118.858811411857, 14199.532276403726, 14471.42114315426, 10603.46982650872, 11190.496427660693, 11302.378369189692, 11551.364674942875, 11634.301941883514, 3807.0862992881785, 3813.656770890633, 3836.8848934532007, 3850.576436592001, 3871.632194941476, 62004.37995620076, 62293.37706622921, 62933.37066629321, 63989.3601063988, 63995.0, 10739.731506712395, 11119.610813621484, 11191.440427978569, 11235.382053986945, 11310.0, 20180.29368972079, 20327.18691252363, 20351.185952562028, 20608.27871024507, 20814.37556873296, 7789.86136687393, 8273.793155171168, 8328.375371847014, 8340.708075217339, 8407.579621018924, 4785.665003449725, 4801.615870730333, 4839.540243676845, 4871.878203044952, 4917.557419832232, 3296.571445712042, 3356.8992930212135, 3373.2916087621384, 3381.1040074380307, 3397.303552771676, 634.6667999300312, 644.4715333426545, 650.9283978762332, 663.9070530125787, 670.7451168555917, 690.7237105157876, 711.6797441151502, 714.0752725220851, 715.8389362393419, 721.5778769419843, 9905.504724763732, 9911.80176396468, 9917.900820991843, 9963.701088967342, 9979.251556133318, 728.8375041808307, 735.8307589254501, 751.597895126105, 761.1285078584989, 778.1090651204453, 4328.437303150633, 4434.1178234148065, 4616.515265897099, 4643.976780116078, 4690.108879312919, 88324.55837720771, 90067.0, 91071.54464227769, 92434.0, 94400.52799735958, 45310.32034519485, 52955.735221323645, 62321.0, 63093.05360419597, 80152.59923700462, 65173.67413162999, 66332.0, 66685.66657166684, 67105.32894671186, 67777.32222677808, 10096.139447123174, 10299.948500257451, 10321.48392580383, 10559.0, 10575.524101415302, 32563.02310930676, 41219.1756164869, 45013.77493112513, 45689.77155114203, 49303.0, 55243.72378138084, 60269.39730602638, 62240.06639900496, 63681.36318636754, 65508.344916550224, 12180.57367992116, 12278.201916875374, 12404.75190496167, 12437.62687119388, 12784.232946023269, 13888.513902013381, 13975.510857119953, 14077.436902523785, 14138.929305353407, 14576.052556583789, 13331.417187825193, 13335.466581336637, 13344.733105337644, 13705.109167904453, 14073.296335182995, 12198.695032624255, 12667.176633518791, 13080.672983175116, 13669.316534173053, 13780.862191377957, 13356.198628082346, 13371.866281337063, 13409.32953352348, 13798.793018104938, 13834.0, 10413.061693994146, 11088.611898583833, 11093.50079246452, 11131.165162612675, 11566.826497602711, 10540.10409115203, 10545.894541054491, 10681.626143084955, 10738.570457181626, 10776.407297598707], "value": 7191.105406195881, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1463.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 112.0, 110.0, 109.0, 110.0, 111.0, 109.0, 110.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 120.0, 158.0, 119.0, 120.0, 119.0, 123.0, 145.0, 122.0], "value": 128.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 169.0, 163.0, 161.0, 162.0, 161.0, 161.0, 162.0, 161.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 113.0, 76.0, 74.0, 75.0, 77.0, 102.0, 78.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 112.0, 81.0, 82.0, 83.0, 99.0, 82.0, 83.0, 112.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 147.0, 146.0, 146.0, 147.0, 147.0, 148.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 87.0, 87.0, 85.0, 85.0, 85.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 57.0, 54.0, 56.0, 55.0, 56.0, 55.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 75.0, 75.0, 80.0, 75.0, 78.0, 73.0, 73.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 121.0, 133.0, 123.0, 122.0, 130.0, 122.0, 121.0, 160.0, 122.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 157.0, 158.0, 157.0, 156.0, 165.0, 157.0, 158.0, 158.0, 156.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 69.0, 63.0, 65.0, 63.0, 63.0, 63.0, 62.0], "value": 63.8, "unit": "score"}]}]} 09:01:05 INFO - Return code: 0 09:01:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:01:05 ERROR - # TBPL SUCCESS # 09:01:05 INFO - Running post-action listener: _resource_record_post_action 09:01:05 INFO - [mozharness: 2017-02-24 17:01:05.305871Z] Finished run-tests step (success) 09:01:05 INFO - Running post-run listener: _resource_record_post_run 09:01:05 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 320983040; Read time: 0; Write time: 162780 09:01:05 INFO - TinderboxPrint: CPU usage
13.2% 09:01:05 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:01:05 INFO - TinderboxPrint: I/O write bytes / time
320,983,040 / 162,780 09:01:05 INFO - TinderboxPrint: CPU idle
8,220.6 (86.8%) 09:01:05 INFO - TinderboxPrint: CPU user
1,199.6 (12.7%) 09:01:05 INFO - TinderboxPrint: Swap in / out
0 / 0 09:01:05 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 97329152; Read time: 0; Write time: 53196 09:01:05 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 219258880; Read time: 0; Write time: 109276 09:01:05 INFO - Running post-run listener: _upload_blobber_files 09:01:05 INFO - Blob upload gear active. 09:01:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:01:05 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 09:01:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:01:06 INFO - (blobuploader) - INFO - Open directory for files ... 09:01:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:01:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:01:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:09 INFO - (blobuploader) - INFO - Done attempting. 09:01:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:01:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:01:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:10 INFO - (blobuploader) - INFO - Done attempting. 09:01:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:01:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:01:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:11 INFO - (blobuploader) - INFO - Done attempting. 09:01:11 INFO - (blobuploader) - INFO - Iteration through files over. 09:01:11 INFO - Return code: 0 09:01:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:01:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:01:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92b74cd1af0dd40f5cda0bc513e743792811b478d266f632c6e0fab49b1af1ee27e14d15dedefa89fe3bdf635ba1ca1754a5f0ceb4daa49673ebe90d0e47810c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea4cf20af67ef766c59f5cea2466c9ed343c2479cbe1dd9abf8744e2b6f477ed03bcce7176444799ac0eb62d297886c445f480c9098114c5cf181c53748a204f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea8e8114186294fceb17640965cc254467a49a380fb504f9910138a7451d68d2d4e55a2d0c2c2ce1eaa228543e685f5e9bc27a9cf6ad16f31ceaa19fe76f7e7d"} 09:01:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:01:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:01:11 INFO - Contents: 09:01:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92b74cd1af0dd40f5cda0bc513e743792811b478d266f632c6e0fab49b1af1ee27e14d15dedefa89fe3bdf635ba1ca1754a5f0ceb4daa49673ebe90d0e47810c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea4cf20af67ef766c59f5cea2466c9ed343c2479cbe1dd9abf8744e2b6f477ed03bcce7176444799ac0eb62d297886c445f480c9098114c5cf181c53748a204f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea8e8114186294fceb17640965cc254467a49a380fb504f9910138a7451d68d2d4e55a2d0c2c2ce1eaa228543e685f5e9bc27a9cf6ad16f31ceaa19fe76f7e7d"} 09:01:11 INFO - Running post-run listener: copy_logs_to_upload_dir 09:01:11 INFO - Copying logs to upload dir... 09:01:11 INFO - mkdir: /builds/slave/test/build/upload/logs 09:01:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.008447 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-24 09:01:11.566204) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-24 09:01:11.569978) ========= 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=32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855 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/Mozilla-Beta/sha512/92b74cd1af0dd40f5cda0bc513e743792811b478d266f632c6e0fab49b1af1ee27e14d15dedefa89fe3bdf635ba1ca1754a5f0ceb4daa49673ebe90d0e47810c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea4cf20af67ef766c59f5cea2466c9ed343c2479cbe1dd9abf8744e2b6f477ed03bcce7176444799ac0eb62d297886c445f480c9098114c5cf181c53748a204f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea8e8114186294fceb17640965cc254467a49a380fb504f9910138a7451d68d2d4e55a2d0c2c2ce1eaa228543e685f5e9bc27a9cf6ad16f31ceaa19fe76f7e7d"} build_url:https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011408 build_url: 'https://queue.taskcluster.net/v1/task/FuWjX_EeSradf3n1XFaGEg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92b74cd1af0dd40f5cda0bc513e743792811b478d266f632c6e0fab49b1af1ee27e14d15dedefa89fe3bdf635ba1ca1754a5f0ceb4daa49673ebe90d0e47810c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea4cf20af67ef766c59f5cea2466c9ed343c2479cbe1dd9abf8744e2b6f477ed03bcce7176444799ac0eb62d297886c445f480c9098114c5cf181c53748a204f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea8e8114186294fceb17640965cc254467a49a380fb504f9910138a7451d68d2d4e55a2d0c2c2ce1eaa228543e685f5e9bc27a9cf6ad16f31ceaa19fe76f7e7d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-24 09:01:11.594651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 09:01:11.594969) ========= 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=32c5991c409366f7fec8a718000001d2-1487953747.265690-697433855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 09:01:11.680360) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-24 09:01:11.680681) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-24 09:01:11.680968) ========= ========= Total master_lag: 0.16 =========