builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1486332512.42 results: success (0) buildid: 20170205120809 builduid: 432c3932db924da5b227c719717b8634 revision: e5373fbb022e1a227116a989d22929040bfabc3c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-05 14:08:32.422821) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-05 14:08:32.423281) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-05 14:08:32.423553) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-05 14:08:32.437150) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 14:08:32.437468) ========= 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=7de08804244eb36560b44971000001c3-1486332512.195918-154754451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-05 14:08:32-- 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% 50.1M=0s 2017-02-05 14:08:33 (50.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.327806 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 14:08:32.776701) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 14:08:32.777011) ========= 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=7de08804244eb36560b44971000001c3-1486332512.195918-154754451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017799 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 14:08:32.826391) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-05 14:08:32.826753) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e5373fbb022e1a227116a989d22929040bfabc3c --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 e5373fbb022e1a227116a989d22929040bfabc3c --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=7de08804244eb36560b44971000001c3-1486332512.195918-154754451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-05 14:08:33,202 truncating revision to first 12 chars 2017-02-05 14:08:33,202 Setting DEBUG logging. 2017-02-05 14:08:33,202 attempt 1/10 2017-02-05 14:08:33,202 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e5373fbb022e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-05 14:08:34,157 unpacking tar archive at: mozilla-beta-e5373fbb022e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.251005 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-05 14:08:34.097259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-05 14:08:34.097609) ========= script_repo_revision: e5373fbb022e1a227116a989d22929040bfabc3c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-05 14:08:34.098001) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-05 14:08:34.098265) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-05 14:08:34.108273) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-02-05 14:08:34.108547) ========= /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=7de08804244eb36560b44971000001c3-1486332512.195918-154754451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:08:34 INFO - MultiFileLogger online at 20170205 14:08:34 in /builds/slave/test 14:08:34 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 14:08:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:08:34 INFO - {'append_to_log': False, 14:08:34 INFO - 'base_work_dir': '/builds/slave/test', 14:08:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:08:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:08:34 INFO - 'branch': 'Mozilla-Beta', 14:08:34 INFO - 'buildbot_json_path': 'buildprops.json', 14:08:34 INFO - 'config_files': ('talos/linux_config.py',), 14:08:34 INFO - 'default_actions': ('clobber', 14:08:34 INFO - 'read-buildbot-config', 14:08:34 INFO - 'download-and-extract', 14:08:34 INFO - 'populate-webroot', 14:08:34 INFO - 'create-virtualenv', 14:08:34 INFO - 'install', 14:08:34 INFO - 'run-tests'), 14:08:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:08:34 INFO - 'download_minidump_stackwalk': True, 14:08:34 INFO - 'download_symbols': 'ondemand', 14:08:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:08:34 INFO - 'tooltool.py': '/tools/tooltool.py', 14:08:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:08:34 INFO - '/tools/misc-python/virtualenv.py')}, 14:08:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:08:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:08:34 INFO - 'installer_path': 'installer.exe', 14:08:34 INFO - 'log_level': 'info', 14:08:34 INFO - 'log_name': 'talos', 14:08:34 INFO - 'log_to_console': True, 14:08:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:08:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:08:34 INFO - 'opt_config_files': (), 14:08:34 INFO - 'pip_index': False, 14:08:34 INFO - 'sps_profile': False, 14:08:34 INFO - 'sps_profile_interval': 0, 14:08:34 INFO - 'suite': 'dromaeojs-e10s', 14:08:34 INFO - 'system_bits': '32', 14:08:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:08:34 INFO - 'title': 'talos-linux64-ix-003', 14:08:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:08:34 INFO - 'use_talos_json': True, 14:08:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:08:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:08:34 INFO - 'work_dir': 'build'} 14:08:34 INFO - [mozharness: 2017-02-05 22:08:34.576980Z] Running clobber step. 14:08:34 INFO - Running pre-action listener: _resource_record_pre_action 14:08:34 INFO - Running main action method: clobber 14:08:34 INFO - rmtree: /builds/slave/test/build 14:08:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:08:35 INFO - Running post-action listener: _resource_record_post_action 14:08:35 INFO - [mozharness: 2017-02-05 22:08:35.644878Z] Finished clobber step (success) 14:08:35 INFO - [mozharness: 2017-02-05 22:08:35.644976Z] Running read-buildbot-config step. 14:08:35 INFO - Running pre-action listener: _resource_record_pre_action 14:08:35 INFO - Running main action method: read_buildbot_config 14:08:35 INFO - Using buildbot properties: 14:08:35 INFO - { 14:08:35 INFO - "project": "", 14:08:35 INFO - "product": "firefox", 14:08:35 INFO - "script_repo_revision": "production", 14:08:35 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 14:08:35 INFO - "repository": "", 14:08:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 14:08:35 INFO - "buildid": "20170205120809", 14:08:35 INFO - "pgo_build": "True", 14:08:35 INFO - "basedir": "/builds/slave/test", 14:08:35 INFO - "buildnumber": 398, 14:08:35 INFO - "slavename": "talos-linux64-ix-003", 14:08:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:08:35 INFO - "platform": "ubuntu64_hw", 14:08:35 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:08:35 INFO - "branch": "mozilla-beta", 14:08:35 INFO - "repo_path": "releases/mozilla-beta", 14:08:35 INFO - "revision": "e5373fbb022e1a227116a989d22929040bfabc3c", 14:08:35 INFO - "stage_platform": "linux64-pgo", 14:08:35 INFO - "builduid": "432c3932db924da5b227c719717b8634", 14:08:35 INFO - "slavebuilddir": "test" 14:08:35 INFO - } 14:08:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 14:08:35 INFO - Running post-action listener: _resource_record_post_action 14:08:35 INFO - [mozharness: 2017-02-05 22:08:35.647410Z] Finished read-buildbot-config step (success) 14:08:35 INFO - [mozharness: 2017-02-05 22:08:35.647499Z] Running download-and-extract step. 14:08:35 INFO - Running pre-action listener: _resource_record_pre_action 14:08:35 INFO - Running main action method: download_and_extract 14:08:35 INFO - mkdir: /builds/slave/test/build/tests 14:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:35 INFO - trying https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:08:35 INFO - Downloading https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/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 14:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/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 14:08:36 INFO - Downloaded 1327 bytes. 14:08:36 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:08:36 INFO - Using the following test package requirements: 14:08:36 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 14:08:36 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:08:36 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:08:36 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:08:36 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 14:08:36 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:08:36 INFO - u'jsshell-linux-x86_64.zip'], 14:08:36 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:08:36 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:08:36 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 14:08:36 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:08:36 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 14:08:36 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:08:36 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 14:08:36 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:08:36 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:08:36 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:08:36 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:08:36 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:08:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 14:08:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:08:36 INFO - Fetch https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 14:08:36 INFO - Http code: 200 14:08:36 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 14:08:36 INFO - x-amz-cf-id: uyjaWMPeIZ2kphUZqGKFQ2mkJ05rwbtfJPpQ7-Eh_kEBfQ9uTyEFxw== 14:08:36 INFO - x-amz-version-id: rH5HidAzOFJv6pmMxGvuoxT.cW.JsSFC 14:08:37 INFO - Expected file size: 21956555 14:08:37 INFO - Obtained file size: 21956555 14:08:41 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 14:08:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 14:08:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:08:41 INFO - Fetch https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 14:08:41 INFO - Http code: 200 14:08:41 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 14:08:41 INFO - x-amz-cf-id: HzvrWIuOJwp8rHARtcedsjCYVTgAQC940IMZXXmhIrHPPdCmdLZyiQ== 14:08:41 INFO - x-amz-version-id: rH5HidAzOFJv6pmMxGvuoxT.cW.JsSFC 14:08:41 INFO - Expected file size: 21956555 14:08:41 INFO - Obtained file size: 21956555 14:08:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 14:08:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:08:47 INFO - Fetch https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 14:08:47 INFO - Http code: 200 14:08:47 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 14:08:47 INFO - x-amz-cf-id: xZ09vAnFLwPOw-gA55KGzqRuYm9CDurgRCQkscINGS5_hrwdGY51Yg== 14:08:47 INFO - x-amz-version-id: t3wCbSE2ow2ekDFGIohSlGy.8EpBcqDJ 14:08:47 INFO - Expected file size: 14403005 14:08:47 INFO - Obtained file size: 14403005 14:08:48 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')]} 14:08:48 INFO - trying https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:08:48 INFO - Downloading https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/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 14:08:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/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 14:08:49 INFO - Downloaded 57689905 bytes. 14:08:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:08:49 INFO - mkdir: /builds/slave/test/properties 14:08:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:08:49 INFO - Writing to file /builds/slave/test/properties/build_url 14:08:49 INFO - Contents: 14:08:49 INFO - build_url:https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:08:49 INFO - Running post-action listener: _resource_record_post_action 14:08:49 INFO - Running post-action listener: set_extra_try_arguments 14:08:49 INFO - [mozharness: 2017-02-05 22:08:49.766939Z] Finished download-and-extract step (success) 14:08:49 INFO - [mozharness: 2017-02-05 22:08:49.767170Z] Running populate-webroot step. 14:08:49 INFO - Running pre-action listener: _resource_record_pre_action 14:08:49 INFO - Running main action method: populate_webroot 14:08:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:08:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:08:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:08:49 INFO - '--tppagecycles', 14:08:49 INFO - '7'], 14:08:49 INFO - 'tests': ['tsvgm']}}, 14:08:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:08:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:08:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:08:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:08:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:08:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:08:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:49 INFO - 'talos_options': ['--disable-e10s'], 14:08:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:08:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:08:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:49 INFO - 'talos_options': ['--disable-e10s'], 14:08:49 INFO - 'tests': ['damp', 'tps']}, 14:08:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:49 INFO - 'tests': ['damp', 'tps']}, 14:08:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:08:49 INFO - 'tests': ['dromaeo_dom']}, 14:08:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:08:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:08:49 INFO - 'tests': ['basic_compositor_video']}, 14:08:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:08:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:08:49 INFO - 'tests': ['a11yr', 14:08:49 INFO - 'ts_paint', 14:08:49 INFO - 'tpaint', 14:08:49 INFO - 'sessionrestore', 14:08:49 INFO - 'sessionrestore_no_auto_restore', 14:08:49 INFO - 'tabpaint']}, 14:08:49 INFO - 'other-e10s': {'tests': ['a11yr', 14:08:49 INFO - 'ts_paint', 14:08:49 INFO - 'tpaint', 14:08:49 INFO - 'sessionrestore', 14:08:49 INFO - 'sessionrestore_no_auto_restore', 14:08:49 INFO - 'tabpaint']}, 14:08:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:08:49 INFO - 'ts_paint', 14:08:49 INFO - 'tpaint', 14:08:49 INFO - 'sessionrestore', 14:08:49 INFO - 'sessionrestore_no_auto_restore', 14:08:49 INFO - 'tabpaint']}, 14:08:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:08:49 INFO - 'ts_paint', 14:08:49 INFO - 'tpaint', 14:08:49 INFO - 'sessionrestore', 14:08:49 INFO - 'sessionrestore_no_auto_restore', 14:08:49 INFO - 'tabpaint']}, 14:08:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:08:49 INFO - 'tests': ['a11yr', 14:08:49 INFO - 'ts_paint', 14:08:49 INFO - 'tpaint', 14:08:49 INFO - 'sessionrestore', 14:08:49 INFO - 'sessionrestore_no_auto_restore', 14:08:49 INFO - 'tabpaint']}, 14:08:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:08:49 INFO - 'tests': ['a11yr', 14:08:49 INFO - 'ts_paint', 14:08:49 INFO - 'tpaint', 14:08:49 INFO - 'sessionrestore', 14:08:49 INFO - 'sessionrestore_no_auto_restore', 14:08:49 INFO - 'tabpaint']}, 14:08:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:08:49 INFO - 'tests': ['tsvgx', 14:08:49 INFO - 'tsvgr_opacity', 14:08:49 INFO - 'tart', 14:08:49 INFO - 'tscrollx', 14:08:49 INFO - 'cart']}, 14:08:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:08:49 INFO - 'tsvgr_opacity', 14:08:49 INFO - 'tart', 14:08:49 INFO - 'tscrollx', 14:08:49 INFO - 'cart']}, 14:08:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:49 INFO - 'talos_options': ['--disable-e10s'], 14:08:49 INFO - 'tests': ['tp5o']}, 14:08:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:49 INFO - 'tests': ['tp5o']}, 14:08:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:49 INFO - 'talos_options': ['--disable-e10s', 14:08:49 INFO - '--xperf_path', 14:08:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:08:49 INFO - 'tests': ['tp5n']}, 14:08:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:49 INFO - 'talos_options': ['--xperf_path', 14:08:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:08:49 INFO - 'tests': ['tp5n']}}, 14:08:49 INFO - 'talos.zip': {'path': '', 14:08:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:08:49 INFO - Running post-action listener: _resource_record_post_action 14:08:49 INFO - [mozharness: 2017-02-05 22:08:49.786809Z] Finished populate-webroot step (success) 14:08:49 INFO - [mozharness: 2017-02-05 22:08:49.786897Z] Running create-virtualenv step. 14:08:49 INFO - Running pre-action listener: _resource_record_pre_action 14:08:49 INFO - Running main action method: create_virtualenv 14:08:49 INFO - Creating virtualenv /builds/slave/test/build/venv 14:08:49 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 14:08:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:08:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:08:49 INFO - Using real prefix '/usr' 14:08:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:08:50 INFO - Installing distribute.............................................................................................................................................................................................done. 14:08:52 INFO - Installing pip.................done. 14:08:52 INFO - Return code: 0 14:08:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:08:52 INFO - Reading from file tmpfile_stdout 14:08:52 INFO - Output received: 14:08:52 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) 14:08:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:08:52 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')]} 14:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:52 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')]} 14:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:52 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 0x7f1733013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', '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 14:08:52 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 14:08:52 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 14:08:52 INFO - Using env: {'DISPLAY': ':0', 14:08:52 INFO - 'HOME': '/home/cltbld', 14:08:52 INFO - 'LANG': 'en_US.UTF-8', 14:08:52 INFO - 'LANGUAGE': 'en_US:en', 14:08:52 INFO - 'LOGNAME': 'cltbld', 14:08:52 INFO - 'MAIL': '/var/mail/cltbld', 14:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:52 INFO - 'MOZ_NO_REMOTE': '1', 14:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:52 INFO - 'NO_EM_RESTART': '1', 14:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:52 INFO - 'PWD': '/builds/slave/test', 14:08:52 INFO - 'SHELL': '/bin/bash', 14:08:52 INFO - 'SHLVL': '1', 14:08:52 INFO - 'TERM': 'linux', 14:08:52 INFO - 'TMOUT': '86400', 14:08:52 INFO - 'USER': 'cltbld', 14:08:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', 14:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:52 INFO - '_': '/tools/buildbot/bin/python'} 14:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:52 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 14:08:52 INFO - Cleaning up... 14:08:52 INFO - Return code: 0 14:08:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:08:52 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')]} 14:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:52 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')]} 14:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:52 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 0x7f1733013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', '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 14:08:52 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 14:08:52 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 14:08:52 INFO - Using env: {'DISPLAY': ':0', 14:08:52 INFO - 'HOME': '/home/cltbld', 14:08:52 INFO - 'LANG': 'en_US.UTF-8', 14:08:52 INFO - 'LANGUAGE': 'en_US:en', 14:08:52 INFO - 'LOGNAME': 'cltbld', 14:08:52 INFO - 'MAIL': '/var/mail/cltbld', 14:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:52 INFO - 'MOZ_NO_REMOTE': '1', 14:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:52 INFO - 'NO_EM_RESTART': '1', 14:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:52 INFO - 'PWD': '/builds/slave/test', 14:08:52 INFO - 'SHELL': '/bin/bash', 14:08:52 INFO - 'SHLVL': '1', 14:08:52 INFO - 'TERM': 'linux', 14:08:52 INFO - 'TMOUT': '86400', 14:08:52 INFO - 'USER': 'cltbld', 14:08:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', 14:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:52 INFO - '_': '/tools/buildbot/bin/python'} 14:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:53 INFO - Downloading/unpacking psutil>=3.1.1 14:08:53 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 14:08:53 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 14:08:53 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 14:08:53 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 14:08:53 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 14:08:53 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 14:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:08:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:55 INFO - Installing collected packages: psutil 14:08:55 INFO - Running setup.py install for psutil 14:08:55 INFO - building 'psutil._psutil_linux' extension 14:08:55 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 14:08:55 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 14:08:55 INFO - building 'psutil._psutil_posix' extension 14:08:55 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 14:08:55 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 14:08:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:55 INFO - Successfully installed psutil 14:08:55 INFO - Cleaning up... 14:08:55 INFO - Return code: 0 14:08:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:08:55 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')]} 14:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:55 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')]} 14:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:55 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 0x7f1733013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', '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 14:08:55 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 14:08:55 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 14:08:55 INFO - Using env: {'DISPLAY': ':0', 14:08:55 INFO - 'HOME': '/home/cltbld', 14:08:55 INFO - 'LANG': 'en_US.UTF-8', 14:08:55 INFO - 'LANGUAGE': 'en_US:en', 14:08:55 INFO - 'LOGNAME': 'cltbld', 14:08:55 INFO - 'MAIL': '/var/mail/cltbld', 14:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:55 INFO - 'MOZ_NO_REMOTE': '1', 14:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:55 INFO - 'NO_EM_RESTART': '1', 14:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:55 INFO - 'PWD': '/builds/slave/test', 14:08:55 INFO - 'SHELL': '/bin/bash', 14:08:55 INFO - 'SHLVL': '1', 14:08:55 INFO - 'TERM': 'linux', 14:08:55 INFO - 'TMOUT': '86400', 14:08:55 INFO - 'USER': 'cltbld', 14:08:55 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', 14:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:55 INFO - '_': '/tools/buildbot/bin/python'} 14:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:08:55 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 14:08:55 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 14:08:55 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 14:08:55 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 14:08:55 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 14:08:55 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 14:08:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:08:58 INFO - Installing collected packages: mozsystemmonitor 14:08:58 INFO - Running setup.py install for mozsystemmonitor 14:08:58 INFO - Successfully installed mozsystemmonitor 14:08:58 INFO - Cleaning up... 14:08:58 INFO - Return code: 0 14:08:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:08:58 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')]} 14:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:58 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')]} 14:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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', '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 0x7f1733013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', '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 14:08: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:08: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 jsonschema==2.5.1 14:08:58 INFO - Using env: {'DISPLAY': ':0', 14:08:58 INFO - 'HOME': '/home/cltbld', 14:08:58 INFO - 'LANG': 'en_US.UTF-8', 14:08:58 INFO - 'LANGUAGE': 'en_US:en', 14:08:58 INFO - 'LOGNAME': 'cltbld', 14:08:58 INFO - 'MAIL': '/var/mail/cltbld', 14:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:58 INFO - 'MOZ_NO_REMOTE': '1', 14:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:58 INFO - 'NO_EM_RESTART': '1', 14:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:58 INFO - 'PWD': '/builds/slave/test', 14:08:58 INFO - 'SHELL': '/bin/bash', 14:08:58 INFO - 'SHLVL': '1', 14:08:58 INFO - 'TERM': 'linux', 14:08:58 INFO - 'TMOUT': '86400', 14:08:58 INFO - 'USER': 'cltbld', 14:08:58 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', 14:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:58 INFO - '_': '/tools/buildbot/bin/python'} 14:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:58 INFO - Downloading/unpacking jsonschema==2.5.1 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:09:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:09:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:09:00 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 14:09:00 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 14:09:00 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 14:09:00 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 14:09:00 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 14:09:00 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 14:09:00 INFO - Downloading functools32-3.2.3-2.tar.gz 14:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:09:00 INFO - warning: no files found matching '*.txt' 14:09:00 INFO - no previously-included directories found matching 'build' 14:09:00 INFO - no previously-included directories found matching 'dist' 14:09:00 INFO - no previously-included directories found matching '.git*' 14:09:00 INFO - Installing collected packages: jsonschema, functools32 14:09:00 INFO - Running setup.py install for functools32 14:09:00 INFO - warning: no files found matching '*.txt' 14:09:00 INFO - no previously-included directories found matching 'build' 14:09:00 INFO - no previously-included directories found matching 'dist' 14:09:00 INFO - no previously-included directories found matching '.git*' 14:09:00 INFO - Successfully installed jsonschema functools32 14:09:00 INFO - Cleaning up... 14:09:00 INFO - Return code: 0 14:09:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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', '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 0x7f1733013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', '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 14:09: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:09: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 functools32==3.2.3-2 14:09:00 INFO - Using env: {'DISPLAY': ':0', 14:09:00 INFO - 'HOME': '/home/cltbld', 14:09:00 INFO - 'LANG': 'en_US.UTF-8', 14:09:00 INFO - 'LANGUAGE': 'en_US:en', 14:09:00 INFO - 'LOGNAME': 'cltbld', 14:09:00 INFO - 'MAIL': '/var/mail/cltbld', 14:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:00 INFO - 'MOZ_NO_REMOTE': '1', 14:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:00 INFO - 'NO_EM_RESTART': '1', 14:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:00 INFO - 'PWD': '/builds/slave/test', 14:09:00 INFO - 'SHELL': '/bin/bash', 14:09:00 INFO - 'SHLVL': '1', 14:09:00 INFO - 'TERM': 'linux', 14:09:00 INFO - 'TMOUT': '86400', 14:09:00 INFO - 'USER': 'cltbld', 14:09:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', 14:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:00 INFO - '_': '/tools/buildbot/bin/python'} 14:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:09:01 INFO - Cleaning up... 14:09:01 INFO - Return code: 0 14:09:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:09:01 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')]} 14:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:01 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')]} 14:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:01 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 0x7f1733013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', '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 14:09:01 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 14:09:01 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 14:09:01 INFO - Using env: {'DISPLAY': ':0', 14:09:01 INFO - 'HOME': '/home/cltbld', 14:09:01 INFO - 'LANG': 'en_US.UTF-8', 14:09:01 INFO - 'LANGUAGE': 'en_US:en', 14:09:01 INFO - 'LOGNAME': 'cltbld', 14:09:01 INFO - 'MAIL': '/var/mail/cltbld', 14:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:01 INFO - 'MOZ_NO_REMOTE': '1', 14:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:01 INFO - 'NO_EM_RESTART': '1', 14:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:01 INFO - 'PWD': '/builds/slave/test', 14:09:01 INFO - 'SHELL': '/bin/bash', 14:09:01 INFO - 'SHLVL': '1', 14:09:01 INFO - 'TERM': 'linux', 14:09:01 INFO - 'TMOUT': '86400', 14:09:01 INFO - 'USER': 'cltbld', 14:09:01 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', 14:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:01 INFO - '_': '/tools/buildbot/bin/python'} 14:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:01 INFO - Downloading/unpacking blobuploader==1.2.4 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09:03 INFO - Downloading blobuploader-1.2.4.tar.gz 14:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:09:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:09:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09:04 INFO - Downloading docopt-0.6.1.tar.gz 14:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:09:04 INFO - Installing collected packages: blobuploader, requests, docopt 14:09:04 INFO - Running setup.py install for blobuploader 14:09:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:09:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:09:04 INFO - Running setup.py install for requests 14:09:04 INFO - Running setup.py install for docopt 14:09:04 INFO - Successfully installed blobuploader requests docopt 14:09:04 INFO - Cleaning up... 14:09:04 INFO - Return code: 0 14:09:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:04 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')]} 14:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:04 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')]} 14:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:04 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 0x7f1733013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', '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 14:09:04 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 14:09:04 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 14:09:04 INFO - Using env: {'DISPLAY': ':0', 14:09:04 INFO - 'HOME': '/home/cltbld', 14:09:04 INFO - 'LANG': 'en_US.UTF-8', 14:09:04 INFO - 'LANGUAGE': 'en_US:en', 14:09:04 INFO - 'LOGNAME': 'cltbld', 14:09:04 INFO - 'MAIL': '/var/mail/cltbld', 14:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:04 INFO - 'MOZ_NO_REMOTE': '1', 14:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:04 INFO - 'NO_EM_RESTART': '1', 14:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:04 INFO - 'PWD': '/builds/slave/test', 14:09:04 INFO - 'SHELL': '/bin/bash', 14:09:04 INFO - 'SHLVL': '1', 14:09:04 INFO - 'TERM': 'linux', 14:09:04 INFO - 'TMOUT': '86400', 14:09:04 INFO - 'USER': 'cltbld', 14:09:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', 14:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:04 INFO - '_': '/tools/buildbot/bin/python'} 14:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:04 INFO - Running setup.py (path:/tmp/pip-oOb9Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:05 INFO - Running setup.py (path:/tmp/pip-mW_0Gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:05 INFO - Running setup.py (path:/tmp/pip-gs4rN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:05 INFO - Running setup.py (path:/tmp/pip-by3P_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:05 INFO - Running setup.py (path:/tmp/pip-qGOL1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:05 INFO - Running setup.py (path:/tmp/pip-zl7Uqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:05 INFO - Running setup.py (path:/tmp/pip-R5tU2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:05 INFO - Running setup.py (path:/tmp/pip-kIpM64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:05 INFO - Running setup.py (path:/tmp/pip-8zDAdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:05 INFO - Running setup.py (path:/tmp/pip-xzDU23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:05 INFO - Running setup.py (path:/tmp/pip-UOrMQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:05 INFO - Running setup.py (path:/tmp/pip-8FdSAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:05 INFO - Running setup.py (path:/tmp/pip-Qvs35j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:05 INFO - Running setup.py (path:/tmp/pip-tOgnjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:06 INFO - Running setup.py (path:/tmp/pip-xWOS2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:06 INFO - Running setup.py (path:/tmp/pip-NtICK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:06 INFO - Running setup.py (path:/tmp/pip-1NKmwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:09:06 INFO - Running setup.py install for manifestparser 14:09:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:09:06 INFO - Running setup.py install for mozcrash 14:09:06 INFO - Running setup.py install for mozdebug 14:09:06 INFO - Running setup.py install for mozdevice 14:09:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:09:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:09:06 INFO - Running setup.py install for mozfile 14:09:06 INFO - Running setup.py install for mozhttpd 14:09:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:09:06 INFO - Running setup.py install for mozinfo 14:09:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:09:06 INFO - Running setup.py install for mozInstall 14:09:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:09:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:09:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:09:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:09:07 INFO - Running setup.py install for mozleak 14:09:07 INFO - Running setup.py install for mozlog 14:09:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:09:07 INFO - Running setup.py install for moznetwork 14:09:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:09:07 INFO - Running setup.py install for mozprocess 14:09:07 INFO - Running setup.py install for mozprofile 14:09:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:09:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:09:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:09:07 INFO - Running setup.py install for mozrunner 14:09:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:09:07 INFO - Running setup.py install for mozscreenshot 14:09:07 INFO - Running setup.py install for moztest 14:09:07 INFO - Running setup.py install for mozversion 14:09:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:09:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:09:07 INFO - Cleaning up... 14:09:08 INFO - Return code: 0 14:09:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:08 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')]} 14:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:08 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')]} 14:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:08 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 0x7f1733013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', '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 14:09:08 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 14:09:08 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 14:09:08 INFO - Using env: {'DISPLAY': ':0', 14:09:08 INFO - 'HOME': '/home/cltbld', 14:09:08 INFO - 'LANG': 'en_US.UTF-8', 14:09:08 INFO - 'LANGUAGE': 'en_US:en', 14:09:08 INFO - 'LOGNAME': 'cltbld', 14:09:08 INFO - 'MAIL': '/var/mail/cltbld', 14:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:08 INFO - 'MOZ_NO_REMOTE': '1', 14:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:08 INFO - 'NO_EM_RESTART': '1', 14:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:08 INFO - 'PWD': '/builds/slave/test', 14:09:08 INFO - 'SHELL': '/bin/bash', 14:09:08 INFO - 'SHLVL': '1', 14:09:08 INFO - 'TERM': 'linux', 14:09:08 INFO - 'TMOUT': '86400', 14:09:08 INFO - 'USER': 'cltbld', 14:09:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', 14:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:08 INFO - '_': '/tools/buildbot/bin/python'} 14:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:08 INFO - Running setup.py (path:/tmp/pip-kVrEKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:08 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)) 14:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:08 INFO - Running setup.py (path:/tmp/pip-IL843V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:08 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)) 14:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:08 INFO - Running setup.py (path:/tmp/pip-L_loWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:08 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)) 14:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:08 INFO - Running setup.py (path:/tmp/pip-40U1Dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:08 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)) 14:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:08 INFO - Running setup.py (path:/tmp/pip-19LbsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:08 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)) 14:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:08 INFO - Running setup.py (path:/tmp/pip-LxRKnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:08 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)) 14:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:08 INFO - Running setup.py (path:/tmp/pip-Zz8xaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:08 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)) 14:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:08 INFO - Running setup.py (path:/tmp/pip-w2dU4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:08 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)) 14:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:08 INFO - Running setup.py (path:/tmp/pip-c6hc4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:08 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)) 14:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:08 INFO - Running setup.py (path:/tmp/pip-iCGimt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:08 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)) 14:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:08 INFO - Running setup.py (path:/tmp/pip-_L4N6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:09 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)) 14:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:09 INFO - Running setup.py (path:/tmp/pip-TGUxor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:09 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)) 14:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:09 INFO - Running setup.py (path:/tmp/pip-Js34Cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:09 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)) 14:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:09 INFO - Running setup.py (path:/tmp/pip-Iyxi7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:09 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)) 14:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:09 INFO - Running setup.py (path:/tmp/pip-XuCbYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:09 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)) 14:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:09 INFO - Running setup.py (path:/tmp/pip-2Iuaka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:09 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)) 14:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:09 INFO - Running setup.py (path:/tmp/pip-WqltaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:09 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)) 14:09:09 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)) 14:09:09 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)) 14:09:09 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)) 14:09:09 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)) 14:09:09 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)) 14:09:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09:11 INFO - Downloading blessings-1.6.tar.gz 14:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:09:11 INFO - Installing collected packages: blessings 14:09:11 INFO - Running setup.py install for blessings 14:09:11 INFO - Successfully installed blessings 14:09:11 INFO - Cleaning up... 14:09:11 INFO - Return code: 0 14:09:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:09:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:11 INFO - Reading from file tmpfile_stdout 14:09:11 INFO - Current package versions: 14:09:11 INFO - argparse == 1.2.1 14:09:11 INFO - blessings == 1.6 14:09:11 INFO - blobuploader == 1.2.4 14:09:11 INFO - docopt == 0.6.1 14:09:11 INFO - functools32 == 3.2.3-2 14:09:11 INFO - jsonschema == 2.5.1 14:09:11 INFO - manifestparser == 1.1 14:09:11 INFO - mozInstall == 1.12 14:09:11 INFO - mozcrash == 1.0 14:09:11 INFO - mozdebug == 0.1 14:09:11 INFO - mozdevice == 0.48 14:09:11 INFO - mozfile == 1.2 14:09:11 INFO - mozhttpd == 0.7 14:09:11 INFO - mozinfo == 0.9 14:09:11 INFO - mozleak == 0.1 14:09:11 INFO - mozlog == 3.4 14:09:11 INFO - moznetwork == 0.27 14:09:11 INFO - mozprocess == 0.23 14:09:11 INFO - mozprofile == 0.28 14:09:11 INFO - mozrunner == 6.13 14:09:11 INFO - mozscreenshot == 0.1 14:09:11 INFO - mozsystemmonitor == 0.3 14:09:11 INFO - moztest == 0.8 14:09:11 INFO - mozversion == 1.4 14:09:11 INFO - psutil == 3.1.1 14:09:11 INFO - requests == 1.2.3 14:09:11 INFO - wsgiref == 0.1.2 14:09:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:11 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')]} 14:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:11 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')]} 14:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:11 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 0x7f1733013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', '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 14:09:11 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 14:09:11 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 14:09:11 INFO - Using env: {'DISPLAY': ':0', 14:09:11 INFO - 'HOME': '/home/cltbld', 14:09:11 INFO - 'LANG': 'en_US.UTF-8', 14:09:11 INFO - 'LANGUAGE': 'en_US:en', 14:09:11 INFO - 'LOGNAME': 'cltbld', 14:09:11 INFO - 'MAIL': '/var/mail/cltbld', 14:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:11 INFO - 'MOZ_NO_REMOTE': '1', 14:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:11 INFO - 'NO_EM_RESTART': '1', 14:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:11 INFO - 'PWD': '/builds/slave/test', 14:09:11 INFO - 'SHELL': '/bin/bash', 14:09:11 INFO - 'SHLVL': '1', 14:09:11 INFO - 'TERM': 'linux', 14:09:11 INFO - 'TMOUT': '86400', 14:09:11 INFO - 'USER': 'cltbld', 14:09:11 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', 14:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:11 INFO - '_': '/tools/buildbot/bin/python'} 14:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:12 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)) 14:09:12 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)) 14:09:12 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)) 14:09:12 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)) 14:09:12 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)) 14:09:12 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)) 14:09:12 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)) 14:09:12 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)) 14:09:12 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)) 14:09:12 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)) 14:09:12 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)) 14:09:12 INFO - Cleaning up... 14:09:12 INFO - Return code: 0 14:09:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:12 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 0x7f1733013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, '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': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', '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 14:09:12 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 14:09:12 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 14:09:12 INFO - Using env: {'DISPLAY': ':0', 14:09:12 INFO - 'HOME': '/home/cltbld', 14:09:12 INFO - 'LANG': 'en_US.UTF-8', 14:09:12 INFO - 'LANGUAGE': 'en_US:en', 14:09:12 INFO - 'LOGNAME': 'cltbld', 14:09:12 INFO - 'MAIL': '/var/mail/cltbld', 14:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:12 INFO - 'MOZ_NO_REMOTE': '1', 14:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:12 INFO - 'NO_EM_RESTART': '1', 14:09:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:12 INFO - 'PWD': '/builds/slave/test', 14:09:12 INFO - 'SHELL': '/bin/bash', 14:09:12 INFO - 'SHLVL': '1', 14:09:12 INFO - 'TERM': 'linux', 14:09:12 INFO - 'TMOUT': '86400', 14:09:12 INFO - 'USER': 'cltbld', 14:09:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', 14:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:12 INFO - '_': '/tools/buildbot/bin/python'} 14:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:09:12 INFO - Cleaning up... 14:09:12 INFO - Return code: 0 14:09:12 INFO - Running post-action listener: _resource_record_post_action 14:09:12 INFO - Running post-action listener: _start_resource_monitoring 14:09:12 INFO - Starting resource monitoring. 14:09:12 INFO - [mozharness: 2017-02-05 22:09:12.470810Z] Finished create-virtualenv step (success) 14:09:12 INFO - [mozharness: 2017-02-05 22:09:12.471261Z] Running install step. 14:09:12 INFO - Running pre-action listener: _resource_record_pre_action 14:09:12 INFO - Running main action method: install 14:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:12 INFO - Reading from file tmpfile_stdout 14:09:12 INFO - Detecting whether we're running mozinstall >=1.0... 14:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:09:12 INFO - Reading from file tmpfile_stdout 14:09:12 INFO - Output received: 14:09:12 INFO - Usage: mozinstall [options] installer 14:09:12 INFO - Options: 14:09:12 INFO - -h, --help show this help message and exit 14:09:12 INFO - -d DEST, --destination=DEST 14:09:12 INFO - Directory to install application into. [default: 14:09:12 INFO - "/builds/slave/test"] 14:09:12 INFO - --app=APP Application being installed. [default: firefox] 14:09:12 INFO - mkdir: /builds/slave/test/build/application 14:09:12 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'] 14:09:12 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 14:09:26 INFO - Reading from file tmpfile_stdout 14:09:26 INFO - Output received: 14:09:26 INFO - /builds/slave/test/build/application/firefox/firefox 14:09:26 INFO - Running post-action listener: _resource_record_post_action 14:09:26 INFO - [mozharness: 2017-02-05 22:09:26.390798Z] Finished install step (success) 14:09:26 INFO - [mozharness: 2017-02-05 22:09:26.391040Z] Running run-tests step. 14:09:26 INFO - Running pre-action listener: _resource_record_pre_action 14:09:26 INFO - Running main action method: run_tests 14:09:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:09:26 INFO - Python 2.7.3 14:09:26 INFO - Return code: 0 14:09:26 INFO - grabbing minidump binary from tooltool 14:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:26 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 0x28b4f60>, '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 0x28b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:09:26 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 14:09:26 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 14:09:26 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 14:09:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:09:26 INFO - Return code: 0 14:09:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:09:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:09:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:09:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:09:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:09:26 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/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 14:09:26 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/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 14:09:26 INFO - Using env: {'DISPLAY': ':0', 14:09:26 INFO - 'HOME': '/home/cltbld', 14:09:26 INFO - 'LANG': 'en_US.UTF-8', 14:09:26 INFO - 'LANGUAGE': 'en_US:en', 14:09:26 INFO - 'LOGNAME': 'cltbld', 14:09:26 INFO - 'MAIL': '/var/mail/cltbld', 14:09:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:09:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:26 INFO - 'MOZ_NO_REMOTE': '1', 14:09:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:26 INFO - 'NO_EM_RESTART': '1', 14:09:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:26 INFO - 'PWD': '/builds/slave/test', 14:09:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:09:26 INFO - 'SHELL': '/bin/bash', 14:09:26 INFO - 'SHLVL': '1', 14:09:26 INFO - 'TERM': 'linux', 14:09:26 INFO - 'TMOUT': '86400', 14:09:26 INFO - 'USER': 'cltbld', 14:09:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1486332512.195918-154754451', 14:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:26 INFO - '_': '/tools/buildbot/bin/python'} 14:09:26 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/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 14:09:26 INFO - mozversion application_buildid: 20170205120809 14:09:26 INFO - mozversion application_changeset: e5373fbb022e1a227116a989d22929040bfabc3c 14:09:26 INFO - mozversion application_display_name: Firefox 14:09:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:09:26 INFO - mozversion application_name: Firefox 14:09:26 INFO - mozversion application_remotingname: firefox 14:09:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:09:26 INFO - mozversion application_vendor: Mozilla 14:09:26 INFO - mozversion application_version: 52.0 14:09:26 INFO - mozversion platform_buildid: 20170205120809 14:09:26 INFO - mozversion platform_changeset: e5373fbb022e1a227116a989d22929040bfabc3c 14:09:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:09:26 INFO - mozversion platform_version: 52.0 14:09:26 INFO - using testdate: 1486332566 14:09:26 INFO - actual date: 1486332566 14:09:26 INFO - starting webserver on 'localhost:54171' 14:09:26 INFO - SUITE-START | Running 2 tests 14:09:26 INFO - TEST-START | dromaeo_css 14:09:26 INFO - operating with platform_type : linux_ 14:09:26 INFO - Initialising browser for dromaeo_css test... 14:09:26 INFO - TEST-INFO | started process 23910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfHCExO/profile http://localhost:54171/getInfo.html) 14:09:31 INFO - PROCESS | 23910 | __metrics Screen width/height:1600/1200 14:09:31 INFO - PROCESS | 23910 | colorDepth:24 14:09:31 INFO - PROCESS | 23910 | Browser inner width/height: 1024/697 14:09:31 INFO - PROCESS | 23910 | __metrics 14:09:32 ERROR - PROCESS | 23910 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 14:09:32 INFO - TEST-INFO | 23910: exit 0 14:09:32 INFO - Browser initialized. 14:09:32 INFO - Running cycle 1/1 for dromaeo_css test... 14:09:32 INFO - TEST-INFO | started process 24040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfHCExO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:09:44 INFO - PROCESS | 24040 | RSS: Main: 147976192 14:09:44 INFO - PROCESS | 24040 | 14:12:44 INFO - PROCESS | 24040 | Cycle 1(1): loaded http://localhost:54171/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54171/tests/dromaeo/cssquery-ext.html) 14:12:45 INFO - PROCESS | 24040 | RSS: Main: 153866240 14:12:45 INFO - PROCESS | 24040 | 14:15:47 INFO - PROCESS | 24040 | Cycle 1(1): loaded http://localhost:54171/tests/dromaeo/cssquery-ext.html (next: http://localhost:54171/tests/dromaeo/cssquery-jquery.html) 14:15:47 INFO - PROCESS | 24040 | RSS: Main: 152702976 14:15:47 INFO - PROCESS | 24040 | 14:18:49 INFO - PROCESS | 24040 | Cycle 1(1): loaded http://localhost:54171/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54171/tests/dromaeo/cssquery-mootools.html) 14:18:50 INFO - PROCESS | 24040 | RSS: Main: 151248896 14:18:50 INFO - PROCESS | 24040 | 14:21:52 INFO - PROCESS | 24040 | Cycle 1(1): loaded http://localhost:54171/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54171/tests/dromaeo/cssquery-prototype.html) 14:21:52 INFO - PROCESS | 24040 | RSS: Main: 153112576 14:21:52 INFO - PROCESS | 24040 | 14:24:55 INFO - PROCESS | 24040 | Cycle 1(1): loaded http://localhost:54171/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54171/tests/dromaeo/cssquery-yui.html) 14:24:55 INFO - PROCESS | 24040 | RSS: Main: 154308608 14:24:55 INFO - PROCESS | 24040 | 14:27:58 INFO - PROCESS | 24040 | Cycle 1(1): loaded http://localhost:54171/tests/dromaeo/cssquery-yui.html (next: http://localhost:54171/tests/dromaeo/cssquery-dojo.html) 14:27:58 INFO - PROCESS | 24040 | RSS: Main: 155344896 14:27:58 INFO - PROCESS | 24040 | 14:27:58 INFO - PROCESS | 24040 | __start_tp_report 14:27:58 INFO - PROCESS | 24040 | _x_x_mozilla_page_load 14:27:58 INFO - PROCESS | 24040 | _x_x_mozilla_page_load_details 14:27:58 INFO - PROCESS | 24040 | |i|pagename|runs| 14:27:58 INFO - PROCESS | 24040 | |0;dojo.html;3307.553480280162;3333.9166520836975;3348.229907121362;3358.4122778513783;3366.8316584170784;5651.63264387815;5738.196652468658;5742.6841523716175;5765.538756899448;5788.247527821382;5587.106063029916;5792.991897599231;5804.216430781843;5804.2744656917885;5806.4483874032;5211.635185537014;5214.217867319904;5253.921191182136;5297.152455607104;5308.124159513695;5296.761645725952;5299.072662284104;5301.469853014706;5317.654352467097;5335.866603334928;5122.462141475147;5163.483651634844;5279.70961597112;5284.260203571503;5286.154215325549;5161;5194.194899790538;5243.239730239094;5284.207368894658;5324.5740340772645;5162.896742065138;5239.5546378557865;5240.973795131;5248.029114613809;5280.630355875091;5515;5700.7719691212305;5716.399778023289;5781.421857814227;5803.390643982363;5978.461938425519;6034.396560343975;6073.1497590337385;6116.938830611682;6118;6156.7845125420845;6165.907511387333;6177.073438984144;6197.566170368076;6224.751009959641;5808.128780682931;5810.099434587646;5814.476697097281;5816.302043754777;5819.534437245053;6125.296497837281;6157.291911430243;6195.783147589813;6249.843753906098;6272.874542509125;6000.8799824004145;6012.669303188279;6045.486133678599;6050.515958723292;6072.05883088122;5964.701764911737;6063.757449701962;6138.416850399205;6150.354212807681;6155.538334624921;6012.549058820518;6051.546134039964;6060.121282414026;6126.578745377165;6135.53983451234;6058.757649694051;6095.116208149793;6105.542084343692;6132.2947860996555;6136.693165341804;4595.1728688835665;4729;4731.716097034189;4739.952600473951;4752.002079563261;4130.91738165241;4143.6892233082635;4170.270202714512;4194.391813187131;4258.61672449481;5883.205767221456;5913.615614985099;5920.171176035358;5921.7631294747725;5932.169496270526;6185.505159587222;6188.319284878659;6191.504679625619;6209.627422354673;6211.9068213976825;5769.59612827098;5833.941660583425;5869.354371019184;5889.146073819358;5948.881022379528;5274.736263186825;5276.736163191825;5279.868003299872;5281.049411106038;5303.973480132652;6413.775517856852;6512.446442052478;6516.087747715229;6528.249251336062;6542.24764152119;6061.909071364022;6073.514118870568;6076.969615151896;6127.111568822406;6289.7484100635465;6336.20797400325;6392.456641185366;6399.7440102395385;6411.070394792822;6419.550631455753;5991.940080599313;6049.334573196857;6053.697315134314;6066.484348830399;6072.14989901423;5845.064789633639;5955.464008239279;6096;6136.7852125175405;6145.446909778141;5940.346561878277;6061.212042434631;6065.423784740443;6072.483838873569;6077.179580756541;6030.4572588467245;6061.787837425669;6071.180390647206;6076.058210977306;6078.027515597483;5827;5894.882102357843;6051.334353221054;6059.394060593905;6060.2424696912885;5983.730732116978;6066.848328791815;6089.878202436015;6119.076065312483;6133.64071396146;5931;5974.4324289192455;5981.850453738692;5982.670953097621;5985.850353741017 14:27:58 INFO - PROCESS | 24040 | |1;ext.html;577.1054864959312;607.8206928955958;645.6642545876143;675.854691241383;679.7145199016412;45779;46486;47021.52978470214;50048.24927626088;50226.49773502264;47760.52239477604;48124.518754812445;48447.51552484474;48525.51474485254;48608.51391486084;9078.86381704275;9166.129217724305;9215.585298661543;9218.262538996898;9223.44659320443;9044.09559044097;9095.590698418588;9124.726258212264;9127.589258483351;9136.72589822303;9153.450792952412;9185.265178785714;9189.127032931861;9209.677661281856;9218.86171707425;9064.048274931136;9138.54307284633;9147.17675409213;9162;9165.862512062324;9045.412048216846;9120.8631870522;9123.589438475285;9151.222146117589;9156.496392698398;45121.32318015232;45129.54870451319;45267.54732452666;45277.32084018742;45389.09221815545;3670.5228320318456;3850.9229815403537;3951.5258169019903;4120.134771697947;4374.03771170342;33497.497537536714;33703;33916.83041584801;34056.48915266273;34209;4429.756363400012;4449.755263460508;4496.100779844044;4508.481524624644;4591.586757191835;348019.2599037014;349356;350359;351748;352311;66455.66772166108;66669.66665166643;66743.33256667468;66822.33177668258;66932.66533667398;68710;69131.65434172798;69571.30428695648;69831.65084174546;69836.65081674559;16079.598010049609;16340.346386144422;16360;16374.83625163757;16425;13576.321183940763;13621.591352259447;13628.727425451436;13629.727405452033;13671;18911.243550257837;19895.60208795816;20051.699224511645;20055.298064567964;20162.798372016387;6395.584287021329;6555.573887697285;6592.538522303393;6632.933670663231;6714.429273511806;966.6278482784179;1038.85456036155;1085.777415629794;1092.4985421723356;1130.0451118804597;32488.675113248566;32942.50586241209;32943.176420589676;33293;33748.831255843565;1123.9494222759831;1125.836753670713;1193.8209268609605;1204.8915597596258;1232.870548592385;17372.913135434243;17530.561735956704;17659;17786.733199002025;18017.18922648484;550416;551017;554395;554853;556992;64218.35781642217;64868.35131648718;64903.35096648973;65412;65490.67254663696;1384.1487485196733;1393.4217299820664;1409.0700137909137;1414.6746248362933;1415.6248594122567;32058.19854503656;32544.51183232206;33342.33315333631;33343;33878;56314.43685563092;57170.714146429;57220.1416978754;57382;57399.426005739406;483600;483858;485166;485536;487323;31250.28047169124;31530.211744706565;31913.68086319107;32226.677733223307;32246.19384515406;51056;51291.9483220667;51563;51693.48306516887;52345.73827130992;42090.7895460533;43275.78362108169;43661;44889;44915.55084449114;42407.36388954106;42735.358969614856;43457.78271108624;43710.781446092566;44614;43098.56901431071;43231;46364.30453543132;46409.76795116138;46662;40902.795486022376;46184;46309.536904631874;46754.29868552042;47298;35525.82237088798;35536;35668.643313566536;35878;36241.637583624884 14:27:58 INFO - PROCESS | 24040 | |2;jquery.html;399.62834563855637;403.3506055251047;419.40025763158684;422.1283050500717;434.65227817745813;18805.62388752224;19725.50686232845;20120.69818952715;20284.39146825594;20483.18067277311;18308.816911830876;19033.714494282598;20315.18739250432;20738.68891966618;20876.58246835066;5618.213450116977;5865.706714664271;5873;5876.559258055663;5885.705714714269;4236.4704411948505;4368.301071828508;5728.541716662657;5794.971025144869;5804.883902321951;6619.900701489481;6693.129893113888;6705.899411508832;6732.528722989393;6733.966330168367;6176.351483094255;6189.535784816157;6199.132121502993;6425.7108430120525;6706.195256569218;5946.197263369433;5980.43185897339;5986.431289027535;5993.760249590011;6025.879482410371;23035.1937682182;23077.538449231088;23578.882105589535;23753.76246237533;24042.879785601133;2538.7968962482955;2556.3353528082835;2621.9868900655565;2695.6495655564845;2829.1653962081236;10808.729781755519;10947.4526273686;11258.493367798468;16191.271392787352;16240.918795406065;1998.740163778714;2051.712760213571;2100.096958307927;2129.659254519285;2139.2191849974647;103282.74126125619;105907;107957;108352;108515;18869.62260754777;19245.615087698166;19245.711314330296;19325.806741932684;19479.61040779205;35116.29767404638;35258;35291.823540882135;35338;35894;10028.197744180448;10180.694579162637;10186.949065254626;10241.43672098027;10330;8394.160583941679;8474.788130296669;8532.232099110986;8715;8719.956400218085;9240.3531752778;9495.38280011797;9523.666671666459;9536.52317384128;9658.32391732586;3345.6654334566347;3607.603163651996;3618.6048367787007;3770.359038963383;3877.903052423712;913.5112714697605;968.3995922527937;1017.0795430135739;1027.5735569738474;1088.9455527223606;18778.342758003404;19900.104495297746;19937.202511899362;19993.500162496053;20342.08460619246;1020.3163880200284;1033.89661033896;1045.534737042009;1063.9468026598795;1079.3685693869018;10403.5838566458;11063.225574209728;11126.443677816076;11134.665960021212;11188.888111118784;492123;494187;506520;514672;515353;97880;98418.50790746;99064.50467747616;100750;105939.47030264954;920.1074957291551;935.6818681648136;948.9383190092622;955.1737746849064;978.4325091447085;17231.310747569958;17597.824021759618;17716.379926702502;17812.46562603124;17950.820491794915;30362.696373035986;42098.78950605227;42534.787326063175;42663;44513.55486445094;59657.701711491165;59690;60135.69932150311;60694;61119;8571.185737354941;8600.827983440422;8658.78353041179;8722.215000649972;8753.912460875565;7088.2202957675645;10928.289661171999;11009.339439633648;11647.59233426826;12772.680682982627;10867.184961127788;10948.507317170906;10997.450127493434;11034.062104720868;11035.944820275847;5312.070387682063;8315.459495132796;10598.629047983284;11037.72405689832;11163.995240428401;11205.71985700364;11334.376609286568;11379.487923043318;11387.658370248906;11772.882271177521;8424.115467875785;8593.871091933752;8641.654333826576;8677.1756683115;8825.205731484197;8995.685151019683;11108.666739997812;11246.775064498828;11420.600278990196;11675.708107297045 14:27:58 INFO - PROCESS | 24040 | |3;mootools.html;1542.344503585976;1546.0646308983064;1719.8538124259437;1829.3414370826508;1844.8985305808183;7807.882881756778;8006.0793008804;8052.235037671412;8380.58097095145;8387.329013678915;8276.668933242663;8539;8542.572871356422;8704.260137888286;8713.956430217855;2481.3548477395916;2506.097804790274;2510.5104504621604;2511.660925775024;2514.798816094708;2411.2645643078854;2522.1676846640567;2531.0508559290265;2538.352720056383;2541.6949966004104;2421.891014904325;2455.9263222103364;2456.705195376557;2460;2474.3071939856777;2391.0794344177443;2397.6403539469134;2422.1401402502033;2432.9391765205833;2433.841800282976;2405.891734871935;2445.7554244575576;2445.8532488050773;2468.8888999995042;2469.172827102923;8989.325800564984;9034.322425818023;9049.728508144766;9059.773505662346;9065.456072635598;5421.891562168735;5629.437056294379;5642.74607642653;5644.689542075184;5671.6880571568545;3435.3129374125274;3527.5061491391225;3554.91112722184;3596.496490491333;3618.1316484043905;1096.8519249901242;1117.0002847451485;1133.0822034152363;1157.2015309436463;1159.1190695071723;11980.820287695604;11982.221155624944;12046.578369757017;12071.275723456532;12082.093842961813;4712.717236965793;4907.87730306738;4946.777395017233;4999.400071991312;5004.774785134678;10048.748781280527;10098.242631802497;10100.545475453475;10111.39331640104;10118.898811011943;5625.54995600351;5635.239242702265;5635.971820140873;5645.5483561314995;5646.350669672958;4421.4915284742665;4754.762261886892;5085.669431486942;5117.232415137759;5186.5850731941355;4174.186033723395;4192.811323490389;4256.8297268109545;4269.146170765859;4275.700700950903;1362.1214316765631;1373.986260137386;1374.3471850870756;1384.473899918045;1400.6288333591403;951.5242378810594;1006.0392325329293;1025.9230557708202;1036.3471013261596;1044.5404022230193;5703.001974654502;5722.856928576819;5741.684207368551;5744.253247077937;5843.3864444233595;486.2900165758033;494.24133954380574;498.925161225819;1043.838205078214;1059.782744537368;4044.7775372354213;4102;4115.629593336614;4178.247915375201;4216.704830661824;11038.668839934815;11336.773264534662;11363.602273920373;11388.974992250738;11398.316101033965;11047.171462140372;11058.447077646086;11153.442327883573;11166.944165279285;11298.774024519464;8151.062627797879;8195.508269503849;8242.752717418487;8353;8365.330773538102;5891.3224979127945;6043.002904520705;6103.267607887082;6156.138140660221;6161.599496032743;9712.320137590583;9930.553125109533;9966.252531060054;10169.644062457779;10220.846687299547;9930;9995.950020249853;10014;10096.141827944706;10360.792784144425;7325.230850760593;7479.70081196746;7547.5848828314965;7555.09338879338;7630.961845190738;8576.313894888519;8616.224539791448;8626.051134375088;8638.395312328328;8666.436681615674;7854.4894581851995;7877.409194310564;7902.051753789582;7940.086890007492;7986.8003299915645;7445.888311675438;7518.135414427192;7519.962400187964;7528.661210245443;7668.156502784801;6762.289959554176;6780.559263647847;6790.253072162157;6837.692303846438;6966.79099627012;5029.899402012013;5180.663256888291;5235.869103272448;5238.135707608354;5276.657017293864;5207.869803254949;5222.843314700565;5336.092864213016;5337.706426146599;5387 14:27:58 INFO - PROCESS | 24040 | |4;prototype.html;349.24214454633443;359.703244823021;363.1556630833313;363.8799196265232;364.7173440583549;5469.234307196985;5592.384837667863;5623.409541998088;5702.201691763146;5718.7426565804535;5427.348718153827;5514.862128446791;5564.693941833198;5574.554035677146;5588.524975377098;4396.934045989305;4414.933775993362;4417.5361587033385;4448.154850578396;4472.843450479234;4205.600467955554;4385.451818522684;4408.272635015219;4440.689151759379;4489.46126464823;4376.474823021226;4377.212101821671;4378.97810510947;4380.189664911985;4391.516933137353;4379.299312110047;4389.582989615981;4399.18615056214;4409.250427427345;4415.161119387339;3820.2550502651993;3860.2665493556133;3901.258760835432;3907.249040920691;3919.745216560943;5441.59188060897;5449.509544141047;5454.209139674765;5462.453754624546;5473.562115030788;5024.723640199788;5045.798168073273;5051.898962020776;5054.519820617073;5075.771590278447;5632.662040277596;5846.298444186725;5851.444112809277;5907.438793314628;5930.55520835939;4233.153369326147;4244;4255.234057869582;4255.765932873691;4284.764337961411;6150.786711102909;6170.167027451282;6177.362998805275;6181.6600086995195;6184.783532576384;4300.548442413564;4313.223619748475;4320.265554855682;4331.5018772840895;4420.403245561873;4376.474823021194;4388.780560971939;4405.140997505456;4407.867763967086;4430.645548356124;5026.597872170218;5032.119379108642;5044.419891712427;5078.466760990117;5080.288759573663;5819.73811178498;5821.708914554255;5961.913330334435;5982.49148822355;5999.250093738283;1480.7038592281372;1486.9739879483122;1488.5162322245314;1488.977665335021;1490.8061951946177;965.6813251627086;1011.8077565262577;1016.7204018894863;1035.3787727363672;1039.6673064619401;5557.221389305348;5568.911658128202;5595.496405323541;5616.466435688603;5617.438256174431;5774.48029677331;5781.768729250783;5795;5831.912521312183;5913.4867681236165;5389.844062375081;5478.534324582375;5510.311211098613;5562.805301814417;5586.217929489874;3128.6402063762503;3145.5596216529702;3156.2267244525237;3166.034359520322;3166.2401023754132;5890.558208134407;6073.210482637317;6103.572749907553;6118.265808102967;6165.907511387333;5889.823305300848;5933.537581903462;5970.522358211333;5970.820875373745;5980.192673988956;6065.757369705162;6085.939140608626;6089.756409743561;6097.292758027759;6110.633361998294;5705.515031222392;5720.656760594377;5809.709514524172;5867;5886.587938844411;5777.335606405317;5795.435806978762;5807.245058142415;5810.4189581041555;5862.208601838697;5956.583039187215;6084;6110.388961103854;6146.631202127886;6304.211973503312;4377.409049778239;4396.054848207651;4399.868003959887;4402.207602631557;4404.779761012001;5968.806688421673;6141.385861413823;6154.938450615616;6168.722407491763;6173.783917562864;5951.7619295227705;5957.761689532544;5967.522598192221;5969.671668058299;5993.940060599338;5933.554983376351;5964.850878728066;6010.819675409744;6028.5177185825905;6052.273727152769;5709.571782116275;5951.851203719942;5983.311919129182;6000.459958603747;6025.156478092983;6038.5772995889865;6041.18444010053;6058.485028772604;6079.966405710951;6086.169930982114;5678.545716342765;5832.24180856486;5866.823995280149;5868.559858010752;5893.145493903446 14:27:58 INFO - PROCESS | 24040 | |5;yui.html;749.4079677055126;770.1528318849266;851.1105894340413;866.7269810009848;884.2042162054153;14923;15377.308021139033;15434.459793907215;15559.222038898039;15857.682846343067;14472.131672099682;14675.486357977474;14693.33879975401;14786.18675972821;14803.481878134267;845.953472559009;860.7761981884693;861.9094995025526;863.6588547523725;864.3301441382915;847.588919374103;850.4387104511025;851.1148405658108;851.2168804699692;851.880736696863;905.0451773379083;908.2053203446984;909.417972497602;909.6816114359988;915.9404638698463;894.0433735902554;898.344208727626;898.8561830107152;904.2223687628667;909.963601455941;667.9813284740809;669.1234482827512;671.6104659297645;675.338168594775;676.6109487044969;13362;13438.32808359588;13442.059055866093;13454.260015699132;13489.932550337186;12429.813552796715;12447.937760311232;12529.310887901162;12582.81125783114;12759.362031898369;11055.778884422347;11138.33170009802;11201.159913006475;11237.83143252852;11385.203035787497;3838.098046958962;3925.8429662813737;3943.743656662308;4035.1122752994293;4072.450219220397;59252;59535;60461.6976915117;69830.99999999949;70371.64814175948;11921.821172682243;12007.279563226235;12146.635600931986;12398.5660501882;12518.248905065726;22271.109155633916;22481;22629;22645.547089058127;23107.422314441937;8584.8712269316;8655.567221638892;8729.563521823884;8742.781430464289;8871.866921996176;4601.148787474261;4709.081729062868;4773.069251495925;4815.590674792612;4867.634927380461;3375.1899544109237;3457.5850897892415;3493.1965647901125;3502.754807163474;3503.8248087595516;587.4448646029462;600.3276330509857;601.7021574320739;603.6770327874566;611.150500803883;691.7163962775238;731.5976213082783;771.4060173666246;789.467109700961;794.1066300412036;9698.272629552812;9892.505374731234;9950.900490995142;10031.799364012679;10198.541065652063;678.7861823525574;705.7036044861171;725.5247812682701;800.6317094136763;816.873384625384;4754.595859351924;4969.73081871397;4993.1262029144755;5009.549140577293;5079.187330027252;55661;75503;91495.54252228697;92337;97563;68364;80116;80846;81712.59143704362;81867.5906620475;73868.26131738721;73893.26106738864;75106.62446687731;76308;78726.99999999885;10132.898671013196;10387.117095047006;10430.895691043295;10458.111060559633;10604.946975265382;48888.75555622199;49783.751081244365;50652;50807.729806755124;51896.481035189165;61895.690521547105;62825.371746281955;69337;69916.30083699098;71517;12760.553380631633;12799;12953.740925181632;13728.65678358049;13841.100328478617;12747;12908.935455322664;14869;14913.850861491681;14951.25243737787;14036.78944815808;14089.365978531196;14169.291535423394;14701.338439770023;14730.2634868254;13734.65663358384;14288.499902503363;14714.852851471349;14997.625059373602;15216.619584510034;13969.58091257264;14041.648958776112;14503.274836258355;14827.887908406698;14993;11018.724531886766;11215.49530271156;11428.771424571629;11579.247348922294;11813.527458901548;10701.678949631523;11003.889961100287;11851.992580630744;12040.819387709367;12057 14:27:58 INFO - PROCESS | 24040 | __end_tp_report 14:27:58 INFO - PROCESS | 24040 | __start_cc_report 14:27:58 INFO - PROCESS | 24040 | _x_x_mozilla_cycle_collect,294 14:27:58 INFO - PROCESS | 24040 | __end_cc_report 14:27:58 INFO - PROCESS | 24040 | __startTimestamp1486333678487__endTimestamp 14:27:58 INFO - PROCESS | 24040 | 14:27:58 INFO - PROCESS | 24040 | ------- Summary: start ------- 14:27:58 INFO - PROCESS | 24040 | Number of tests: 6 14:27:58 INFO - PROCESS | 24040 | 14:27:58 INFO - PROCESS | 24040 | [#0] dojo.html Cycles:165 Average:5720.40 Median:5974.43 stddev:646.67 (10.8%) stddev-sans-first:620.33 14:27:58 INFO - PROCESS | 24040 | Values: 3307.6 3333.9 3348.2 3358.4 3366.8 5651.6 5738.2 5742.7 5765.5 5788.2 5587.1 5793.0 5804.2 5804.3 5806.4 5211.6 5214.2 5253.9 5297.2 5308.1 5296.8 5299.1 5301.5 5317.7 5335.9 5122.5 5163.5 5279.7 5284.3 5286.2 5161.0 5194.2 5243.2 5284.2 5324.6 5162.9 5239.6 5241.0 5248.0 5280.6 5515.0 5700.8 5716.4 5781.4 5803.4 5978.5 6034.4 6073.1 6116.9 6118.0 6156.8 6165.9 6177.1 6197.6 6224.8 5808.1 5810.1 5814.5 5816.3 5819.5 6125.3 6157.3 6195.8 6249.8 6272.9 6000.9 6012.7 6045.5 6050.5 6072.1 5964.7 6063.8 6138.4 6150.4 6155.5 6012.5 6051.5 6060.1 6126.6 6135.5 6058.8 6095.1 6105.5 6132.3 6136.7 4595.2 4729.0 4731.7 4740.0 4752.0 4130.9 4143.7 4170.3 4194.4 4258.6 5883.2 5913.6 5920.2 5921.8 5932.2 6185.5 6188.3 6191.5 6209.6 6211.9 5769.6 5833.9 5869.4 5889.1 5948.9 5274.7 5276.7 5279.9 5281.0 5304.0 6413.8 6512.4 6516.1 6528.2 6542.2 6061.9 6073.5 6077.0 6127.1 6289.7 6336.2 6392.5 6399.7 6411.1 6419.6 5991.9 6049.3 6053.7 6066.5 6072.1 5845.1 5955.5 6096.0 6136.8 6145.4 5940.3 6061.2 6065.4 6072.5 6077.2 6030.5 6061.8 6071.2 6076.1 6078.0 5827.0 5894.9 6051.3 6059.4 6060.2 5983.7 6066.8 6089.9 6119.1 6133.6 5931.0 5974.4 5981.9 5982.7 5985.9 14:27:58 INFO - PROCESS | 24040 | 14:27:58 INFO - PROCESS | 24040 | [#1] ext.html Cycles:180 Average:64392.75 Median:45584.05 stddev:124678.94 (273.5%) stddev-sans-first:124936.63 14:27:58 INFO - PROCESS | 24040 | Values: 577.1 607.8 645.7 675.9 679.7 45779.0 46486.0 47021.5 50048.2 50226.5 47760.5 48124.5 48447.5 48525.5 48608.5 9078.9 9166.1 9215.6 9218.3 9223.4 9044.1 9095.6 9124.7 9127.6 9136.7 9153.5 9185.3 9189.1 9209.7 9218.9 9064.0 9138.5 9147.2 9162.0 9165.9 9045.4 9120.9 9123.6 9151.2 9156.5 45121.3 45129.5 45267.5 45277.3 45389.1 3670.5 3850.9 3951.5 4120.1 4374.0 33497.5 33703.0 33916.8 34056.5 34209.0 4429.8 4449.8 4496.1 4508.5 4591.6 348019.3 349356.0 350359.0 351748.0 352311.0 66455.7 66669.7 66743.3 66822.3 66932.7 68710.0 69131.7 69571.3 69831.7 69836.7 16079.6 16340.3 16360.0 16374.8 16425.0 13576.3 13621.6 13628.7 13629.7 13671.0 18911.2 19895.6 20051.7 20055.3 20162.8 6395.6 6555.6 6592.5 6632.9 6714.4 966.6 1038.9 1085.8 1092.5 1130.0 32488.7 32942.5 32943.2 33293.0 33748.8 1123.9 1125.8 1193.8 1204.9 1232.9 17372.9 17530.6 17659.0 17786.7 18017.2 550416.0 551017.0 554395.0 554853.0 556992.0 64218.4 64868.4 64903.4 65412.0 65490.7 1384.1 1393.4 1409.1 1414.7 1415.6 32058.2 32544.5 33342.3 33343.0 33878.0 56314.4 57170.7 57220.1 57382.0 57399.4 483600.0 483858.0 485166.0 485536.0 487323.0 31250.3 31530.2 31913.7 32226.7 32246.2 51056.0 51291.9 51563.0 51693.5 52345.7 42090.8 43275.8 43661.0 44889.0 44915.6 42407.4 42735.4 43457.8 43710.8 44614.0 43098.6 43231.0 46364.3 46409.8 46662.0 40902.8 46184.0 46309.5 46754.3 47298.0 35525.8 35536.0 35668.6 35878.0 36241.6 14:27:58 INFO - PROCESS | 24040 | 14:27:58 INFO - PROCESS | 24040 | [#2] jquery.html Cycles:180 Average:31457.75 Median:16595.93 stddev:83738.07 (504.6%) stddev-sans-first:83940.51 14:27:58 INFO - PROCESS | 24040 | Values: 399.6 403.4 419.4 422.1 434.7 18805.6 19725.5 20120.7 20284.4 20483.2 18308.8 19033.7 20315.2 20738.7 20876.6 5618.2 5865.7 5873.0 5876.6 5885.7 4236.5 4368.3 5728.5 5795.0 5804.9 6619.9 6693.1 6705.9 6732.5 6734.0 6176.4 6189.5 6199.1 6425.7 6706.2 5946.2 5980.4 5986.4 5993.8 6025.9 23035.2 23077.5 23578.9 23753.8 24042.9 2538.8 2556.3 2622.0 2695.6 2829.2 10808.7 10947.5 11258.5 16191.3 16240.9 1998.7 2051.7 2100.1 2129.7 2139.2 103282.7 105907.0 107957.0 108352.0 108515.0 18869.6 19245.6 19245.7 19325.8 19479.6 35116.3 35258.0 35291.8 35338.0 35894.0 10028.2 10180.7 10186.9 10241.4 10330.0 8394.2 8474.8 8532.2 8715.0 8720.0 9240.4 9495.4 9523.7 9536.5 9658.3 3345.7 3607.6 3618.6 3770.4 3877.9 913.5 968.4 1017.1 1027.6 1088.9 18778.3 19900.1 19937.2 19993.5 20342.1 1020.3 1033.9 1045.5 1063.9 1079.4 10403.6 11063.2 11126.4 11134.7 11188.9 492123.0 494187.0 506520.0 514672.0 515353.0 97880.0 98418.5 99064.5 100750.0 105939.5 920.1 935.7 948.9 955.2 978.4 17231.3 17597.8 17716.4 17812.5 17950.8 30362.7 42098.8 42534.8 42663.0 44513.6 59657.7 59690.0 60135.7 60694.0 61119.0 8571.2 8600.8 8658.8 8722.2 8753.9 7088.2 10928.3 11009.3 11647.6 12772.7 10867.2 10948.5 10997.5 11034.1 11035.9 5312.1 8315.5 10598.6 11037.7 11164.0 11205.7 11334.4 11379.5 11387.7 11772.9 8424.1 8593.9 8641.7 8677.2 8825.2 8995.7 11108.7 11246.8 11420.6 11675.7 14:27:58 INFO - PROCESS | 24040 | 14:27:58 INFO - PROCESS | 24040 | [#3] mootools.html Cycles:180 Average:5850.25 Median:2701.06 stddev:3243.41 (120.1%) stddev-sans-first:3236.35 14:27:58 INFO - PROCESS | 24040 | Values: 1542.3 1546.1 1719.9 1829.3 1844.9 7807.9 8006.1 8052.2 8380.6 8387.3 8276.7 8539.0 8542.6 8704.3 8714.0 2481.4 2506.1 2510.5 2511.7 2514.8 2411.3 2522.2 2531.1 2538.4 2541.7 2421.9 2455.9 2456.7 2460.0 2474.3 2391.1 2397.6 2422.1 2432.9 2433.8 2405.9 2445.8 2445.9 2468.9 2469.2 8989.3 9034.3 9049.7 9059.8 9065.5 5421.9 5629.4 5642.7 5644.7 5671.7 3435.3 3527.5 3554.9 3596.5 3618.1 1096.9 1117.0 1133.1 1157.2 1159.1 11980.8 11982.2 12046.6 12071.3 12082.1 4712.7 4907.9 4946.8 4999.4 5004.8 10048.7 10098.2 10100.5 10111.4 10118.9 5625.5 5635.2 5636.0 5645.5 5646.4 4421.5 4754.8 5085.7 5117.2 5186.6 4174.2 4192.8 4256.8 4269.1 4275.7 1362.1 1374.0 1374.3 1384.5 1400.6 951.5 1006.0 1025.9 1036.3 1044.5 5703.0 5722.9 5741.7 5744.3 5843.4 486.3 494.2 498.9 1043.8 1059.8 4044.8 4102.0 4115.6 4178.2 4216.7 11038.7 11336.8 11363.6 11389.0 11398.3 11047.2 11058.4 11153.4 11166.9 11298.8 8151.1 8195.5 8242.8 8353.0 8365.3 5891.3 6043.0 6103.3 6156.1 6161.6 9712.3 9930.6 9966.3 10169.6 10220.8 9930.0 9996.0 10014.0 10096.1 10360.8 7325.2 7479.7 7547.6 7555.1 7631.0 8576.3 8616.2 8626.1 8638.4 8666.4 7854.5 7877.4 7902.1 7940.1 7986.8 7445.9 7518.1 7520.0 7528.7 7668.2 6762.3 6780.6 6790.3 6837.7 6966.8 5029.9 5180.7 5235.9 5238.1 5276.7 5207.9 5222.8 5336.1 5337.7 5387.0 14:27:58 INFO - PROCESS | 24040 | 14:27:58 INFO - PROCESS | 24040 | [#4] prototype.html Cycles:180 Average:4949.52 Median:5587.37 stddev:1440.96 (25.8%) stddev-sans-first:1403.02 14:27:58 INFO - PROCESS | 24040 | Values: 349.2 359.7 363.2 363.9 364.7 5469.2 5592.4 5623.4 5702.2 5718.7 5427.3 5514.9 5564.7 5574.6 5588.5 4396.9 4414.9 4417.5 4448.2 4472.8 4205.6 4385.5 4408.3 4440.7 4489.5 4376.5 4377.2 4379.0 4380.2 4391.5 4379.3 4389.6 4399.2 4409.3 4415.2 3820.3 3860.3 3901.3 3907.2 3919.7 5441.6 5449.5 5454.2 5462.5 5473.6 5024.7 5045.8 5051.9 5054.5 5075.8 5632.7 5846.3 5851.4 5907.4 5930.6 4233.2 4244.0 4255.2 4255.8 4284.8 6150.8 6170.2 6177.4 6181.7 6184.8 4300.5 4313.2 4320.3 4331.5 4420.4 4376.5 4388.8 4405.1 4407.9 4430.6 5026.6 5032.1 5044.4 5078.5 5080.3 5819.7 5821.7 5961.9 5982.5 5999.3 1480.7 1487.0 1488.5 1489.0 1490.8 965.7 1011.8 1016.7 1035.4 1039.7 5557.2 5568.9 5595.5 5616.5 5617.4 5774.5 5781.8 5795.0 5831.9 5913.5 5389.8 5478.5 5510.3 5562.8 5586.2 3128.6 3145.6 3156.2 3166.0 3166.2 5890.6 6073.2 6103.6 6118.3 6165.9 5889.8 5933.5 5970.5 5970.8 5980.2 6065.8 6085.9 6089.8 6097.3 6110.6 5705.5 5720.7 5809.7 5867.0 5886.6 5777.3 5795.4 5807.2 5810.4 5862.2 5956.6 6084.0 6110.4 6146.6 6304.2 4377.4 4396.1 4399.9 4402.2 4404.8 5968.8 6141.4 6154.9 6168.7 6173.8 5951.8 5957.8 5967.5 5969.7 5993.9 5933.6 5964.9 6010.8 6028.5 6052.3 5709.6 5951.9 5983.3 6000.5 6025.2 6038.6 6041.2 6058.5 6080.0 6086.2 5678.5 5832.2 5866.8 5868.6 5893.1 14:27:58 INFO - PROCESS | 24040 | 14:27:58 INFO - PROCESS | 24040 | [#5] yui.html Cycles:180 Average:18532.71 Median:4794.33 stddev:24203.30 (504.8%) stddev-sans-first:24234.36 14:27:58 INFO - PROCESS | 24040 | Values: 749.4 770.2 851.1 866.7 884.2 14923.0 15377.3 15434.5 15559.2 15857.7 14472.1 14675.5 14693.3 14786.2 14803.5 846.0 860.8 861.9 863.7 864.3 847.6 850.4 851.1 851.2 851.9 905.0 908.2 909.4 909.7 915.9 894.0 898.3 898.9 904.2 910.0 668.0 669.1 671.6 675.3 676.6 13362.0 13438.3 13442.1 13454.3 13489.9 12429.8 12447.9 12529.3 12582.8 12759.4 11055.8 11138.3 11201.2 11237.8 11385.2 3838.1 3925.8 3943.7 4035.1 4072.5 59252.0 59535.0 60461.7 69831.0 70371.6 11921.8 12007.3 12146.6 12398.6 12518.2 22271.1 22481.0 22629.0 22645.5 23107.4 8584.9 8655.6 8729.6 8742.8 8871.9 4601.1 4709.1 4773.1 4815.6 4867.6 3375.2 3457.6 3493.2 3502.8 3503.8 587.4 600.3 601.7 603.7 611.2 691.7 731.6 771.4 789.5 794.1 9698.3 9892.5 9950.9 10031.8 10198.5 678.8 705.7 725.5 800.6 816.9 4754.6 4969.7 4993.1 5009.5 5079.2 55661.0 75503.0 91495.5 92337.0 97563.0 68364.0 80116.0 80846.0 81712.6 81867.6 73868.3 73893.3 75106.6 76308.0 78727.0 10132.9 10387.1 10430.9 10458.1 10604.9 48888.8 49783.8 50652.0 50807.7 51896.5 61895.7 62825.4 69337.0 69916.3 71517.0 12760.6 12799.0 12953.7 13728.7 13841.1 12747.0 12908.9 14869.0 14913.9 14951.3 14036.8 14089.4 14169.3 14701.3 14730.3 13734.7 14288.5 14714.9 14997.6 15216.6 13969.6 14041.6 14503.3 14827.9 14993.0 11018.7 11215.5 11428.8 11579.2 11813.5 10701.7 11003.9 11852.0 12040.8 12057.0 14:27:58 INFO - PROCESS | 24040 | -------- Summary: end -------- 14:27:58 INFO - PROCESS | 24040 | 14:27:59 INFO - TEST-INFO | 24040: exit 0 14:27:59 INFO - TEST-OK | dromaeo_css | took 1112595ms 14:27:59 INFO - TEST-START | kraken 14:27:59 INFO - operating with platform_type : linux_ 14:27:59 INFO - Initialising browser for kraken test... 14:27:59 INFO - TEST-INFO | started process 24402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU39tiJ/profile http://localhost:54171/getInfo.html) 14:28:03 INFO - PROCESS | 24402 | __metrics Screen width/height:1600/1200 14:28:03 INFO - PROCESS | 24402 | colorDepth:24 14:28:03 INFO - PROCESS | 24402 | Browser inner width/height: 1024/697 14:28:03 INFO - PROCESS | 24402 | __metrics 14:28:04 ERROR - PROCESS | 24402 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 14:28:04 INFO - TEST-INFO | 24402: exit 0 14:28:04 INFO - Browser initialized. 14:28:04 INFO - Running cycle 1/1 for kraken test... 14:28:04 INFO - TEST-INFO | started process 24533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU39tiJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:16 INFO - PROCESS | 24533 | RSS: Main: 147890176 14:28:16 INFO - PROCESS | 24533 | 14:28:19 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:54171/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54171/tests/kraken/driver.html?testName=audio-beat-detection) 14:28:20 INFO - PROCESS | 24533 | RSS: Main: 153772032 14:28:20 INFO - PROCESS | 24533 | 14:28:22 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:54171/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54171/tests/kraken/driver.html?testName=audio-dft) 14:28:23 INFO - PROCESS | 24533 | RSS: Main: 152477696 14:28:23 INFO - PROCESS | 24533 | 14:28:26 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:54171/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54171/tests/kraken/driver.html?testName=audio-fft) 14:28:27 INFO - PROCESS | 24533 | RSS: Main: 153235456 14:28:27 INFO - PROCESS | 24533 | 14:28:29 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:54171/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54171/tests/kraken/driver.html?testName=audio-oscillator) 14:28:29 INFO - PROCESS | 24533 | RSS: Main: 152780800 14:28:29 INFO - PROCESS | 24533 | 14:28:31 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:54171/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54171/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:28:32 INFO - PROCESS | 24533 | RSS: Main: 152608768 14:28:32 INFO - PROCESS | 24533 | 14:28:35 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:54171/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54171/tests/kraken/driver.html?testName=imaging-darkroom) 14:28:35 INFO - PROCESS | 24533 | RSS: Main: 155209728 14:28:35 INFO - PROCESS | 24533 | 14:28:39 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:54171/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54171/tests/kraken/driver.html?testName=imaging-desaturate) 14:28:39 INFO - PROCESS | 24533 | RSS: Main: 155480064 14:28:39 INFO - PROCESS | 24533 | 14:28:42 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:54171/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54171/tests/kraken/driver.html?testName=json-parse-financial) 14:28:43 INFO - PROCESS | 24533 | RSS: Main: 155254784 14:28:43 INFO - PROCESS | 24533 | 14:28:44 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:54171/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54171/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:28:45 INFO - PROCESS | 24533 | RSS: Main: 154611712 14:28:45 INFO - PROCESS | 24533 | 14:28:47 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:54171/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54171/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:28:47 INFO - PROCESS | 24533 | RSS: Main: 154681344 14:28:47 INFO - PROCESS | 24533 | 14:28:49 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:54171/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54171/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:28:50 INFO - PROCESS | 24533 | RSS: Main: 154886144 14:28:50 INFO - PROCESS | 24533 | 14:28:52 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:54171/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:28:53 INFO - PROCESS | 24533 | RSS: Main: 154664960 14:28:53 INFO - PROCESS | 24533 | 14:28:56 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:54171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:28:57 INFO - PROCESS | 24533 | RSS: Main: 155066368 14:28:57 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | Cycle 1(1): loaded http://localhost:54171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54171/tests/kraken/driver.html?testName=ai-astar) 14:28:58 INFO - PROCESS | 24533 | RSS: Main: 156819456 14:28:58 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | __start_tp_report 14:28:58 INFO - PROCESS | 24533 | _x_x_mozilla_page_load 14:28:58 INFO - PROCESS | 24533 | _x_x_mozilla_page_load_details 14:28:58 INFO - PROCESS | 24533 | |i|pagename|runs| 14:28:58 INFO - PROCESS | 24533 | |0;ai-astar;105;112;112;114;114;117;116;112;113;113 14:28:58 INFO - PROCESS | 24533 | |1;audio-beat-detection;148;117;118;157;122;127;124;120;160;119 14:28:58 INFO - PROCESS | 24533 | |2;audio-dft;165;165;165;163;161;162;161;161;163;159 14:28:58 INFO - PROCESS | 24533 | |3;audio-fft;75;76;76;116;75;75;76;75;98;76 14:28:58 INFO - PROCESS | 24533 | |4;audio-oscillator;82;82;113;83;82;81;105;81;83;119 14:28:58 INFO - PROCESS | 24533 | |5;imaging-gaussian-blur;120;118;117;118;117;118;118;118;120;118 14:28:58 INFO - PROCESS | 24533 | |6;imaging-darkroom;147;147;147;148;147;147;147;147;148;147 14:28:58 INFO - PROCESS | 24533 | |7;imaging-desaturate;86;85;88;89;85;85;85;85;85;84 14:28:58 INFO - PROCESS | 24533 | |8;json-parse-financial;50;52;51;51;52;56;50;52;56;51 14:28:58 INFO - PROCESS | 24533 | |9;json-stringify-tinderbox;60;60;64;60;61;60;61;60;60;60 14:28:58 INFO - PROCESS | 24533 | |10;stanford-crypto-aes;74;74;78;73;75;73;73;81;76;74 14:28:58 INFO - PROCESS | 24533 | |11;stanford-crypto-ccm;124;131;125;124;123;124;130;124;163;122 14:28:58 INFO - PROCESS | 24533 | |12;stanford-crypto-pbkdf2;157;158;163;154;159;156;162;157;155;163 14:28:58 INFO - PROCESS | 24533 | |13;stanford-crypto-sha256-iterative;64;63;64;64;66;63;65;63;61;62 14:28:58 INFO - PROCESS | 24533 | __end_tp_report 14:28:58 INFO - PROCESS | 24533 | __start_cc_report 14:28:58 INFO - PROCESS | 24533 | _x_x_mozilla_cycle_collect,768 14:28:58 INFO - PROCESS | 24533 | __end_cc_report 14:28:58 INFO - PROCESS | 24533 | __startTimestamp1486333738926__endTimestamp 14:28:58 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | ------- Summary: start ------- 14:28:58 INFO - PROCESS | 24533 | Number of tests: 14 14:28:58 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.50 stddev:3.22 (2.8%) stddev-sans-first:1.80 14:28:58 INFO - PROCESS | 24533 | Values: 105.0 112.0 112.0 114.0 114.0 117.0 116.0 112.0 113.0 113.0 14:28:58 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:125.50 stddev:16.94 (13.5%) stddev-sans-first:16.84 14:28:58 INFO - PROCESS | 24533 | Values: 148.0 117.0 118.0 157.0 122.0 127.0 124.0 120.0 160.0 119.0 14:28:58 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:2.07 (1.3%) stddev-sans-first:1.99 14:28:58 INFO - PROCESS | 24533 | Values: 165.0 165.0 165.0 163.0 161.0 162.0 161.0 161.0 163.0 159.0 14:28:58 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:13.95 (18.4%) stddev-sans-first:14.58 14:28:58 INFO - PROCESS | 24533 | Values: 75.0 76.0 76.0 116.0 75.0 75.0 76.0 75.0 98.0 76.0 14:28:58 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:82.00 stddev:15.04 (18.3%) stddev-sans-first:15.58 14:28:58 INFO - PROCESS | 24533 | Values: 82.0 82.0 113.0 83.0 82.0 81.0 105.0 81.0 83.0 119.0 14:28:58 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.03 (0.9%) stddev-sans-first:0.87 14:28:58 INFO - PROCESS | 24533 | Values: 120.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 120.0 118.0 14:28:58 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 14:28:58 INFO - PROCESS | 24533 | Values: 147.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 148.0 147.0 14:28:58 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:85.00 stddev:1.57 (1.8%) stddev-sans-first:1.66 14:28:58 INFO - PROCESS | 24533 | Values: 86.0 85.0 88.0 89.0 85.0 85.0 85.0 85.0 85.0 84.0 14:28:58 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:2.18 (4.2%) stddev-sans-first:2.18 14:28:58 INFO - PROCESS | 24533 | Values: 50.0 52.0 51.0 51.0 52.0 56.0 50.0 52.0 56.0 51.0 14:28:58 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.00 stddev:1.26 (2.1%) stddev-sans-first:1.32 14:28:58 INFO - PROCESS | 24533 | Values: 60.0 60.0 64.0 60.0 61.0 60.0 61.0 60.0 60.0 60.0 14:28:58 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:74.50 stddev:2.60 (3.5%) stddev-sans-first:2.73 14:28:58 INFO - PROCESS | 24533 | Values: 74.0 74.0 78.0 73.0 75.0 73.0 73.0 81.0 76.0 74.0 14:28:58 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:124.50 stddev:12.30 (9.9%) stddev-sans-first:12.91 14:28:58 INFO - PROCESS | 24533 | Values: 124.0 131.0 125.0 124.0 123.0 124.0 130.0 124.0 163.0 122.0 14:28:58 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:158.50 stddev:3.27 (2.1%) stddev-sans-first:3.43 14:28:58 INFO - PROCESS | 24533 | Values: 157.0 158.0 163.0 154.0 159.0 156.0 162.0 157.0 155.0 163.0 14:28:58 INFO - PROCESS | 24533 | 14:28:58 INFO - PROCESS | 24533 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.43 (2.2%) stddev-sans-first:1.51 14:28:58 INFO - PROCESS | 24533 | Values: 64.0 63.0 64.0 64.0 66.0 63.0 65.0 63.0 61.0 62.0 14:28:58 INFO - PROCESS | 24533 | -------- Summary: end -------- 14:28:58 INFO - PROCESS | 24533 | 14:28:59 INFO - TEST-INFO | 24533: exit 0 14:29:00 INFO - TEST-OK | kraken | took 60764ms 14:29:00 INFO - SUITE-END | took 1173s 14:29:00 INFO - Completed test suite (00:19:33) 14:29:00 INFO - javascript benchmark 14:29:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7634.632257057856, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.553480280162, 3333.9166520836975, 3348.229907121362, 3358.4122778513783, 3366.8316584170784, 5651.63264387815, 5738.196652468658, 5742.6841523716175, 5765.538756899448, 5788.247527821382, 5587.106063029916, 5792.991897599231, 5804.216430781843, 5804.2744656917885, 5806.4483874032, 5211.635185537014, 5214.217867319904, 5253.921191182136, 5297.152455607104, 5308.124159513695, 5296.761645725952, 5299.072662284104, 5301.469853014706, 5317.654352467097, 5335.866603334928, 5122.462141475147, 5163.483651634844, 5279.70961597112, 5284.260203571503, 5286.154215325549, 5161.0, 5194.194899790538, 5243.239730239094, 5284.207368894658, 5324.5740340772645, 5162.896742065138, 5239.5546378557865, 5240.973795131, 5248.029114613809, 5280.630355875091, 5515.0, 5700.7719691212305, 5716.399778023289, 5781.421857814227, 5803.390643982363, 5978.461938425519, 6034.396560343975, 6073.1497590337385, 6116.938830611682, 6118.0, 6156.7845125420845, 6165.907511387333, 6177.073438984144, 6197.566170368076, 6224.751009959641, 5808.128780682931, 5810.099434587646, 5814.476697097281, 5816.302043754777, 5819.534437245053, 6125.296497837281, 6157.291911430243, 6195.783147589813, 6249.843753906098, 6272.874542509125, 6000.8799824004145, 6012.669303188279, 6045.486133678599, 6050.515958723292, 6072.05883088122, 5964.701764911737, 6063.757449701962, 6138.416850399205, 6150.354212807681, 6155.538334624921, 6012.549058820518, 6051.546134039964, 6060.121282414026, 6126.578745377165, 6135.53983451234, 6058.757649694051, 6095.116208149793, 6105.542084343692, 6132.2947860996555, 6136.693165341804, 4595.1728688835665, 4729.0, 4731.716097034189, 4739.952600473951, 4752.002079563261, 4130.91738165241, 4143.6892233082635, 4170.270202714512, 4194.391813187131, 4258.61672449481, 5883.205767221456, 5913.615614985099, 5920.171176035358, 5921.7631294747725, 5932.169496270526, 6185.505159587222, 6188.319284878659, 6191.504679625619, 6209.627422354673, 6211.9068213976825, 5769.59612827098, 5833.941660583425, 5869.354371019184, 5889.146073819358, 5948.881022379528, 5274.736263186825, 5276.736163191825, 5279.868003299872, 5281.049411106038, 5303.973480132652, 6413.775517856852, 6512.446442052478, 6516.087747715229, 6528.249251336062, 6542.24764152119, 6061.909071364022, 6073.514118870568, 6076.969615151896, 6127.111568822406, 6289.7484100635465, 6336.20797400325, 6392.456641185366, 6399.7440102395385, 6411.070394792822, 6419.550631455753, 5991.940080599313, 6049.334573196857, 6053.697315134314, 6066.484348830399, 6072.14989901423, 5845.064789633639, 5955.464008239279, 6096.0, 6136.7852125175405, 6145.446909778141, 5940.346561878277, 6061.212042434631, 6065.423784740443, 6072.483838873569, 6077.179580756541, 6030.4572588467245, 6061.787837425669, 6071.180390647206, 6076.058210977306, 6078.027515597483, 5827.0, 5894.882102357843, 6051.334353221054, 6059.394060593905, 6060.2424696912885, 5983.730732116978, 6066.848328791815, 6089.878202436015, 6119.076065312483, 6133.64071396146, 5931.0, 5974.4324289192455, 5981.850453738692, 5982.670953097621, 5985.850353741017], "value": 5676.885925609705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.1054864959312, 607.8206928955958, 645.6642545876143, 675.854691241383, 679.7145199016412, 45779.0, 46486.0, 47021.52978470214, 50048.24927626088, 50226.49773502264, 47760.52239477604, 48124.518754812445, 48447.51552484474, 48525.51474485254, 48608.51391486084, 9078.86381704275, 9166.129217724305, 9215.585298661543, 9218.262538996898, 9223.44659320443, 9044.09559044097, 9095.590698418588, 9124.726258212264, 9127.589258483351, 9136.72589822303, 9153.450792952412, 9185.265178785714, 9189.127032931861, 9209.677661281856, 9218.86171707425, 9064.048274931136, 9138.54307284633, 9147.17675409213, 9162.0, 9165.862512062324, 9045.412048216846, 9120.8631870522, 9123.589438475285, 9151.222146117589, 9156.496392698398, 45121.32318015232, 45129.54870451319, 45267.54732452666, 45277.32084018742, 45389.09221815545, 3670.5228320318456, 3850.9229815403537, 3951.5258169019903, 4120.134771697947, 4374.03771170342, 33497.497537536714, 33703.0, 33916.83041584801, 34056.48915266273, 34209.0, 4429.756363400012, 4449.755263460508, 4496.100779844044, 4508.481524624644, 4591.586757191835, 348019.2599037014, 349356.0, 350359.0, 351748.0, 352311.0, 66455.66772166108, 66669.66665166643, 66743.33256667468, 66822.33177668258, 66932.66533667398, 68710.0, 69131.65434172798, 69571.30428695648, 69831.65084174546, 69836.65081674559, 16079.598010049609, 16340.346386144422, 16360.0, 16374.83625163757, 16425.0, 13576.321183940763, 13621.591352259447, 13628.727425451436, 13629.727405452033, 13671.0, 18911.243550257837, 19895.60208795816, 20051.699224511645, 20055.298064567964, 20162.798372016387, 6395.584287021329, 6555.573887697285, 6592.538522303393, 6632.933670663231, 6714.429273511806, 966.6278482784179, 1038.85456036155, 1085.777415629794, 1092.4985421723356, 1130.0451118804597, 32488.675113248566, 32942.50586241209, 32943.176420589676, 33293.0, 33748.831255843565, 1123.9494222759831, 1125.836753670713, 1193.8209268609605, 1204.8915597596258, 1232.870548592385, 17372.913135434243, 17530.561735956704, 17659.0, 17786.733199002025, 18017.18922648484, 550416.0, 551017.0, 554395.0, 554853.0, 556992.0, 64218.35781642217, 64868.35131648718, 64903.35096648973, 65412.0, 65490.67254663696, 1384.1487485196733, 1393.4217299820664, 1409.0700137909137, 1414.6746248362933, 1415.6248594122567, 32058.19854503656, 32544.51183232206, 33342.33315333631, 33343.0, 33878.0, 56314.43685563092, 57170.714146429, 57220.1416978754, 57382.0, 57399.426005739406, 483600.0, 483858.0, 485166.0, 485536.0, 487323.0, 31250.28047169124, 31530.211744706565, 31913.68086319107, 32226.677733223307, 32246.19384515406, 51056.0, 51291.9483220667, 51563.0, 51693.48306516887, 52345.73827130992, 42090.7895460533, 43275.78362108169, 43661.0, 44889.0, 44915.55084449114, 42407.36388954106, 42735.358969614856, 43457.78271108624, 43710.781446092566, 44614.0, 43098.56901431071, 43231.0, 46364.30453543132, 46409.76795116138, 46662.0, 40902.795486022376, 46184.0, 46309.536904631874, 46754.29868552042, 47298.0, 35525.82237088798, 35536.0, 35668.643313566536, 35878.0, 36241.637583624884], "value": 21512.59369760615, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.62834563855637, 403.3506055251047, 419.40025763158684, 422.1283050500717, 434.65227817745813, 18805.62388752224, 19725.50686232845, 20120.69818952715, 20284.39146825594, 20483.18067277311, 18308.816911830876, 19033.714494282598, 20315.18739250432, 20738.68891966618, 20876.58246835066, 5618.213450116977, 5865.706714664271, 5873.0, 5876.559258055663, 5885.705714714269, 4236.4704411948505, 4368.301071828508, 5728.541716662657, 5794.971025144869, 5804.883902321951, 6619.900701489481, 6693.129893113888, 6705.899411508832, 6732.528722989393, 6733.966330168367, 6176.351483094255, 6189.535784816157, 6199.132121502993, 6425.7108430120525, 6706.195256569218, 5946.197263369433, 5980.43185897339, 5986.431289027535, 5993.760249590011, 6025.879482410371, 23035.1937682182, 23077.538449231088, 23578.882105589535, 23753.76246237533, 24042.879785601133, 2538.7968962482955, 2556.3353528082835, 2621.9868900655565, 2695.6495655564845, 2829.1653962081236, 10808.729781755519, 10947.4526273686, 11258.493367798468, 16191.271392787352, 16240.918795406065, 1998.740163778714, 2051.712760213571, 2100.096958307927, 2129.659254519285, 2139.2191849974647, 103282.74126125619, 105907.0, 107957.0, 108352.0, 108515.0, 18869.62260754777, 19245.615087698166, 19245.711314330296, 19325.806741932684, 19479.61040779205, 35116.29767404638, 35258.0, 35291.823540882135, 35338.0, 35894.0, 10028.197744180448, 10180.694579162637, 10186.949065254626, 10241.43672098027, 10330.0, 8394.160583941679, 8474.788130296669, 8532.232099110986, 8715.0, 8719.956400218085, 9240.3531752778, 9495.38280011797, 9523.666671666459, 9536.52317384128, 9658.32391732586, 3345.6654334566347, 3607.603163651996, 3618.6048367787007, 3770.359038963383, 3877.903052423712, 913.5112714697605, 968.3995922527937, 1017.0795430135739, 1027.5735569738474, 1088.9455527223606, 18778.342758003404, 19900.104495297746, 19937.202511899362, 19993.500162496053, 20342.08460619246, 1020.3163880200284, 1033.89661033896, 1045.534737042009, 1063.9468026598795, 1079.3685693869018, 10403.5838566458, 11063.225574209728, 11126.443677816076, 11134.665960021212, 11188.888111118784, 492123.0, 494187.0, 506520.0, 514672.0, 515353.0, 97880.0, 98418.50790746, 99064.50467747616, 100750.0, 105939.47030264954, 920.1074957291551, 935.6818681648136, 948.9383190092622, 955.1737746849064, 978.4325091447085, 17231.310747569958, 17597.824021759618, 17716.379926702502, 17812.46562603124, 17950.820491794915, 30362.696373035986, 42098.78950605227, 42534.787326063175, 42663.0, 44513.55486445094, 59657.701711491165, 59690.0, 60135.69932150311, 60694.0, 61119.0, 8571.185737354941, 8600.827983440422, 8658.78353041179, 8722.215000649972, 8753.912460875565, 7088.2202957675645, 10928.289661171999, 11009.339439633648, 11647.59233426826, 12772.680682982627, 10867.184961127788, 10948.507317170906, 10997.450127493434, 11034.062104720868, 11035.944820275847, 5312.070387682063, 8315.459495132796, 10598.629047983284, 11037.72405689832, 11163.995240428401, 11205.71985700364, 11334.376609286568, 11379.487923043318, 11387.658370248906, 11772.882271177521, 8424.115467875785, 8593.871091933752, 8641.654333826576, 8677.1756683115, 8825.205731484197, 8995.685151019683, 11108.666739997812, 11246.775064498828, 11420.600278990196, 11675.708107297045], "value": 10228.9137007613, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1542.344503585976, 1546.0646308983064, 1719.8538124259437, 1829.3414370826508, 1844.8985305808183, 7807.882881756778, 8006.0793008804, 8052.235037671412, 8380.58097095145, 8387.329013678915, 8276.668933242663, 8539.0, 8542.572871356422, 8704.260137888286, 8713.956430217855, 2481.3548477395916, 2506.097804790274, 2510.5104504621604, 2511.660925775024, 2514.798816094708, 2411.2645643078854, 2522.1676846640567, 2531.0508559290265, 2538.352720056383, 2541.6949966004104, 2421.891014904325, 2455.9263222103364, 2456.705195376557, 2460.0, 2474.3071939856777, 2391.0794344177443, 2397.6403539469134, 2422.1401402502033, 2432.9391765205833, 2433.841800282976, 2405.891734871935, 2445.7554244575576, 2445.8532488050773, 2468.8888999995042, 2469.172827102923, 8989.325800564984, 9034.322425818023, 9049.728508144766, 9059.773505662346, 9065.456072635598, 5421.891562168735, 5629.437056294379, 5642.74607642653, 5644.689542075184, 5671.6880571568545, 3435.3129374125274, 3527.5061491391225, 3554.91112722184, 3596.496490491333, 3618.1316484043905, 1096.8519249901242, 1117.0002847451485, 1133.0822034152363, 1157.2015309436463, 1159.1190695071723, 11980.820287695604, 11982.221155624944, 12046.578369757017, 12071.275723456532, 12082.093842961813, 4712.717236965793, 4907.87730306738, 4946.777395017233, 4999.400071991312, 5004.774785134678, 10048.748781280527, 10098.242631802497, 10100.545475453475, 10111.39331640104, 10118.898811011943, 5625.54995600351, 5635.239242702265, 5635.971820140873, 5645.5483561314995, 5646.350669672958, 4421.4915284742665, 4754.762261886892, 5085.669431486942, 5117.232415137759, 5186.5850731941355, 4174.186033723395, 4192.811323490389, 4256.8297268109545, 4269.146170765859, 4275.700700950903, 1362.1214316765631, 1373.986260137386, 1374.3471850870756, 1384.473899918045, 1400.6288333591403, 951.5242378810594, 1006.0392325329293, 1025.9230557708202, 1036.3471013261596, 1044.5404022230193, 5703.001974654502, 5722.856928576819, 5741.684207368551, 5744.253247077937, 5843.3864444233595, 486.2900165758033, 494.24133954380574, 498.925161225819, 1043.838205078214, 1059.782744537368, 4044.7775372354213, 4102.0, 4115.629593336614, 4178.247915375201, 4216.704830661824, 11038.668839934815, 11336.773264534662, 11363.602273920373, 11388.974992250738, 11398.316101033965, 11047.171462140372, 11058.447077646086, 11153.442327883573, 11166.944165279285, 11298.774024519464, 8151.062627797879, 8195.508269503849, 8242.752717418487, 8353.0, 8365.330773538102, 5891.3224979127945, 6043.002904520705, 6103.267607887082, 6156.138140660221, 6161.599496032743, 9712.320137590583, 9930.553125109533, 9966.252531060054, 10169.644062457779, 10220.846687299547, 9930.0, 9995.950020249853, 10014.0, 10096.141827944706, 10360.792784144425, 7325.230850760593, 7479.70081196746, 7547.5848828314965, 7555.09338879338, 7630.961845190738, 8576.313894888519, 8616.224539791448, 8626.051134375088, 8638.395312328328, 8666.436681615674, 7854.4894581851995, 7877.409194310564, 7902.051753789582, 7940.086890007492, 7986.8003299915645, 7445.888311675438, 7518.135414427192, 7519.962400187964, 7528.661210245443, 7668.156502784801, 6762.289959554176, 6780.559263647847, 6790.253072162157, 6837.692303846438, 6966.79099627012, 5029.899402012013, 5180.663256888291, 5235.869103272448, 5238.135707608354, 5276.657017293864, 5207.869803254949, 5222.843314700565, 5336.092864213016, 5337.706426146599, 5387.0], "value": 4709.512139679799, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.24214454633443, 359.703244823021, 363.1556630833313, 363.8799196265232, 364.7173440583549, 5469.234307196985, 5592.384837667863, 5623.409541998088, 5702.201691763146, 5718.7426565804535, 5427.348718153827, 5514.862128446791, 5564.693941833198, 5574.554035677146, 5588.524975377098, 4396.934045989305, 4414.933775993362, 4417.5361587033385, 4448.154850578396, 4472.843450479234, 4205.600467955554, 4385.451818522684, 4408.272635015219, 4440.689151759379, 4489.46126464823, 4376.474823021226, 4377.212101821671, 4378.97810510947, 4380.189664911985, 4391.516933137353, 4379.299312110047, 4389.582989615981, 4399.18615056214, 4409.250427427345, 4415.161119387339, 3820.2550502651993, 3860.2665493556133, 3901.258760835432, 3907.249040920691, 3919.745216560943, 5441.59188060897, 5449.509544141047, 5454.209139674765, 5462.453754624546, 5473.562115030788, 5024.723640199788, 5045.798168073273, 5051.898962020776, 5054.519820617073, 5075.771590278447, 5632.662040277596, 5846.298444186725, 5851.444112809277, 5907.438793314628, 5930.55520835939, 4233.153369326147, 4244.0, 4255.234057869582, 4255.765932873691, 4284.764337961411, 6150.786711102909, 6170.167027451282, 6177.362998805275, 6181.6600086995195, 6184.783532576384, 4300.548442413564, 4313.223619748475, 4320.265554855682, 4331.5018772840895, 4420.403245561873, 4376.474823021194, 4388.780560971939, 4405.140997505456, 4407.867763967086, 4430.645548356124, 5026.597872170218, 5032.119379108642, 5044.419891712427, 5078.466760990117, 5080.288759573663, 5819.73811178498, 5821.708914554255, 5961.913330334435, 5982.49148822355, 5999.250093738283, 1480.7038592281372, 1486.9739879483122, 1488.5162322245314, 1488.977665335021, 1490.8061951946177, 965.6813251627086, 1011.8077565262577, 1016.7204018894863, 1035.3787727363672, 1039.6673064619401, 5557.221389305348, 5568.911658128202, 5595.496405323541, 5616.466435688603, 5617.438256174431, 5774.48029677331, 5781.768729250783, 5795.0, 5831.912521312183, 5913.4867681236165, 5389.844062375081, 5478.534324582375, 5510.311211098613, 5562.805301814417, 5586.217929489874, 3128.6402063762503, 3145.5596216529702, 3156.2267244525237, 3166.034359520322, 3166.2401023754132, 5890.558208134407, 6073.210482637317, 6103.572749907553, 6118.265808102967, 6165.907511387333, 5889.823305300848, 5933.537581903462, 5970.522358211333, 5970.820875373745, 5980.192673988956, 6065.757369705162, 6085.939140608626, 6089.756409743561, 6097.292758027759, 6110.633361998294, 5705.515031222392, 5720.656760594377, 5809.709514524172, 5867.0, 5886.587938844411, 5777.335606405317, 5795.435806978762, 5807.245058142415, 5810.4189581041555, 5862.208601838697, 5956.583039187215, 6084.0, 6110.388961103854, 6146.631202127886, 6304.211973503312, 4377.409049778239, 4396.054848207651, 4399.868003959887, 4402.207602631557, 4404.779761012001, 5968.806688421673, 6141.385861413823, 6154.938450615616, 6168.722407491763, 6173.783917562864, 5951.7619295227705, 5957.761689532544, 5967.522598192221, 5969.671668058299, 5993.940060599338, 5933.554983376351, 5964.850878728066, 6010.819675409744, 6028.5177185825905, 6052.273727152769, 5709.571782116275, 5951.851203719942, 5983.311919129182, 6000.459958603747, 6025.156478092983, 6038.5772995889865, 6041.18444010053, 6058.485028772604, 6079.966405710951, 6086.169930982114, 5678.545716342765, 5832.24180856486, 5866.823995280149, 5868.559858010752, 5893.145493903446], "value": 4491.687804046801, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.4079677055126, 770.1528318849266, 851.1105894340413, 866.7269810009848, 884.2042162054153, 14923.0, 15377.308021139033, 15434.459793907215, 15559.222038898039, 15857.682846343067, 14472.131672099682, 14675.486357977474, 14693.33879975401, 14786.18675972821, 14803.481878134267, 845.953472559009, 860.7761981884693, 861.9094995025526, 863.6588547523725, 864.3301441382915, 847.588919374103, 850.4387104511025, 851.1148405658108, 851.2168804699692, 851.880736696863, 905.0451773379083, 908.2053203446984, 909.417972497602, 909.6816114359988, 915.9404638698463, 894.0433735902554, 898.344208727626, 898.8561830107152, 904.2223687628667, 909.963601455941, 667.9813284740809, 669.1234482827512, 671.6104659297645, 675.338168594775, 676.6109487044969, 13362.0, 13438.32808359588, 13442.059055866093, 13454.260015699132, 13489.932550337186, 12429.813552796715, 12447.937760311232, 12529.310887901162, 12582.81125783114, 12759.362031898369, 11055.778884422347, 11138.33170009802, 11201.159913006475, 11237.83143252852, 11385.203035787497, 3838.098046958962, 3925.8429662813737, 3943.743656662308, 4035.1122752994293, 4072.450219220397, 59252.0, 59535.0, 60461.6976915117, 69830.99999999949, 70371.64814175948, 11921.821172682243, 12007.279563226235, 12146.635600931986, 12398.5660501882, 12518.248905065726, 22271.109155633916, 22481.0, 22629.0, 22645.547089058127, 23107.422314441937, 8584.8712269316, 8655.567221638892, 8729.563521823884, 8742.781430464289, 8871.866921996176, 4601.148787474261, 4709.081729062868, 4773.069251495925, 4815.590674792612, 4867.634927380461, 3375.1899544109237, 3457.5850897892415, 3493.1965647901125, 3502.754807163474, 3503.8248087595516, 587.4448646029462, 600.3276330509857, 601.7021574320739, 603.6770327874566, 611.150500803883, 691.7163962775238, 731.5976213082783, 771.4060173666246, 789.467109700961, 794.1066300412036, 9698.272629552812, 9892.505374731234, 9950.900490995142, 10031.799364012679, 10198.541065652063, 678.7861823525574, 705.7036044861171, 725.5247812682701, 800.6317094136763, 816.873384625384, 4754.595859351924, 4969.73081871397, 4993.1262029144755, 5009.549140577293, 5079.187330027252, 55661.0, 75503.0, 91495.54252228697, 92337.0, 97563.0, 68364.0, 80116.0, 80846.0, 81712.59143704362, 81867.5906620475, 73868.26131738721, 73893.26106738864, 75106.62446687731, 76308.0, 78726.99999999885, 10132.898671013196, 10387.117095047006, 10430.895691043295, 10458.111060559633, 10604.946975265382, 48888.75555622199, 49783.751081244365, 50652.0, 50807.729806755124, 51896.481035189165, 61895.690521547105, 62825.371746281955, 69337.0, 69916.30083699098, 71517.0, 12760.553380631633, 12799.0, 12953.740925181632, 13728.65678358049, 13841.100328478617, 12747.0, 12908.935455322664, 14869.0, 14913.850861491681, 14951.25243737787, 14036.78944815808, 14089.365978531196, 14169.291535423394, 14701.338439770023, 14730.2634868254, 13734.65663358384, 14288.499902503363, 14714.852851471349, 14997.625059373602, 15216.619584510034, 13969.58091257264, 14041.648958776112, 14503.274836258355, 14827.887908406698, 14993.0, 11018.724531886766, 11215.49530271156, 11428.771424571629, 11579.247348922294, 11813.527458901548, 10701.678949631523, 11003.889961100287, 11851.992580630744, 12040.819387709367, 12057.0], "value": 7493.178975464964, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1469.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 112.0, 114.0, 114.0, 117.0, 116.0, 112.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 118.0, 157.0, 122.0, 127.0, 124.0, 120.0, 160.0, 119.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 165.0, 163.0, 161.0, 162.0, 161.0, 161.0, 163.0, 159.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 116.0, 75.0, 75.0, 76.0, 75.0, 98.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 113.0, 83.0, 82.0, 81.0, 105.0, 81.0, 83.0, 119.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 120.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 88.0, 89.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 51.0, 51.0, 52.0, 56.0, 50.0, 52.0, 56.0, 51.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 64.0, 60.0, 61.0, 60.0, 61.0, 60.0, 60.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 78.0, 73.0, 75.0, 73.0, 73.0, 81.0, 76.0, 74.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 131.0, 125.0, 124.0, 123.0, 124.0, 130.0, 124.0, 163.0, 122.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 163.0, 154.0, 159.0, 156.0, 162.0, 157.0, 155.0, 163.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 66.0, 63.0, 65.0, 63.0, 61.0, 62.0], "value": 63.5, "unit": "score"}]}]} 14:29:00 INFO - Return code: 0 14:29:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:29:00 ERROR - # TBPL SUCCESS # 14:29:00 INFO - Running post-action listener: _resource_record_post_action 14:29:00 INFO - [mozharness: 2017-02-05 22:29:00.220439Z] Finished run-tests step (success) 14:29:00 INFO - Running post-run listener: _resource_record_post_run 14:29:00 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 319229952; Read time: 40; Write time: 175780 14:29:00 INFO - TinderboxPrint: CPU usage
13.2% 14:29:00 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 40 14:29:00 INFO - TinderboxPrint: I/O write bytes / time
319,229,952 / 175,780 14:29:00 INFO - TinderboxPrint: CPU idle
8,217.4 (86.8%) 14:29:00 INFO - TinderboxPrint: CPU user
1,200.4 (12.7%) 14:29:00 INFO - TinderboxPrint: Swap in / out
0 / 0 14:29:00 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 97259520; Read time: 0; Write time: 74792 14:29:00 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 218112000; Read time: 40; Write time: 100504 14:29:00 INFO - Running post-run listener: _upload_blobber_files 14:29:00 INFO - Blob upload gear active. 14:29:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:29:00 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 14:29:00 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'] 14:29:00 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 14:29:01 INFO - (blobuploader) - INFO - Open directory for files ... 14:29:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:29:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:29:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:02 INFO - (blobuploader) - INFO - Done attempting. 14:29:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:29:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:29:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:03 INFO - (blobuploader) - INFO - Done attempting. 14:29:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:29:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:07 INFO - (blobuploader) - INFO - Done attempting. 14:29:07 INFO - (blobuploader) - INFO - Iteration through files over. 14:29:07 INFO - Return code: 0 14:29:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:29:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:29:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08d068c2ee7e39461641cdd6126284aed1aca7b6de731d491c7fdd6097f2f9753c1cbbe2a474d2d3d2b6b9dec57ce24af4dc996673d5fd02674eadc33f1ce415", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aeb4018209aac8842ad2b485715255e4a60c66d916069a62d44aae073db6b8baff825083c430465e6a3d3e3e6f4a5c3a657428c89755bb5122b15c5657cbc861", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/947c77b517d7db084149173104e1e36922a34d3f58c6b14009b92d021b745743b21a9ee53b5b1fe0009ace6d69f34ae921d21380b7affb02d76bb3860fbbc2ec"} 14:29:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:29:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:29:07 INFO - Contents: 14:29:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08d068c2ee7e39461641cdd6126284aed1aca7b6de731d491c7fdd6097f2f9753c1cbbe2a474d2d3d2b6b9dec57ce24af4dc996673d5fd02674eadc33f1ce415", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aeb4018209aac8842ad2b485715255e4a60c66d916069a62d44aae073db6b8baff825083c430465e6a3d3e3e6f4a5c3a657428c89755bb5122b15c5657cbc861", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/947c77b517d7db084149173104e1e36922a34d3f58c6b14009b92d021b745743b21a9ee53b5b1fe0009ace6d69f34ae921d21380b7affb02d76bb3860fbbc2ec"} 14:29:07 INFO - Running post-run listener: copy_logs_to_upload_dir 14:29:07 INFO - Copying logs to upload dir... 14:29:07 INFO - mkdir: /builds/slave/test/build/upload/logs 14:29:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.997609 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-02-05 14:29:07.120411) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-05 14:29:07.124130) ========= 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=7de08804244eb36560b44971000001c3-1486332512.195918-154754451 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/08d068c2ee7e39461641cdd6126284aed1aca7b6de731d491c7fdd6097f2f9753c1cbbe2a474d2d3d2b6b9dec57ce24af4dc996673d5fd02674eadc33f1ce415", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aeb4018209aac8842ad2b485715255e4a60c66d916069a62d44aae073db6b8baff825083c430465e6a3d3e3e6f4a5c3a657428c89755bb5122b15c5657cbc861", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/947c77b517d7db084149173104e1e36922a34d3f58c6b14009b92d021b745743b21a9ee53b5b1fe0009ace6d69f34ae921d21380b7affb02d76bb3860fbbc2ec"} build_url:https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/NrWRQuQKS3qSwjgB75CvBg/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/08d068c2ee7e39461641cdd6126284aed1aca7b6de731d491c7fdd6097f2f9753c1cbbe2a474d2d3d2b6b9dec57ce24af4dc996673d5fd02674eadc33f1ce415", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aeb4018209aac8842ad2b485715255e4a60c66d916069a62d44aae073db6b8baff825083c430465e6a3d3e3e6f4a5c3a657428c89755bb5122b15c5657cbc861", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/947c77b517d7db084149173104e1e36922a34d3f58c6b14009b92d021b745743b21a9ee53b5b1fe0009ace6d69f34ae921d21380b7affb02d76bb3860fbbc2ec"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-05 14:29:07.149194) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 14:29:07.149564) ========= 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=7de08804244eb36560b44971000001c3-1486332512.195918-154754451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 14:29:07.231682) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-05 14:29:07.232012) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-05 14:29:07.232398) ========= ========= Total master_lag: 0.17 =========