builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1487091571.84 results: success (0) buildid: 20170214070945 builduid: 15eb97c329c14a38b448e071f7a15064 revision: 3a0e9dab386403cec5b899eb7f321c2aa27e0186 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 08:59:31.836094) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 08:59:31.836561) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 08:59:31.836845) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 08:59:31.853140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 08:59:31.853456) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-14 08:59: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% 45.9M=0s 2017-02-14 08:59:32 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120897 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 08:59:31.988492) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 08:59:31.988858) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017203 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 08:59:32.039775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 08:59:32.040144) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3a0e9dab386403cec5b899eb7f321c2aa27e0186 --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 3a0e9dab386403cec5b899eb7f321c2aa27e0186 --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=516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-14 08:59:32,632 truncating revision to first 12 chars 2017-02-14 08:59:32,632 Setting DEBUG logging. 2017-02-14 08:59:32,632 attempt 1/10 2017-02-14 08:59:32,632 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3a0e9dab3864?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-14 08:59:33,793 unpacking tar archive at: mozilla-beta-3a0e9dab3864/testing/mozharness/ program finished with exit code 0 elapsedTime=1.428121 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 08:59:33.481505) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 08:59:33.481831) ========= script_repo_revision: 3a0e9dab386403cec5b899eb7f321c2aa27e0186 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 08:59:33.482225) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 08:59:33.482504) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 08:59:33.491517) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-02-14 08:59:33.491858) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:59:34 INFO - MultiFileLogger online at 20170214 08:59:34 in /builds/slave/test 08:59: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 08:59:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:59:34 INFO - {'append_to_log': False, 08:59:34 INFO - 'base_work_dir': '/builds/slave/test', 08:59:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:59:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:59:34 INFO - 'branch': 'Mozilla-Beta', 08:59:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:59:34 INFO - 'config_files': ('talos/linux_config.py',), 08:59:34 INFO - 'default_actions': ('clobber', 08:59:34 INFO - 'read-buildbot-config', 08:59:34 INFO - 'download-and-extract', 08:59:34 INFO - 'populate-webroot', 08:59:34 INFO - 'create-virtualenv', 08:59:34 INFO - 'install', 08:59:34 INFO - 'run-tests'), 08:59:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:59:34 INFO - 'download_minidump_stackwalk': True, 08:59:34 INFO - 'download_symbols': 'ondemand', 08:59:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:59:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:59:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:59:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:59:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:59:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:59:34 INFO - 'installer_path': 'installer.exe', 08:59:34 INFO - 'log_level': 'info', 08:59:34 INFO - 'log_name': 'talos', 08:59:34 INFO - 'log_to_console': True, 08:59:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:59:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:59:34 INFO - 'opt_config_files': (), 08:59:34 INFO - 'pip_index': False, 08:59:34 INFO - 'sps_profile': False, 08:59:34 INFO - 'sps_profile_interval': 0, 08:59:34 INFO - 'suite': 'dromaeojs-e10s', 08:59:34 INFO - 'system_bits': '32', 08:59:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:59:34 INFO - 'title': 'talos-linux64-ix-061', 08:59:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:59:34 INFO - 'use_talos_json': True, 08:59:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:59:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:59:34 INFO - 'work_dir': 'build'} 08:59:34 INFO - [mozharness: 2017-02-14 16:59:34.175927Z] Running clobber step. 08:59:34 INFO - Running pre-action listener: _resource_record_pre_action 08:59:34 INFO - Running main action method: clobber 08:59:34 INFO - rmtree: /builds/slave/test/build 08:59:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:59:35 INFO - Running post-action listener: _resource_record_post_action 08:59:35 INFO - [mozharness: 2017-02-14 16:59:35.160597Z] Finished clobber step (success) 08:59:35 INFO - [mozharness: 2017-02-14 16:59:35.160696Z] Running read-buildbot-config step. 08:59:35 INFO - Running pre-action listener: _resource_record_pre_action 08:59:35 INFO - Running main action method: read_buildbot_config 08:59:35 INFO - Using buildbot properties: 08:59:35 INFO - { 08:59:35 INFO - "project": "", 08:59:35 INFO - "product": "firefox", 08:59:35 INFO - "script_repo_revision": "production", 08:59:35 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:59:35 INFO - "repository": "", 08:59:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 08:59:35 INFO - "buildid": "20170214070945", 08:59:35 INFO - "pgo_build": "True", 08:59:35 INFO - "basedir": "/builds/slave/test", 08:59:35 INFO - "buildnumber": 335, 08:59:35 INFO - "slavename": "talos-linux64-ix-061", 08:59:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:59:35 INFO - "platform": "ubuntu64_hw", 08:59:35 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:59:35 INFO - "branch": "mozilla-beta", 08:59:35 INFO - "repo_path": "releases/mozilla-beta", 08:59:35 INFO - "revision": "3a0e9dab386403cec5b899eb7f321c2aa27e0186", 08:59:35 INFO - "stage_platform": "linux64-pgo", 08:59:35 INFO - "builduid": "15eb97c329c14a38b448e071f7a15064", 08:59:35 INFO - "slavebuilddir": "test" 08:59:35 INFO - } 08:59:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 08:59:35 INFO - Running post-action listener: _resource_record_post_action 08:59:35 INFO - [mozharness: 2017-02-14 16:59:35.163124Z] Finished read-buildbot-config step (success) 08:59:35 INFO - [mozharness: 2017-02-14 16:59:35.163213Z] Running download-and-extract step. 08:59:35 INFO - Running pre-action listener: _resource_record_pre_action 08:59:35 INFO - Running main action method: download_and_extract 08:59:35 INFO - mkdir: /builds/slave/test/build/tests 08:59: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')]} 08:59:35 INFO - trying https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 08:59:35 INFO - Downloading https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 08:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:59:35 INFO - Downloaded 1327 bytes. 08:59:35 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 08:59:35 INFO - Using the following test package requirements: 08:59:35 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 08:59:35 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:59:35 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:59:35 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:59:35 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 08:59:35 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:59:35 INFO - u'jsshell-linux-x86_64.zip'], 08:59:35 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:59:35 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:59:35 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 08:59:35 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:59:35 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 08:59:35 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:59:35 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 08:59:35 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:59:35 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:59:35 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:59:35 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:59:35 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:59:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 08:59:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:59:35 INFO - Fetch https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 08:59:36 INFO - Http code: 200 08:59:36 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 08:59:36 INFO - x-amz-cf-id: rD6SagPBuXxblOMF3yPcOaYSKc0yIjaIcmoQTmwHhLiWw9fE9rpg4A== 08:59:36 INFO - x-amz-version-id: SxiVmDD7S_.Qf9CNcCMgSqMQUWdQchA7 08:59:36 INFO - Expected file size: 21958830 08:59:36 INFO - Obtained file size: 21958830 08:59:40 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:59:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 08:59:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:59:40 INFO - Fetch https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 08:59:41 INFO - Http code: 200 08:59:41 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 08:59:41 INFO - x-amz-cf-id: QxK7KkbPHsH4GqnGsu3BaM6ynde_oGTLrEJ_T8zWUA1wyVMeZHg0qw== 08:59:41 INFO - x-amz-version-id: SxiVmDD7S_.Qf9CNcCMgSqMQUWdQchA7 08:59:41 INFO - Expected file size: 21958830 08:59:41 INFO - Obtained file size: 21958830 08:59:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 08:59:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:59:45 INFO - Fetch https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 08:59:46 INFO - Http code: 200 08:59:46 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 08:59:46 INFO - x-amz-cf-id: z5OkyOdizqM2vIX-yblZsJCznTQ9-30FctrUrJvvwFmIpd5_5yMZlw== 08:59:46 INFO - x-amz-version-id: g2W4cAWlDnqtIBahIIHwka7gd6lqYrMq 08:59:46 INFO - Expected file size: 14403005 08:59:46 INFO - Obtained file size: 14403005 08:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:46 INFO - trying https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 08:59:46 INFO - Downloading https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 08:59:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:59:47 INFO - Downloaded 57753670 bytes. 08:59:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 08:59:47 INFO - mkdir: /builds/slave/test/properties 08:59:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:59:47 INFO - Writing to file /builds/slave/test/properties/build_url 08:59:47 INFO - Contents: 08:59:47 INFO - build_url:https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 08:59:48 INFO - Running post-action listener: _resource_record_post_action 08:59:48 INFO - Running post-action listener: set_extra_try_arguments 08:59:48 INFO - [mozharness: 2017-02-14 16:59:48.426594Z] Finished download-and-extract step (success) 08:59:48 INFO - [mozharness: 2017-02-14 16:59:48.426820Z] Running populate-webroot step. 08:59:48 INFO - Running pre-action listener: _resource_record_pre_action 08:59:48 INFO - Running main action method: populate_webroot 08:59:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:59:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:59:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:59:48 INFO - '--tppagecycles', 08:59:48 INFO - '7'], 08:59:48 INFO - 'tests': ['tsvgm']}}, 08:59:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:59:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:59:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:59:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:59:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:59:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:59:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:48 INFO - 'talos_options': ['--disable-e10s'], 08:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:48 INFO - 'talos_options': ['--disable-e10s'], 08:59:48 INFO - 'tests': ['damp', 'tps']}, 08:59:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:48 INFO - 'tests': ['damp', 'tps']}, 08:59:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:59:48 INFO - 'tests': ['dromaeo_dom']}, 08:59:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:59:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:59:48 INFO - 'tests': ['basic_compositor_video']}, 08:59:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:59:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:59:48 INFO - 'tests': ['a11yr', 08:59:48 INFO - 'ts_paint', 08:59:48 INFO - 'tpaint', 08:59:48 INFO - 'sessionrestore', 08:59:48 INFO - 'sessionrestore_no_auto_restore', 08:59:48 INFO - 'tabpaint']}, 08:59:48 INFO - 'other-e10s': {'tests': ['a11yr', 08:59:48 INFO - 'ts_paint', 08:59:48 INFO - 'tpaint', 08:59:48 INFO - 'sessionrestore', 08:59:48 INFO - 'sessionrestore_no_auto_restore', 08:59:48 INFO - 'tabpaint']}, 08:59:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:59:48 INFO - 'ts_paint', 08:59:48 INFO - 'tpaint', 08:59:48 INFO - 'sessionrestore', 08:59:48 INFO - 'sessionrestore_no_auto_restore', 08:59:48 INFO - 'tabpaint']}, 08:59:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:59:48 INFO - 'ts_paint', 08:59:48 INFO - 'tpaint', 08:59:48 INFO - 'sessionrestore', 08:59:48 INFO - 'sessionrestore_no_auto_restore', 08:59:48 INFO - 'tabpaint']}, 08:59:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:59:48 INFO - 'tests': ['a11yr', 08:59:48 INFO - 'ts_paint', 08:59:48 INFO - 'tpaint', 08:59:48 INFO - 'sessionrestore', 08:59:48 INFO - 'sessionrestore_no_auto_restore', 08:59:48 INFO - 'tabpaint']}, 08:59:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:59:48 INFO - 'tests': ['a11yr', 08:59:48 INFO - 'ts_paint', 08:59:48 INFO - 'tpaint', 08:59:48 INFO - 'sessionrestore', 08:59:48 INFO - 'sessionrestore_no_auto_restore', 08:59:48 INFO - 'tabpaint']}, 08:59:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:59:48 INFO - 'tests': ['tsvgx', 08:59:48 INFO - 'tsvgr_opacity', 08:59:48 INFO - 'tart', 08:59:48 INFO - 'tscrollx', 08:59:48 INFO - 'cart']}, 08:59:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:59:48 INFO - 'tsvgr_opacity', 08:59:48 INFO - 'tart', 08:59:48 INFO - 'tscrollx', 08:59:48 INFO - 'cart']}, 08:59:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:48 INFO - 'talos_options': ['--disable-e10s'], 08:59:48 INFO - 'tests': ['tp5o']}, 08:59:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:48 INFO - 'tests': ['tp5o']}, 08:59:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:48 INFO - 'talos_options': ['--disable-e10s', 08:59:48 INFO - '--xperf_path', 08:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:48 INFO - 'tests': ['tp5n']}, 08:59:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:48 INFO - 'talos_options': ['--xperf_path', 08:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:48 INFO - 'tests': ['tp5n']}}, 08:59:48 INFO - 'talos.zip': {'path': '', 08:59:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:59:48 INFO - Running post-action listener: _resource_record_post_action 08:59:48 INFO - [mozharness: 2017-02-14 16:59:48.448095Z] Finished populate-webroot step (success) 08:59:48 INFO - [mozharness: 2017-02-14 16:59:48.448183Z] Running create-virtualenv step. 08:59:48 INFO - Running pre-action listener: _resource_record_pre_action 08:59:48 INFO - Running main action method: create_virtualenv 08:59:48 INFO - Creating virtualenv /builds/slave/test/build/venv 08:59:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:59:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:59:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:59:48 INFO - Using real prefix '/usr' 08:59:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:59:49 INFO - Installing distribute.............................................................................................................................................................................................done. 08:59:51 INFO - Installing pip.................done. 08:59:51 INFO - Return code: 0 08:59:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:59:51 INFO - Reading from file tmpfile_stdout 08:59:51 INFO - Output received: 08:59:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:59:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:51 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 0x7f6cd0a24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839f60>, '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 0x283ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283b1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:59:51 INFO - Using env: {'DISPLAY': ':0', 08:59:51 INFO - 'HOME': '/home/cltbld', 08:59:51 INFO - 'LANG': 'en_US.UTF-8', 08:59:51 INFO - 'LANGUAGE': 'en_US:en', 08:59:51 INFO - 'LOGNAME': 'cltbld', 08:59:51 INFO - 'MAIL': '/var/mail/cltbld', 08:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:51 INFO - 'MOZ_NO_REMOTE': '1', 08:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:51 INFO - 'NO_EM_RESTART': '1', 08:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:51 INFO - 'PWD': '/builds/slave/test', 08:59:51 INFO - 'SHELL': '/bin/bash', 08:59:51 INFO - 'SHLVL': '1', 08:59:51 INFO - 'TERM': 'linux', 08:59:51 INFO - 'TMOUT': '86400', 08:59:51 INFO - 'USER': 'cltbld', 08:59:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 08:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:51 INFO - '_': '/tools/buildbot/bin/python'} 08:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:59:51 INFO - Cleaning up... 08:59:51 INFO - Return code: 0 08:59:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:51 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 0x7f6cd0a24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839f60>, '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 0x283ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283b1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:59:51 INFO - Using env: {'DISPLAY': ':0', 08:59:51 INFO - 'HOME': '/home/cltbld', 08:59:51 INFO - 'LANG': 'en_US.UTF-8', 08:59:51 INFO - 'LANGUAGE': 'en_US:en', 08:59:51 INFO - 'LOGNAME': 'cltbld', 08:59:51 INFO - 'MAIL': '/var/mail/cltbld', 08:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:51 INFO - 'MOZ_NO_REMOTE': '1', 08:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:51 INFO - 'NO_EM_RESTART': '1', 08:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:51 INFO - 'PWD': '/builds/slave/test', 08:59:51 INFO - 'SHELL': '/bin/bash', 08:59:51 INFO - 'SHLVL': '1', 08:59:51 INFO - 'TERM': 'linux', 08:59:51 INFO - 'TMOUT': '86400', 08:59:51 INFO - 'USER': 'cltbld', 08:59:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 08:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:51 INFO - '_': '/tools/buildbot/bin/python'} 08:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:51 INFO - Downloading/unpacking psutil>=3.1.1 08:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:59:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:53 INFO - Installing collected packages: psutil 08:59:53 INFO - Running setup.py install for psutil 08:59:53 INFO - building 'psutil._psutil_linux' extension 08:59:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:59:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:59:54 INFO - building 'psutil._psutil_posix' extension 08:59:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:59:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:59:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:54 INFO - Successfully installed psutil 08:59:54 INFO - Cleaning up... 08:59:54 INFO - Return code: 0 08:59:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cd0a24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839f60>, '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 0x283ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283b1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:59:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:59:54 INFO - Using env: {'DISPLAY': ':0', 08:59:54 INFO - 'HOME': '/home/cltbld', 08:59:54 INFO - 'LANG': 'en_US.UTF-8', 08:59:54 INFO - 'LANGUAGE': 'en_US:en', 08:59:54 INFO - 'LOGNAME': 'cltbld', 08:59:54 INFO - 'MAIL': '/var/mail/cltbld', 08:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:54 INFO - 'MOZ_NO_REMOTE': '1', 08:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:54 INFO - 'NO_EM_RESTART': '1', 08:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:54 INFO - 'PWD': '/builds/slave/test', 08:59:54 INFO - 'SHELL': '/bin/bash', 08:59:54 INFO - 'SHLVL': '1', 08:59:54 INFO - 'TERM': 'linux', 08:59:54 INFO - 'TMOUT': '86400', 08:59:54 INFO - 'USER': 'cltbld', 08:59:54 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 08:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:54 INFO - '_': '/tools/buildbot/bin/python'} 08:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:59:56 INFO - Installing collected packages: mozsystemmonitor 08:59:56 INFO - Running setup.py install for mozsystemmonitor 08:59:56 INFO - Successfully installed mozsystemmonitor 08:59:56 INFO - Cleaning up... 08:59:56 INFO - Return code: 0 08:59:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:56 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 0x7f6cd0a24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839f60>, '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 0x283ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283b1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:59:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:59:56 INFO - Using env: {'DISPLAY': ':0', 08:59:56 INFO - 'HOME': '/home/cltbld', 08:59:56 INFO - 'LANG': 'en_US.UTF-8', 08:59:56 INFO - 'LANGUAGE': 'en_US:en', 08:59:56 INFO - 'LOGNAME': 'cltbld', 08:59:56 INFO - 'MAIL': '/var/mail/cltbld', 08:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:56 INFO - 'MOZ_NO_REMOTE': '1', 08:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:56 INFO - 'NO_EM_RESTART': '1', 08:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:56 INFO - 'PWD': '/builds/slave/test', 08:59:56 INFO - 'SHELL': '/bin/bash', 08:59:56 INFO - 'SHLVL': '1', 08:59:56 INFO - 'TERM': 'linux', 08:59:56 INFO - 'TMOUT': '86400', 08:59:56 INFO - 'USER': 'cltbld', 08:59:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 08:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:56 INFO - '_': '/tools/buildbot/bin/python'} 08:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:57 INFO - Downloading/unpacking jsonschema==2.5.1 08:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:59:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:59 INFO - Downloading functools32-3.2.3-2.tar.gz 08:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:59:59 INFO - warning: no files found matching '*.txt' 08:59:59 INFO - no previously-included directories found matching 'build' 08:59:59 INFO - no previously-included directories found matching 'dist' 08:59:59 INFO - no previously-included directories found matching '.git*' 08:59:59 INFO - Installing collected packages: jsonschema, functools32 08:59:59 INFO - Running setup.py install for functools32 08:59:59 INFO - warning: no files found matching '*.txt' 08:59:59 INFO - no previously-included directories found matching 'build' 08:59:59 INFO - no previously-included directories found matching 'dist' 08:59:59 INFO - no previously-included directories found matching '.git*' 08:59:59 INFO - Successfully installed jsonschema functools32 08:59:59 INFO - Cleaning up... 08:59:59 INFO - Return code: 0 08:59:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 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 0x7f6cd0a24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839f60>, '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 0x283ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283b1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:59:59 INFO - Using env: {'DISPLAY': ':0', 08:59:59 INFO - 'HOME': '/home/cltbld', 08:59:59 INFO - 'LANG': 'en_US.UTF-8', 08:59:59 INFO - 'LANGUAGE': 'en_US:en', 08:59:59 INFO - 'LOGNAME': 'cltbld', 08:59:59 INFO - 'MAIL': '/var/mail/cltbld', 08:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:59 INFO - 'MOZ_NO_REMOTE': '1', 08:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:59 INFO - 'NO_EM_RESTART': '1', 08:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:59 INFO - 'PWD': '/builds/slave/test', 08:59:59 INFO - 'SHELL': '/bin/bash', 08:59:59 INFO - 'SHLVL': '1', 08:59:59 INFO - 'TERM': 'linux', 08:59:59 INFO - 'TMOUT': '86400', 08:59:59 INFO - 'USER': 'cltbld', 08:59:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 08:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:59 INFO - '_': '/tools/buildbot/bin/python'} 08:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:59:59 INFO - Cleaning up... 08:59:59 INFO - Return code: 0 08:59:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:59 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 0x7f6cd0a24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839f60>, '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 0x283ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283b1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:59:59 INFO - Using env: {'DISPLAY': ':0', 08:59:59 INFO - 'HOME': '/home/cltbld', 08:59:59 INFO - 'LANG': 'en_US.UTF-8', 08:59:59 INFO - 'LANGUAGE': 'en_US:en', 08:59:59 INFO - 'LOGNAME': 'cltbld', 08:59:59 INFO - 'MAIL': '/var/mail/cltbld', 08:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:59 INFO - 'MOZ_NO_REMOTE': '1', 08:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:59 INFO - 'NO_EM_RESTART': '1', 08:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:59 INFO - 'PWD': '/builds/slave/test', 08:59:59 INFO - 'SHELL': '/bin/bash', 08:59:59 INFO - 'SHLVL': '1', 08:59:59 INFO - 'TERM': 'linux', 08:59:59 INFO - 'TMOUT': '86400', 08:59:59 INFO - 'USER': 'cltbld', 08:59:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 08:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:59 INFO - '_': '/tools/buildbot/bin/python'} 08:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:59 INFO - Downloading/unpacking blobuploader==1.2.4 08:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:59 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 09:00:01 INFO - Downloading blobuploader-1.2.4.tar.gz 09:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:00:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:00:02 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 09:00:02 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 09:00:02 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 09:00:02 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 09:00:02 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 09:00:02 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 09:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:00:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:00:02 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 09:00:02 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 09:00:02 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 09:00:02 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 09:00:02 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 09:00:02 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 09:00:02 INFO - Downloading docopt-0.6.1.tar.gz 09:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:00:02 INFO - Installing collected packages: blobuploader, requests, docopt 09:00:02 INFO - Running setup.py install for blobuploader 09:00:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:00:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:00:02 INFO - Running setup.py install for requests 09:00:03 INFO - Running setup.py install for docopt 09:00:03 INFO - Successfully installed blobuploader requests docopt 09:00:03 INFO - Cleaning up... 09:00:03 INFO - Return code: 0 09:00:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:03 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 0x7f6cd0a24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839f60>, '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 0x283ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283b1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', '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 09:00:03 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 09:00:03 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 09:00:03 INFO - Using env: {'DISPLAY': ':0', 09:00:03 INFO - 'HOME': '/home/cltbld', 09:00:03 INFO - 'LANG': 'en_US.UTF-8', 09:00:03 INFO - 'LANGUAGE': 'en_US:en', 09:00:03 INFO - 'LOGNAME': 'cltbld', 09:00:03 INFO - 'MAIL': '/var/mail/cltbld', 09:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:03 INFO - 'MOZ_NO_REMOTE': '1', 09:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:03 INFO - 'NO_EM_RESTART': '1', 09:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:03 INFO - 'PWD': '/builds/slave/test', 09:00:03 INFO - 'SHELL': '/bin/bash', 09:00:03 INFO - 'SHLVL': '1', 09:00:03 INFO - 'TERM': 'linux', 09:00:03 INFO - 'TMOUT': '86400', 09:00:03 INFO - 'USER': 'cltbld', 09:00:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 09:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:03 INFO - '_': '/tools/buildbot/bin/python'} 09:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:03 INFO - Running setup.py (path:/tmp/pip-IuyXuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:03 INFO - Running setup.py (path:/tmp/pip-HzK7Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:03 INFO - Running setup.py (path:/tmp/pip-G943if-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:03 INFO - Running setup.py (path:/tmp/pip-bo16hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:03 INFO - Running setup.py (path:/tmp/pip-YR2tk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:03 INFO - Running setup.py (path:/tmp/pip-Nd09Ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:04 INFO - Running setup.py (path:/tmp/pip-jpdjz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:04 INFO - Running setup.py (path:/tmp/pip-luRoGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:04 INFO - Running setup.py (path:/tmp/pip-JVguv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:04 INFO - Running setup.py (path:/tmp/pip-2de9wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:04 INFO - Running setup.py (path:/tmp/pip-6HjcEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:04 INFO - Running setup.py (path:/tmp/pip-3EvZ6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:04 INFO - Running setup.py (path:/tmp/pip-PnBIJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:04 INFO - Running setup.py (path:/tmp/pip-Ur2_oK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:04 INFO - Running setup.py (path:/tmp/pip-2MePJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:04 INFO - Running setup.py (path:/tmp/pip-NjArKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:04 INFO - Running setup.py (path:/tmp/pip-gEFvD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:00:04 INFO - Running setup.py install for manifestparser 09:00:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:00:04 INFO - Running setup.py install for mozcrash 09:00:05 INFO - Running setup.py install for mozdebug 09:00:05 INFO - Running setup.py install for mozdevice 09:00:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:00:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:00:05 INFO - Running setup.py install for mozfile 09:00:05 INFO - Running setup.py install for mozhttpd 09:00:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:00:05 INFO - Running setup.py install for mozinfo 09:00:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:00:05 INFO - Running setup.py install for mozInstall 09:00:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:00:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:00:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:00:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:00:05 INFO - Running setup.py install for mozleak 09:00:05 INFO - Running setup.py install for mozlog 09:00:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:00:05 INFO - Running setup.py install for moznetwork 09:00:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:00:06 INFO - Running setup.py install for mozprocess 09:00:06 INFO - Running setup.py install for mozprofile 09:00:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:00:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:00:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:00:06 INFO - Running setup.py install for mozrunner 09:00:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:00:06 INFO - Running setup.py install for mozscreenshot 09:00:06 INFO - Running setup.py install for moztest 09:00:06 INFO - Running setup.py install for mozversion 09:00:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:00:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:00:06 INFO - Cleaning up... 09:00:06 INFO - Return code: 0 09:00:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:06 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 0x7f6cd0a24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839f60>, '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 0x283ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283b1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', '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 09:00:06 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 09:00:06 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 09:00:06 INFO - Using env: {'DISPLAY': ':0', 09:00:06 INFO - 'HOME': '/home/cltbld', 09:00:06 INFO - 'LANG': 'en_US.UTF-8', 09:00:06 INFO - 'LANGUAGE': 'en_US:en', 09:00:06 INFO - 'LOGNAME': 'cltbld', 09:00:06 INFO - 'MAIL': '/var/mail/cltbld', 09:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:06 INFO - 'MOZ_NO_REMOTE': '1', 09:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:06 INFO - 'NO_EM_RESTART': '1', 09:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:06 INFO - 'PWD': '/builds/slave/test', 09:00:06 INFO - 'SHELL': '/bin/bash', 09:00:06 INFO - 'SHLVL': '1', 09:00:06 INFO - 'TERM': 'linux', 09:00:06 INFO - 'TMOUT': '86400', 09:00:06 INFO - 'USER': 'cltbld', 09:00:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 09:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:06 INFO - '_': '/tools/buildbot/bin/python'} 09:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:06 INFO - Running setup.py (path:/tmp/pip-u398kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:06 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)) 09:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:06 INFO - Running setup.py (path:/tmp/pip-Dmf9et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:07 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)) 09:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:07 INFO - Running setup.py (path:/tmp/pip-Jbm_S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:07 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)) 09:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:07 INFO - Running setup.py (path:/tmp/pip-1uQE82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:07 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)) 09:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:07 INFO - Running setup.py (path:/tmp/pip-LllRIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:07 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)) 09:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:07 INFO - Running setup.py (path:/tmp/pip-fZgmKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:07 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)) 09:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:07 INFO - Running setup.py (path:/tmp/pip-a2Ok78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:07 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)) 09:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:07 INFO - Running setup.py (path:/tmp/pip-uKVf_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:07 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)) 09:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:07 INFO - Running setup.py (path:/tmp/pip-Mrqc0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:07 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)) 09:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:07 INFO - Running setup.py (path:/tmp/pip-ppaHD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:07 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)) 09:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:07 INFO - Running setup.py (path:/tmp/pip-LSZ63k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:07 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)) 09:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:07 INFO - Running setup.py (path:/tmp/pip-aWEsDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:07 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)) 09:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:07 INFO - Running setup.py (path:/tmp/pip-qyqvZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:07 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)) 09:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:07 INFO - Running setup.py (path:/tmp/pip-HzpLKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:07 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)) 09:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:07 INFO - Running setup.py (path:/tmp/pip-m1XO3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:08 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)) 09:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:08 INFO - Running setup.py (path:/tmp/pip-93B8Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:08 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)) 09:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:08 INFO - Running setup.py (path:/tmp/pip-pnnBiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:08 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)) 09:00:08 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)) 09:00:08 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)) 09:00:08 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)) 09:00:08 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)) 09:00:08 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)) 09:00:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:10 INFO - Downloading blessings-1.6.tar.gz 09:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:00:10 INFO - Installing collected packages: blessings 09:00:10 INFO - Running setup.py install for blessings 09:00:10 INFO - Successfully installed blessings 09:00:10 INFO - Cleaning up... 09:00:10 INFO - Return code: 0 09:00:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:00:10 INFO - Reading from file tmpfile_stdout 09:00:10 INFO - Current package versions: 09:00:10 INFO - argparse == 1.2.1 09:00:10 INFO - blessings == 1.6 09:00:10 INFO - blobuploader == 1.2.4 09:00:10 INFO - docopt == 0.6.1 09:00:10 INFO - functools32 == 3.2.3-2 09:00:10 INFO - jsonschema == 2.5.1 09:00:10 INFO - manifestparser == 1.1 09:00:10 INFO - mozInstall == 1.12 09:00:10 INFO - mozcrash == 1.0 09:00:10 INFO - mozdebug == 0.1 09:00:10 INFO - mozdevice == 0.48 09:00:10 INFO - mozfile == 1.2 09:00:10 INFO - mozhttpd == 0.7 09:00:10 INFO - mozinfo == 0.9 09:00:10 INFO - mozleak == 0.1 09:00:10 INFO - mozlog == 3.4 09:00:10 INFO - moznetwork == 0.27 09:00:10 INFO - mozprocess == 0.23 09:00:10 INFO - mozprofile == 0.28 09:00:10 INFO - mozrunner == 6.13 09:00:10 INFO - mozscreenshot == 0.1 09:00:10 INFO - mozsystemmonitor == 0.3 09:00:10 INFO - moztest == 0.8 09:00:10 INFO - mozversion == 1.4 09:00:10 INFO - psutil == 3.1.1 09:00:10 INFO - requests == 1.2.3 09:00:10 INFO - wsgiref == 0.1.2 09:00:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:10 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 0x7f6cd0a24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839f60>, '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 0x283ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283b1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', '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 09:00:10 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 09:00:10 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 09:00:10 INFO - Using env: {'DISPLAY': ':0', 09:00:10 INFO - 'HOME': '/home/cltbld', 09:00:10 INFO - 'LANG': 'en_US.UTF-8', 09:00:10 INFO - 'LANGUAGE': 'en_US:en', 09:00:10 INFO - 'LOGNAME': 'cltbld', 09:00:10 INFO - 'MAIL': '/var/mail/cltbld', 09:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:10 INFO - 'MOZ_NO_REMOTE': '1', 09:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:10 INFO - 'NO_EM_RESTART': '1', 09:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:10 INFO - 'PWD': '/builds/slave/test', 09:00:10 INFO - 'SHELL': '/bin/bash', 09:00:10 INFO - 'SHLVL': '1', 09:00:10 INFO - 'TERM': 'linux', 09:00:10 INFO - 'TMOUT': '86400', 09:00:10 INFO - 'USER': 'cltbld', 09:00:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 09:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:10 INFO - '_': '/tools/buildbot/bin/python'} 09:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:10 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)) 09:00:10 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)) 09:00:10 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)) 09:00:10 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)) 09:00:10 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)) 09:00:10 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)) 09:00:10 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)) 09:00:10 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)) 09:00:10 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)) 09:00:10 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)) 09:00:10 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)) 09:00:10 INFO - Cleaning up... 09:00:10 INFO - Return code: 0 09:00:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:10 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 0x7f6cd0a24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839f60>, '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 0x283ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283b1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', '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 09:00:10 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 09:00:10 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 09:00:10 INFO - Using env: {'DISPLAY': ':0', 09:00:10 INFO - 'HOME': '/home/cltbld', 09:00:10 INFO - 'LANG': 'en_US.UTF-8', 09:00:10 INFO - 'LANGUAGE': 'en_US:en', 09:00:10 INFO - 'LOGNAME': 'cltbld', 09:00:10 INFO - 'MAIL': '/var/mail/cltbld', 09:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:10 INFO - 'MOZ_NO_REMOTE': '1', 09:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:10 INFO - 'NO_EM_RESTART': '1', 09:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:10 INFO - 'PWD': '/builds/slave/test', 09:00:10 INFO - 'SHELL': '/bin/bash', 09:00:10 INFO - 'SHLVL': '1', 09:00:10 INFO - 'TERM': 'linux', 09:00:10 INFO - 'TMOUT': '86400', 09:00:10 INFO - 'USER': 'cltbld', 09:00:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 09:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:10 INFO - '_': '/tools/buildbot/bin/python'} 09:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:00:11 INFO - Cleaning up... 09:00:11 INFO - Return code: 0 09:00:11 INFO - Running post-action listener: _resource_record_post_action 09:00:11 INFO - Running post-action listener: _start_resource_monitoring 09:00:11 INFO - Starting resource monitoring. 09:00:11 INFO - [mozharness: 2017-02-14 17:00:11.171383Z] Finished create-virtualenv step (success) 09:00:11 INFO - [mozharness: 2017-02-14 17:00:11.171925Z] Running install step. 09:00:11 INFO - Running pre-action listener: _resource_record_pre_action 09:00:11 INFO - Running main action method: install 09:00:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:00:11 INFO - Reading from file tmpfile_stdout 09:00:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:00:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:00:11 INFO - Reading from file tmpfile_stdout 09:00:11 INFO - Output received: 09:00:11 INFO - Usage: mozinstall [options] installer 09:00:11 INFO - Options: 09:00:11 INFO - -h, --help show this help message and exit 09:00:11 INFO - -d DEST, --destination=DEST 09:00:11 INFO - Directory to install application into. [default: 09:00:11 INFO - "/builds/slave/test"] 09:00:11 INFO - --app=APP Application being installed. [default: firefox] 09:00:11 INFO - mkdir: /builds/slave/test/build/application 09:00:11 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'] 09:00:11 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 09:00:25 INFO - Reading from file tmpfile_stdout 09:00:25 INFO - Output received: 09:00:25 INFO - /builds/slave/test/build/application/firefox/firefox 09:00:25 INFO - Running post-action listener: _resource_record_post_action 09:00:25 INFO - [mozharness: 2017-02-14 17:00:25.855815Z] Finished install step (success) 09:00:25 INFO - [mozharness: 2017-02-14 17:00:25.856059Z] Running run-tests step. 09:00:25 INFO - Running pre-action listener: _resource_record_pre_action 09:00:25 INFO - Running main action method: run_tests 09:00:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:00:25 INFO - Python 2.7.3 09:00:25 INFO - Return code: 0 09:00:25 INFO - grabbing minidump binary from tooltool 09:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:25 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 0x2839f60>, '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 0x283ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:00:25 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 09:00:25 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 09:00:25 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 09:00:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:00:25 INFO - Return code: 0 09:00:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:00:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:00:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:00:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:00:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:00:25 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/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 09:00:25 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/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 09:00:25 INFO - Using env: {'DISPLAY': ':0', 09:00:25 INFO - 'HOME': '/home/cltbld', 09:00:25 INFO - 'LANG': 'en_US.UTF-8', 09:00:25 INFO - 'LANGUAGE': 'en_US:en', 09:00:25 INFO - 'LOGNAME': 'cltbld', 09:00:25 INFO - 'MAIL': '/var/mail/cltbld', 09:00:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:00:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:25 INFO - 'MOZ_NO_REMOTE': '1', 09:00:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:25 INFO - 'NO_EM_RESTART': '1', 09:00:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:25 INFO - 'PWD': '/builds/slave/test', 09:00:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:00:25 INFO - 'SHELL': '/bin/bash', 09:00:25 INFO - 'SHLVL': '1', 09:00:25 INFO - 'TERM': 'linux', 09:00:25 INFO - 'TMOUT': '86400', 09:00:25 INFO - 'USER': 'cltbld', 09:00:25 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805', 09:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:25 INFO - '_': '/tools/buildbot/bin/python'} 09:00:25 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/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 09:00:26 INFO - mozversion application_buildid: 20170214070945 09:00:26 INFO - mozversion application_changeset: 3a0e9dab386403cec5b899eb7f321c2aa27e0186 09:00:26 INFO - mozversion application_display_name: Firefox 09:00:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:00:26 INFO - mozversion application_name: Firefox 09:00:26 INFO - mozversion application_remotingname: firefox 09:00:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:00:26 INFO - mozversion application_vendor: Mozilla 09:00:26 INFO - mozversion application_version: 52.0 09:00:26 INFO - mozversion platform_buildid: 20170214070945 09:00:26 INFO - mozversion platform_changeset: 3a0e9dab386403cec5b899eb7f321c2aa27e0186 09:00:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:00:26 INFO - mozversion platform_version: 52.0 09:00:26 INFO - using testdate: 1487091626 09:00:26 INFO - actual date: 1487091626 09:00:26 INFO - starting webserver on 'localhost:49786' 09:00:26 INFO - SUITE-START | Running 2 tests 09:00:26 INFO - TEST-START | dromaeo_css 09:00:26 INFO - operating with platform_type : linux_ 09:00:26 INFO - Initialising browser for dromaeo_css test... 09:00:26 INFO - TEST-INFO | started process 29883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprNU8XF/profile http://localhost:49786/getInfo.html) 09:00:31 INFO - PROCESS | 29883 | __metrics Screen width/height:1600/1200 09:00:31 INFO - PROCESS | 29883 | colorDepth:24 09:00:31 INFO - PROCESS | 29883 | Browser inner width/height: 1024/697 09:00:31 INFO - PROCESS | 29883 | __metrics 09:00:31 ERROR - PROCESS | 29883 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 09:00:32 INFO - TEST-INFO | 29883: exit 0 09:00:32 INFO - Browser initialized. 09:00:32 INFO - Running cycle 1/1 for dromaeo_css test... 09:00:32 INFO - TEST-INFO | started process 30012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprNU8XF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:44 INFO - PROCESS | 30012 | RSS: Main: 148316160 09:00:44 INFO - PROCESS | 30012 | 09:03:44 INFO - PROCESS | 30012 | Cycle 1(1): loaded http://localhost:49786/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49786/tests/dromaeo/cssquery-ext.html) 09:03:45 INFO - PROCESS | 30012 | RSS: Main: 153493504 09:03:45 INFO - PROCESS | 30012 | 09:06:47 INFO - PROCESS | 30012 | Cycle 1(1): loaded http://localhost:49786/tests/dromaeo/cssquery-ext.html (next: http://localhost:49786/tests/dromaeo/cssquery-jquery.html) 09:06:47 INFO - PROCESS | 30012 | RSS: Main: 151220224 09:06:47 INFO - PROCESS | 30012 | 09:09:49 INFO - PROCESS | 30012 | Cycle 1(1): loaded http://localhost:49786/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49786/tests/dromaeo/cssquery-mootools.html) 09:09:50 INFO - PROCESS | 30012 | RSS: Main: 151052288 09:09:50 INFO - PROCESS | 30012 | 09:12:51 INFO - PROCESS | 30012 | Cycle 1(1): loaded http://localhost:49786/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49786/tests/dromaeo/cssquery-prototype.html) 09:12:52 INFO - PROCESS | 30012 | RSS: Main: 152358912 09:12:52 INFO - PROCESS | 30012 | 09:15:54 INFO - PROCESS | 30012 | Cycle 1(1): loaded http://localhost:49786/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49786/tests/dromaeo/cssquery-yui.html) 09:15:55 INFO - PROCESS | 30012 | RSS: Main: 154292224 09:15:55 INFO - PROCESS | 30012 | 09:18:57 INFO - PROCESS | 30012 | Cycle 1(1): loaded http://localhost:49786/tests/dromaeo/cssquery-yui.html (next: http://localhost:49786/tests/dromaeo/cssquery-dojo.html) 09:18:58 INFO - PROCESS | 30012 | RSS: Main: 153714688 09:18:58 INFO - PROCESS | 30012 | 09:18:58 INFO - PROCESS | 30012 | __start_tp_report 09:18:58 INFO - PROCESS | 30012 | _x_x_mozilla_page_load 09:18:58 INFO - PROCESS | 30012 | _x_x_mozilla_page_load_details 09:18:58 INFO - PROCESS | 30012 | |i|pagename|runs| 09:18:58 INFO - PROCESS | 30012 | |0;dojo.html;3246.7727259091866;3257.315963647634;3267.036224313827;3273.6726327367264;3277.5903012123485;5666.631668941516;5681.57388195886;5697.6296540724825;5714.057180565207;5729.226554415152;5667.234923285355;5725.341585717643;5735.799247026344;5748.367679555246;5752.539796816255;5173.172292433212;5213;5226;5243.737813109348;5257.8948421031555;5270.104082305998;5271.762770675329;5277.604179686519;5289.788408463657;5302.337207849019;5013.172826483626;5026.2209357549455;5190.299309593194;5216.8174113906025;5249.973750131244;5141;5160.458151894035;5208.192730126836;5241.42344342122;5274.920876186822;5125.154349532323;5207.244949482341;5222.190560463135;5229.921551176735;5260.736963151865;5522.66863988162;5675.744591493351;5696.174054762037;5760.078387458028;5775.220345253421;5949.494292985101;5995.880082398371;5996.970015149896;6034.426729460738;6054.545909056838;6093.146959425684;6101.877962440771;6105.145279660851;6180.505559555225;6192.969035154841;5738.655680659173;5745.080787074048;5746.856328591735;5750.884982300414;5755.712214389306;6090.543209259235;6108.419700128481;6138.508919286446;6140.258962652514;6168.537359698041;5962.672053037125;5972.134040564094;5975.043992961106;5977.163197152402;5981.970090149608;5894.440028197314;5949.345571987078;6040.939590604038;6046.486048685823;6046.879062418815;5964.910526342108;5989.101634754735;6016.217891674142;6070.332263451017;6104.4505994460715;6007.249093863267;6041.2750469943885;6050.971334873082;6052.455279024909;6054.909176362358;4601.861944141681;4713.505081966413;4717.716936983792;4729.69256998294;4735.100330937111;4078.592140785957;4115.773632450244;4123.278426275389;4140.192662430857;4215.78921053946;5758.3090029196765;5837.29952405714;5852.297724273115;5861.6189947653265;5866.032104702762;5959.46364827159;6098.664573448415;6119.2350956130485;6119.296280927661;6130.662813545208;5717.799877004285;5727.312722473246;5744.167095771089;5790.044642634002;5838.678872662044;5178.145605974972;5180.922286165711;5180.922286165711;5185.481451854785;5189.610779191576;6141.7543298267565;6263.68681565929;6276.964300890393;6279.560430769802;6281.937180628227;5888.94111058901;5967.522598192048;5977.521798256216;6018.097285407224;6046.969765151146;6191.9690401547705;6211.875762484635;6224.190855188796;6249.843753906189;6257.342978987141;5875.6474611523445;5897.970510147422;5898.94101058984;5899.970500147472;5936.821895343147;5967.940320596738;6009.729562169626;6051.6066455682;6057.151998720271;6066.090086486885;5974.761009559569;5981.9401805983125;5982.132590774227;5982.730777115127;6006.939930600813;5849.415058494116;5937.703114844327;5953.791617293374;5955.702214889325;5973.104034394875;5793.102069179284;5800.76796928135;5825.50483208915;5907.763689452374;5919.792807251725;5984.611000284967;5989.5507836913275;6011.458968692838;6015.819525414245;6032.638041717511;5802.071668533014;5814.360420353673;5822.126680997884;5848.327442344185;5858.150568167677 09:18:58 INFO - PROCESS | 30012 | |1;ext.html;591.9704014799258;607.5048835199312;629.6725702634631;661.7948435984848;676.2966514824583;44202.33696494555;44897;45210;48757.26864097041;48759.756201218945;46225;46510.53489465104;46817;46862.531374686245;46917;9158.587863546123;9250.25997920168;9270.258379329638;9280.396774209688;9285.814283714322;9249.260059195249;9315.767105822375;9339.76650583734;9340.953295233514;9343.532823358839;9254.305927055464;9383.43699378036;9383.765405864873;9386.342955993083;9409.482478463682;9308.162265396113;9329.533523323875;9339.3462457628;9353.95323023384;9356.953215233949;9150.49672268025;9239.676611318571;9240.306976976754;9241.722748317561;9243.168114869693;44964.325535117;45209.54790452086;45298.320525192146;45323.54676453259;45389.773051134536;3284.2446237365302;3296.686814752619;3313.155145437922;3354.0608629583758;3622.492851000862;28602.284942876595;29128.271793205127;29262.853685731647;29445.70554294451;29695.406091878256;3737.8878633641034;3888.202918401721;3888.2806680764147;3897.123147291865;3914.9804250978564;322044;322161;323241;323894;324143.37928310444;60700.69649651812;61221;61435.38564614386;61545.692271538355;61717.38282617116;63673.68163159247;64000;64198.67900660467;64304.35695643077;64391.356086439475;17153.571160721083;17341;17453.301867925395;17503.03733294681;17507.38724144649;13560.11859229147;13774.586762397144;13818.93090534561;13874.098183618033;14105.78841317381;17193.398231061852;17238.138093095295;17346.91326543359;17541.298348065935;17606.647867042586;3517.75375723702;3644.7448678592773;3686.2443199144113;6364.172657554581;6714.798556043326;1057.7038429239826;1085.2728671789919;1107.2581370481796;1110.1951085463136;1122.5734220995969;31565.00384491364;32383;32529.186770330933;32758;32921.17697057545;1092.9617463388743;1104.094642393246;1143.3470063148327;1194.7431302270054;1217.9025677945742;16820.831791682172;16961.830381696025;16999.575010624834;17124.229409676595;17430.041347725743;515328;519524;520874;521422;522373;61108;61355;61496.69251653802;61499.770004600556;61599.6920015406;1385.072001758824;1402.3549167383119;1404.571605660263;1411.0757453867734;1436.1670231265841;31011.224719382197;31729.68270317267;32066.519002214518;32726.181845454055;33062.17344566405;52790.47209527856;53004.73497632487;53186;53221;53255;428633;431259;431339;432523;434287;30089;30213.244668882573;30247.69752302449;30302.090937271034;30726;48210.27684584664;48581;48855.267170991756;48985;49119;41896.371554427315;42781.144377112905;43446.78276608597;43709.69188903655;43900.12199755923;41290.174196516506;41971;42370.364444533974;42558.14883702247;42630.78684606557;42650.78674606607;42867.57132428761;43552.34671479867;43651.781741091094;43751.78124109359;34961.47557786686;36736;36770.448443272835;37208.62791372051;37389.252214955006;28532;28626.268987958872;29012.709872901;29187.416251675273;29309 09:18:58 INFO - PROCESS | 30012 | |2;jquery.html;426.5755573204662;426.726894787336;429.72927055954744;432.8355225014494;438.84201687392533;18635;19097.427077187673;20040.799592004092;20060.598788024232;20190.89904550477;19035.428937131906;19128.521786955334;19470.610587788273;19520.90239548804;19721.30975415857;5649.943500564993;5890.028145356033;5893.263342082239;5908.527317814564;5918.526517878559;4436.64506839452;4452.0650663360575;5220.451852555484;5801.6519008859395;5882.794102206423;6456.354364563553;6464.482841372679;6475.708593113298;6484.0598113273545;6501.057346684728;5768.394318596529;5787.479126878559;5793.044147715622;6169.321374648785;6474.611523308593;5637.577181711388;5649.180868774005;5650.406707295757;5650.660960342392;5659.773609055674;13282.800757988638;17988.820111798846;19685.704714429296;23225.535489290287;23741.406464838343;2063.7110804487384;2183.061283648031;2250.504888924434;2295.3458264394567;2697.018926973194;5479.3424789025175;9804.90195098047;9810;9890;10162.03460671235;1721.7073097573443;1831.8442932350765;1839.6044850357105;1966.9213231470724;1967.2229469359665;87656.56171719101;88487.55756221242;89402.10597894067;89670;91679;11613;11855.46650400734;11855.636601790904;11887.346195959306;11961.760764784829;16889.408870689465;16902.915485422494;16917.830821691627;16919.40782072646;16980.15099245033;8729.51987640686;8887.822243555222;8904.376693631384;8905.73282801504;9025.63897444108;8572.657093716307;8625.353098517511;8653.610587523577;8723;8877.556122193993;4750.762461876892;4923.704577725348;4957.752112394366;5013.3983921928875;5111.156659151273;1971.8521110916738;1994.7307113539487;2061.093119027623;2120.607687577803;2159.6220661384195;958.9808203836023;993.965211217604;1017.1862509991977;1021.7854250607455;1077.73595469109;18738.625227495373;18988.24047038103;19922.103505342293;20298.188072476936;21232;998.3311181508407;1003.859459675646;1005.3364779245662;1017.8880323164447;1063.7021633942509;10460.424676642857;11186.944065279622;11204.910207774104;11260.831087533694;11284.943575282072;473426;478638;481730;484162;488446;81514.59242703867;98011;98440.50779746055;99792.50103749435;103610;1015.8882522922472;1035.2390992620417;1065.888081751405;1066.3974854207504;1075.575147816608;17554.297828087245;17785;17809.287628494716;18006.909965450614;18313.267469301078;41763;42553.5744642562;43261.26954921768;43547;43613.78193109014;60220.397796021476;61472.38527614667;61823.07265391113;62394.688026559576;63195.368046318945;7771.572563509061;8179.509229446252;8736.78158046054;9011.459312441275;9230.630774768933;13718.794218086936;14021.859781402463;14157.36291866848;14231.786523201954;14430.783538246726;12195.695107622025;12215.816762748744;12288.38558072075;12320.199187052813;12461.563845265373;11214.990650841464;11808.76382472363;11858.229215100991;12029.819552706891;12083.39583020863;11334.14993875446;11484.94257528707;11780.057595392176;11941;12199.268043917393;8049.919500804917;8199.508029518009;8257.95871020641;8330.833383332421;8802.031776504708;11620.76758464809;11665.183437159318;11870.169088163746;12087.456064476944;12120.454579543766 09:18:58 INFO - PROCESS | 30012 | |3;mootools.html;1536.5006372928797;1540.6995635851013;1703.8040625328083;1827.2599597163153;1838.2003828334666;8442.620082096306;8882.822343553133;8907.37648364613;8973.73078807636;9280.814383712323;9161.862572061407;9208.263338932886;9281.118293762082;9294.814103717921;9307.301952353566;2494.638277449769;2532.050481069599;2553.246792196297;2555.7316481769426;2556.5270424971345;2462.1505580574762;2547.821652484327;2547.8471291722462;2548.120898290087;2558.7057488388796;2489.3403248139257;2503.7496250374998;2504.27376060943;2506.1103308325555;2513.296277042431;2431.258466167818;2437.7196622388474;2468.1114798672465;2470.3824043989002;2474.5669507836146;2420.140849998243;2430.829841911067;2450.791682706972;2459.262221333611;2477.182529765173;9069.274458043341;9206.953965230197;9207.723768286962;9221;9272;5409.9459005409835;5558.666480011212;5579.442055794429;5660.066089095336;5690.60165788395;3327.7836940599027;3410.488426735985;3412.9658703412897;3426.931461370759;3436.879709210166;1160.9440884946107;1175.794236008695;1214.4656351205442;1251.0617037222084;1273.2996851731602;12406.441710123067;12463.813042804366;12531.874681253254;12560.434780434902;12619.305938173396;4709.507479747514;4759.643026773006;4820.975895120502;4881.219004959189;4935.7532123393685;9908.157806586521;9932.006799320156;9947;9950.054744799232;9970.750731231632;5441.564674826004;5611.270534830446;5620.044592419298;5625.071863142535;5625.971870140623;4997.075541024849;5104.897902041938;5210.557102646242;5277.525022747971;5287.206918962186;3901;3975.045988962628;4024.678025757932;4047.3119569673227;4048;1237.6967642927361;1258.3205069262679;1259.779538580763;1271.5549557654747;1277.495389321213;774.5120574038319;790.561238512631;874.3005595523556;938.3525367496542;972.8978457262027;5805.651660900359;5895.35151133375;5896.056630939029;5908.970455147783;6034.547408944347;472.95743383095686;482.53194401430557;495.3980913190419;505.94181669107786;506.55676283252154;3665.9083522911606;3781.546214454283;3821.4840996465123;3891.610838916086;3919.9020024499614;10362.326448780805;10809.78380432387;10829.29609575375;10843.295185812896;10847.132229421628;10617.628383006559;10749.731256718645;10758.838617420744;10793.514291856885;11074.114070874311;8469.74590762278;8664.566771661392;8667.566621668891;8668.046514883357;8679.392442528962;5553.8333849984565;5697.316322041216;5705.400932902152;5719.714014299185;5889.705514724333;10198.490075496047;10333;10360.430176340373;10380.844287335545;10452.634157804441;10299.279050466395;10460.26778125524;10485.213608979204;10505.68482945513;10571.2600117991;7491.8501629966;7666.578338191453;7714.884276735741;7718.459707820399;7782;8782.604782784661;8789.780255493408;8810.074942130985;8849.51327676984;8919.42023768453;7730.806729831799;7781.105172904962;7874.84250314979;7884.645190966306;7922.7227047053075;7410.740624078131;7476.25237476248;7481.364084052916;7504.6247687614305;7628.35159011468;6811.7275308989065;6832.077669514552;6852.897206541807;6886.724531018904;6942.8611427772175;4907.656464047625;5038.1435156022835;5045.646804723634;5076.670016448919;5205.453427390221;4947.406311242674;4951.133551628379;5024.57291130258;5087.287779710769;5206.114960456655 09:18:58 INFO - PROCESS | 30012 | |4;prototype.html;334.29630627529036;340.96760807723274;343.4693398699008;361.38564440451233;363.4620761273316;5617.550595952324;5689.435405263549;5699.458551437617;5712.314522257329;5713.200151978726;5543.77824887005;5576.609637325389;5617.38208797033;5618.831435056954;5624.550035997121;4399.186150562156;4400.691951563384;4408.184485870124;4417.668674849383;4419.18245124653;4256.553061928499;4396.340548917672;4405.625521830648;4411.448568928884;4414.492333381654;4363.563643635643;4364.367166760818;4378.715383500063;4387.1006443679125;4387.7367357958465;4366.650667946573;4369.759663218506;4373.737575745466;4380.780960951972;4395.824167033315;3715.294094122108;3865.8067096645054;3874;3880.9223815523815;3885.30064588374;5435.31505233375;5442.700651464168;5446.319210098738;5459.235707001023;5467.17992301154;4996.975015124901;5015.548600625924;5016.573591244749;5018.47306032865;5019.447860735316;5598.300212473441;5760.395158508338;5775.509081728016;5812.331581868097;5822.214001109838;4204.3903633973205;4225.471816022997;4225.492940847118;4231.767252801094;4245.45041060014;6030.155778191057;6056.9697151513965;6063.575549711522;6084.695765211722;6101.938980610182;4262.957370426318;4309.569043095666;4331.761753103547;4338.739675619473;4373.9125217495475;4400.119976004812;4414.404055452473;4422.049259409242;4426.26966550522;4435.157320109169;5013.147764879979;5015.24771284303;5024.748762561857;5025.84922452327;5038.596912247085;5709.857253568694;5863.442972917566;5874.089516125007;5911.852203694942;5923.134212722978;1444.270643325135;1470.985290147085;1481.0598116467463;1482.2810936695694;1486.754685476906;1001.9749506262256;1016.2124353625999;1027.7358848616243;1045.8483519889573;1054.3621109228807;5483.259759932358;5487.2317875497465;5490.368607610096;5536.141898005815;5540.390557038722;5717.342505611908;5742.827715168552;5763.971180144073;5830.416958304136;5839.970800146057;5456.6714304274365;5462.562994960394;5528.612997090246;5774.88450230993;5782.797602083991;3125.515545090469;3130.264387868849;3146.166265939528;3147.213196700825;3148.795328303653;6075.878482430327;6117;6129.264488261437;6129.387061293835;6161.291451483047;6129.601575897642;6140.232470941132;6154.19995400604;6200.162977998003;6219.66762464076;6293.370662933761;6366.6180029198395;6379.245707430401;6379.979203327445;6390.689908568732;5989.910151347646;6001.4298641628975;6064.969675151772;6093.720318733116;6125.834432585706;5983.7008149591475;6022.156898034191;6026.337102918763;6036.1630033884;6060.303065147565;6132.9080063799975;6298.496120310456;6330.85329109434;6340.270868849957;6343.460805831556;4356.738595684269;4371.9344209836245;4417.977910110429;4452.131834292282;4455.955440445554;5934.584579079423;6075.605085669417;6209.658468784261;6214.161088253028;6215.378462153929;5915.615484993462;5923.555733319932;5932.703364831655;5949.702514874326;5955.851103722442;5841.591088623755;5884.941150588611;5892.587518873637;5906.881862362815;5948.821535353946;5647.6893770843;5793.449622285876;5850.414958504116;5863.472287493975;5868.5305175585;5919.852003699942;5930.568466928538;5935.732892019956;5952.880942381042;5958.510372406899;5583.604098975256;5736.282964629421;5778.306603207642;5779.393163717749;5793.667456485116 09:18:58 INFO - PROCESS | 30012 | |5;yui.html;669.0900375489333;678.609799365365;679.205329764176;708.4332533972821;746.332032830617;14537.41850325987;14762.11427314362;14888.404463821435;14905.627359316022;14971.775423368645;13675.247861367621;14183.503577374768;14385.712285754278;14445.927770361133;14459.987800853944;856.648774002659;862.874883141944;885.751989442957;886.2378354615026;892.772343052524;879.1955360844851;881.180502133016;885.3183049052226;888.8488956877314;889.6797153024905;920.1074957291416;927.2165020557652;927.3137877970321;929.8884133903907;931.1479995803832;914.0493886358213;917.2616044084509;921.4655499810127;922.3082687984012;924.159015296084;677.8949262864214;683.135833171039;683.5249501596393;684.1755684400285;684.7979845945458;15385.461508847136;15418.614534636723;15905.363785448568;15938.12340321282;15970.600734981603;12292.323922184276;13074.280914549696;13643.863561364458;13719.45122195111;13756.587302380945;10153.272885355856;10700.090492308163;10752.892471075267;10873.891261087447;10926.125909927187;3735.2529494101286;3769.830357633913;3774.358359078963;3795.8481660733537;3839.9232015359535;64064.67967660179;64120.35879641191;64626.030609540896;64810.351896480905;65066.674666626364;9677.225821934227;9980.589446997214;10001.199904007663;10079;10100.84848727255;20432.182712691327;20441.48896277605;20564.485887852923;20570.58858822815;20885.26901558438;7290.708371665074;7308.342249197598;7339.073800295668;7394.741184058532;7573.091229052438;4041.454403655469;4140;4152.065785198306;4195.139996300751;4639.164950308977;3432.8626854925524;3440.913977150591;3526.982365088158;3541.769784963969;3545.94681079784;609.7439075588263;619.5013014523262;627.2535682537765;638.7955854126727;649.6264647827518;548.2133138945626;633.9397757213058;686.1594546680277;688.277308825731;691.3328637864485;8996.640134394682;9538;9563.521823908915;9875.703728888146;10165.237607179492;636.5671343486381;687.8211664967044;694.1184695436767;707.5294928872345;708.2952462300044;4244.384564238168;4496.527864574173;4541.159885421208;4554.612857907115;4597.632189424838;51422.742886286076;75611.86582201271;81106;81676.59161704153;84823.57588212019;69593.30406695868;71116.64441677759;72273;72533.63733181405;72571;62572.374276256654;63947.360526395074;64437.35562644407;65225;66681.99999999903;9330.953345233502;9698.806023879624;9830.4101753895;10142.695719128438;10194.592216311265;33416.1645958853;42164.78917605515;43134.137317254106;44385.33421998737;47746.76126619345;59134;60518;62688.68655656693;63257.68371158115;63609;10952.178586606196;11019;11204.719882003015;11304;11756.882431175922;12912.418941147484;13155.671108222372;13455.730885382432;13457.327133643474;13539.187648741106;12195.817062743889;12304.384780760747;12480.126391152533;12549.435275412447;12805.103642745291;12765.425555850195;12782.680432988878;12820.23078615286;12906.483740650268;12935.417906194056;12115;12438.626841194779;12473.376331183223;12498.125131240726;12567.685807854878;10059.29584929048;10164.949175254076;10279.588816447258;10330.638427654996;10364.222683298933;10283.485825708534;10715.142788576739;10908.78182436331;10961.50673219691;11071.83392249133 09:18:58 INFO - PROCESS | 30012 | __end_tp_report 09:18:58 INFO - PROCESS | 30012 | __start_cc_report 09:18:58 INFO - PROCESS | 30012 | _x_x_mozilla_cycle_collect,301 09:18:58 INFO - PROCESS | 30012 | __end_cc_report 09:18:58 INFO - PROCESS | 30012 | __startTimestamp1487092738014__endTimestamp 09:18:58 INFO - PROCESS | 30012 | 09:18:58 INFO - PROCESS | 30012 | ------- Summary: start ------- 09:18:58 INFO - PROCESS | 30012 | Number of tests: 6 09:18:58 INFO - PROCESS | 30012 | 09:18:58 INFO - PROCESS | 30012 | [#0] dojo.html Cycles:165 Average:5641.96 Median:5861.62 stddev:627.32 (10.7%) stddev-sans-first:600.45 09:18:58 INFO - PROCESS | 30012 | Values: 3246.8 3257.3 3267.0 3273.7 3277.6 5666.6 5681.6 5697.6 5714.1 5729.2 5667.2 5725.3 5735.8 5748.4 5752.5 5173.2 5213.0 5226.0 5243.7 5257.9 5270.1 5271.8 5277.6 5289.8 5302.3 5013.2 5026.2 5190.3 5216.8 5250.0 5141.0 5160.5 5208.2 5241.4 5274.9 5125.2 5207.2 5222.2 5229.9 5260.7 5522.7 5675.7 5696.2 5760.1 5775.2 5949.5 5995.9 5997.0 6034.4 6054.5 6093.1 6101.9 6105.1 6180.5 6193.0 5738.7 5745.1 5746.9 5750.9 5755.7 6090.5 6108.4 6138.5 6140.3 6168.5 5962.7 5972.1 5975.0 5977.2 5982.0 5894.4 5949.3 6040.9 6046.5 6046.9 5964.9 5989.1 6016.2 6070.3 6104.5 6007.2 6041.3 6051.0 6052.5 6054.9 4601.9 4713.5 4717.7 4729.7 4735.1 4078.6 4115.8 4123.3 4140.2 4215.8 5758.3 5837.3 5852.3 5861.6 5866.0 5959.5 6098.7 6119.2 6119.3 6130.7 5717.8 5727.3 5744.2 5790.0 5838.7 5178.1 5180.9 5180.9 5185.5 5189.6 6141.8 6263.7 6277.0 6279.6 6281.9 5888.9 5967.5 5977.5 6018.1 6047.0 6192.0 6211.9 6224.2 6249.8 6257.3 5875.6 5898.0 5898.9 5900.0 5936.8 5967.9 6009.7 6051.6 6057.2 6066.1 5974.8 5981.9 5982.1 5982.7 6006.9 5849.4 5937.7 5953.8 5955.7 5973.1 5793.1 5800.8 5825.5 5907.8 5919.8 5984.6 5989.6 6011.5 6015.8 6032.6 5802.1 5814.4 5822.1 5848.3 5858.2 09:18:58 INFO - PROCESS | 30012 | 09:18:58 INFO - PROCESS | 30012 | [#1] ext.html Cycles:180 Average:59674.71 Median:235707.07 stddev:114473.79 (48.6%) stddev-sans-first:114708.97 09:18:58 INFO - PROCESS | 30012 | Values: 592.0 607.5 629.7 661.8 676.3 44202.3 44897.0 45210.0 48757.3 48759.8 46225.0 46510.5 46817.0 46862.5 46917.0 9158.6 9250.3 9270.3 9280.4 9285.8 9249.3 9315.8 9339.8 9341.0 9343.5 9254.3 9383.4 9383.8 9386.3 9409.5 9308.2 9329.5 9339.3 9354.0 9357.0 9150.5 9239.7 9240.3 9241.7 9243.2 44964.3 45209.5 45298.3 45323.5 45389.8 3284.2 3296.7 3313.2 3354.1 3622.5 28602.3 29128.3 29262.9 29445.7 29695.4 3737.9 3888.2 3888.3 3897.1 3915.0 322044.0 322161.0 323241.0 323894.0 324143.4 60700.7 61221.0 61435.4 61545.7 61717.4 63673.7 64000.0 64198.7 64304.4 64391.4 17153.6 17341.0 17453.3 17503.0 17507.4 13560.1 13774.6 13818.9 13874.1 14105.8 17193.4 17238.1 17346.9 17541.3 17606.6 3517.8 3644.7 3686.2 6364.2 6714.8 1057.7 1085.3 1107.3 1110.2 1122.6 31565.0 32383.0 32529.2 32758.0 32921.2 1093.0 1104.1 1143.3 1194.7 1217.9 16820.8 16961.8 16999.6 17124.2 17430.0 515328.0 519524.0 520874.0 521422.0 522373.0 61108.0 61355.0 61496.7 61499.8 61599.7 1385.1 1402.4 1404.6 1411.1 1436.2 31011.2 31729.7 32066.5 32726.2 33062.2 52790.5 53004.7 53186.0 53221.0 53255.0 428633.0 431259.0 431339.0 432523.0 434287.0 30089.0 30213.2 30247.7 30302.1 30726.0 48210.3 48581.0 48855.3 48985.0 49119.0 41896.4 42781.1 43446.8 43709.7 43900.1 41290.2 41971.0 42370.4 42558.1 42630.8 42650.8 42867.6 43552.3 43651.8 43751.8 34961.5 36736.0 36770.4 37208.6 37389.3 28532.0 28626.3 29012.7 29187.4 29309.0 09:18:58 INFO - PROCESS | 30012 | 09:18:58 INFO - PROCESS | 30012 | [#2] jquery.html Cycles:180 Average:29361.43 Median:12760.44 stddev:79697.80 (624.6%) stddev-sans-first:79891.76 09:18:58 INFO - PROCESS | 30012 | Values: 426.6 426.7 429.7 432.8 438.8 18635.0 19097.4 20040.8 20060.6 20190.9 19035.4 19128.5 19470.6 19520.9 19721.3 5649.9 5890.0 5893.3 5908.5 5918.5 4436.6 4452.1 5220.5 5801.7 5882.8 6456.4 6464.5 6475.7 6484.1 6501.1 5768.4 5787.5 5793.0 6169.3 6474.6 5637.6 5649.2 5650.4 5650.7 5659.8 13282.8 17988.8 19685.7 23225.5 23741.4 2063.7 2183.1 2250.5 2295.3 2697.0 5479.3 9804.9 9810.0 9890.0 10162.0 1721.7 1831.8 1839.6 1966.9 1967.2 87656.6 88487.6 89402.1 89670.0 91679.0 11613.0 11855.5 11855.6 11887.3 11961.8 16889.4 16902.9 16917.8 16919.4 16980.2 8729.5 8887.8 8904.4 8905.7 9025.6 8572.7 8625.4 8653.6 8723.0 8877.6 4750.8 4923.7 4957.8 5013.4 5111.2 1971.9 1994.7 2061.1 2120.6 2159.6 959.0 994.0 1017.2 1021.8 1077.7 18738.6 18988.2 19922.1 20298.2 21232.0 998.3 1003.9 1005.3 1017.9 1063.7 10460.4 11186.9 11204.9 11260.8 11284.9 473426.0 478638.0 481730.0 484162.0 488446.0 81514.6 98011.0 98440.5 99792.5 103610.0 1015.9 1035.2 1065.9 1066.4 1075.6 17554.3 17785.0 17809.3 18006.9 18313.3 41763.0 42553.6 43261.3 43547.0 43613.8 60220.4 61472.4 61823.1 62394.7 63195.4 7771.6 8179.5 8736.8 9011.5 9230.6 13718.8 14021.9 14157.4 14231.8 14430.8 12195.7 12215.8 12288.4 12320.2 12461.6 11215.0 11808.8 11858.2 12029.8 12083.4 11334.1 11484.9 11780.1 11941.0 12199.3 8049.9 8199.5 8258.0 8330.8 8802.0 11620.8 11665.2 11870.2 12087.5 12120.5 09:18:58 INFO - PROCESS | 30012 | 09:18:58 INFO - PROCESS | 30012 | [#3] mootools.html Cycles:180 Average:5877.59 Median:4974.10 stddev:3330.73 (67.0%) stddev-sans-first:3324.10 09:18:58 INFO - PROCESS | 30012 | Values: 1536.5 1540.7 1703.8 1827.3 1838.2 8442.6 8882.8 8907.4 8973.7 9280.8 9161.9 9208.3 9281.1 9294.8 9307.3 2494.6 2532.1 2553.2 2555.7 2556.5 2462.2 2547.8 2547.8 2548.1 2558.7 2489.3 2503.7 2504.3 2506.1 2513.3 2431.3 2437.7 2468.1 2470.4 2474.6 2420.1 2430.8 2450.8 2459.3 2477.2 9069.3 9207.0 9207.7 9221.0 9272.0 5409.9 5558.7 5579.4 5660.1 5690.6 3327.8 3410.5 3413.0 3426.9 3436.9 1160.9 1175.8 1214.5 1251.1 1273.3 12406.4 12463.8 12531.9 12560.4 12619.3 4709.5 4759.6 4821.0 4881.2 4935.8 9908.2 9932.0 9947.0 9950.1 9970.8 5441.6 5611.3 5620.0 5625.1 5626.0 4997.1 5104.9 5210.6 5277.5 5287.2 3901.0 3975.0 4024.7 4047.3 4048.0 1237.7 1258.3 1259.8 1271.6 1277.5 774.5 790.6 874.3 938.4 972.9 5805.7 5895.4 5896.1 5909.0 6034.5 473.0 482.5 495.4 505.9 506.6 3665.9 3781.5 3821.5 3891.6 3919.9 10362.3 10809.8 10829.3 10843.3 10847.1 10617.6 10749.7 10758.8 10793.5 11074.1 8469.7 8664.6 8667.6 8668.0 8679.4 5553.8 5697.3 5705.4 5719.7 5889.7 10198.5 10333.0 10360.4 10380.8 10452.6 10299.3 10460.3 10485.2 10505.7 10571.3 7491.9 7666.6 7714.9 7718.5 7782.0 8782.6 8789.8 8810.1 8849.5 8919.4 7730.8 7781.1 7874.8 7884.6 7922.7 7410.7 7476.3 7481.4 7504.6 7628.4 6811.7 6832.1 6852.9 6886.7 6942.9 4907.7 5038.1 5045.6 5076.7 5205.5 4947.4 4951.1 5024.6 5087.3 5206.1 09:18:58 INFO - PROCESS | 30012 | 09:18:58 INFO - PROCESS | 30012 | [#4] prototype.html Cycles:180 Average:4959.78 Median:5590.95 stddev:1456.57 (26.1%) stddev-sans-first:1418.68 09:18:58 INFO - PROCESS | 30012 | Values: 334.3 341.0 343.5 361.4 363.5 5617.6 5689.4 5699.5 5712.3 5713.2 5543.8 5576.6 5617.4 5618.8 5624.6 4399.2 4400.7 4408.2 4417.7 4419.2 4256.6 4396.3 4405.6 4411.4 4414.5 4363.6 4364.4 4378.7 4387.1 4387.7 4366.7 4369.8 4373.7 4380.8 4395.8 3715.3 3865.8 3874.0 3880.9 3885.3 5435.3 5442.7 5446.3 5459.2 5467.2 4997.0 5015.5 5016.6 5018.5 5019.4 5598.3 5760.4 5775.5 5812.3 5822.2 4204.4 4225.5 4225.5 4231.8 4245.5 6030.2 6057.0 6063.6 6084.7 6101.9 4263.0 4309.6 4331.8 4338.7 4373.9 4400.1 4414.4 4422.0 4426.3 4435.2 5013.1 5015.2 5024.7 5025.8 5038.6 5709.9 5863.4 5874.1 5911.9 5923.1 1444.3 1471.0 1481.1 1482.3 1486.8 1002.0 1016.2 1027.7 1045.8 1054.4 5483.3 5487.2 5490.4 5536.1 5540.4 5717.3 5742.8 5764.0 5830.4 5840.0 5456.7 5462.6 5528.6 5774.9 5782.8 3125.5 3130.3 3146.2 3147.2 3148.8 6075.9 6117.0 6129.3 6129.4 6161.3 6129.6 6140.2 6154.2 6200.2 6219.7 6293.4 6366.6 6379.2 6380.0 6390.7 5989.9 6001.4 6065.0 6093.7 6125.8 5983.7 6022.2 6026.3 6036.2 6060.3 6132.9 6298.5 6330.9 6340.3 6343.5 4356.7 4371.9 4418.0 4452.1 4456.0 5934.6 6075.6 6209.7 6214.2 6215.4 5915.6 5923.6 5932.7 5949.7 5955.9 5841.6 5884.9 5892.6 5906.9 5948.8 5647.7 5793.4 5850.4 5863.5 5868.5 5919.9 5930.6 5935.7 5952.9 5958.5 5583.6 5736.3 5778.3 5779.4 5793.7 09:18:58 INFO - PROCESS | 30012 | 09:18:58 INFO - PROCESS | 30012 | [#5] yui.html Cycles:180 Average:17001.91 Median:4518.84 stddev:21949.55 (485.7%) stddev-sans-first:21976.86 09:18:58 INFO - PROCESS | 30012 | Values: 669.1 678.6 679.2 708.4 746.3 14537.4 14762.1 14888.4 14905.6 14971.8 13675.2 14183.5 14385.7 14445.9 14460.0 856.6 862.9 885.8 886.2 892.8 879.2 881.2 885.3 888.8 889.7 920.1 927.2 927.3 929.9 931.1 914.0 917.3 921.5 922.3 924.2 677.9 683.1 683.5 684.2 684.8 15385.5 15418.6 15905.4 15938.1 15970.6 12292.3 13074.3 13643.9 13719.5 13756.6 10153.3 10700.1 10752.9 10873.9 10926.1 3735.3 3769.8 3774.4 3795.8 3839.9 64064.7 64120.4 64626.0 64810.4 65066.7 9677.2 9980.6 10001.2 10079.0 10100.8 20432.2 20441.5 20564.5 20570.6 20885.3 7290.7 7308.3 7339.1 7394.7 7573.1 4041.5 4140.0 4152.1 4195.1 4639.2 3432.9 3440.9 3527.0 3541.8 3545.9 609.7 619.5 627.3 638.8 649.6 548.2 633.9 686.2 688.3 691.3 8996.6 9538.0 9563.5 9875.7 10165.2 636.6 687.8 694.1 707.5 708.3 4244.4 4496.5 4541.2 4554.6 4597.6 51422.7 75611.9 81106.0 81676.6 84823.6 69593.3 71116.6 72273.0 72533.6 72571.0 62572.4 63947.4 64437.4 65225.0 66682.0 9331.0 9698.8 9830.4 10142.7 10194.6 33416.2 42164.8 43134.1 44385.3 47746.8 59134.0 60518.0 62688.7 63257.7 63609.0 10952.2 11019.0 11204.7 11304.0 11756.9 12912.4 13155.7 13455.7 13457.3 13539.2 12195.8 12304.4 12480.1 12549.4 12805.1 12765.4 12782.7 12820.2 12906.5 12935.4 12115.0 12438.6 12473.4 12498.1 12567.7 10059.3 10164.9 10279.6 10330.6 10364.2 10283.5 10715.1 10908.8 10961.5 11071.8 09:18:58 INFO - PROCESS | 30012 | -------- Summary: end -------- 09:18:58 INFO - PROCESS | 30012 | 09:18:58 INFO - TEST-INFO | 30012: exit 0 09:18:58 INFO - TEST-OK | dromaeo_css | took 1112582ms 09:18:58 INFO - TEST-START | kraken 09:18:58 INFO - operating with platform_type : linux_ 09:18:58 INFO - Initialising browser for kraken test... 09:18:58 INFO - TEST-INFO | started process 30371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF7oaIf/profile http://localhost:49786/getInfo.html) 09:19:03 INFO - PROCESS | 30371 | __metrics Screen width/height:1600/1200 09:19:03 INFO - PROCESS | 30371 | colorDepth:24 09:19:03 INFO - PROCESS | 30371 | Browser inner width/height: 1024/697 09:19:03 INFO - PROCESS | 30371 | __metrics 09:19:03 ERROR - PROCESS | 30371 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 09:19:04 INFO - TEST-INFO | 30371: exit 0 09:19:04 INFO - Browser initialized. 09:19:04 INFO - Running cycle 1/1 for kraken test... 09:19:04 INFO - TEST-INFO | started process 30503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF7oaIf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:16 INFO - PROCESS | 30503 | RSS: Main: 148344832 09:19:16 INFO - PROCESS | 30503 | 09:19:18 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:49786/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49786/tests/kraken/driver.html?testName=audio-beat-detection) 09:19:19 INFO - PROCESS | 30503 | RSS: Main: 153464832 09:19:19 INFO - PROCESS | 30503 | 09:19:22 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:49786/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49786/tests/kraken/driver.html?testName=audio-dft) 09:19:23 INFO - PROCESS | 30503 | RSS: Main: 152727552 09:19:23 INFO - PROCESS | 30503 | 09:19:25 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:49786/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49786/tests/kraken/driver.html?testName=audio-fft) 09:19:26 INFO - PROCESS | 30503 | RSS: Main: 153120768 09:19:26 INFO - PROCESS | 30503 | 09:19:28 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:49786/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49786/tests/kraken/driver.html?testName=audio-oscillator) 09:19:29 INFO - PROCESS | 30503 | RSS: Main: 152592384 09:19:29 INFO - PROCESS | 30503 | 09:19:31 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:49786/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49786/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:19:31 INFO - PROCESS | 30503 | RSS: Main: 152473600 09:19:31 INFO - PROCESS | 30503 | 09:19:34 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:49786/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49786/tests/kraken/driver.html?testName=imaging-darkroom) 09:19:35 INFO - PROCESS | 30503 | RSS: Main: 155389952 09:19:35 INFO - PROCESS | 30503 | 09:19:38 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:49786/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49786/tests/kraken/driver.html?testName=imaging-desaturate) 09:19:39 INFO - PROCESS | 30503 | RSS: Main: 155594752 09:19:39 INFO - PROCESS | 30503 | 09:19:42 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:49786/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49786/tests/kraken/driver.html?testName=json-parse-financial) 09:19:42 INFO - PROCESS | 30503 | RSS: Main: 155807744 09:19:42 INFO - PROCESS | 30503 | 09:19:44 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:49786/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49786/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:19:44 INFO - PROCESS | 30503 | RSS: Main: 154783744 09:19:44 INFO - PROCESS | 30503 | 09:19:46 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:49786/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49786/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:19:47 INFO - PROCESS | 30503 | RSS: Main: 154689536 09:19:47 INFO - PROCESS | 30503 | 09:19:49 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:49786/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49786/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:19:49 INFO - PROCESS | 30503 | RSS: Main: 154419200 09:19:49 INFO - PROCESS | 30503 | 09:19:52 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:49786/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:19:53 INFO - PROCESS | 30503 | RSS: Main: 154624000 09:19:53 INFO - PROCESS | 30503 | 09:19:55 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:49786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:19:56 INFO - PROCESS | 30503 | RSS: Main: 155078656 09:19:56 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | Cycle 1(1): loaded http://localhost:49786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49786/tests/kraken/driver.html?testName=ai-astar) 09:19:58 INFO - PROCESS | 30503 | RSS: Main: 156987392 09:19:58 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | __start_tp_report 09:19:58 INFO - PROCESS | 30503 | _x_x_mozilla_page_load 09:19:58 INFO - PROCESS | 30503 | _x_x_mozilla_page_load_details 09:19:58 INFO - PROCESS | 30503 | |i|pagename|runs| 09:19:58 INFO - PROCESS | 30503 | |0;ai-astar;104;115;113;115;114;113;112;112;113;116 09:19:58 INFO - PROCESS | 30503 | |1;audio-beat-detection;150;121;119;169;127;128;122;122;145;126 09:19:58 INFO - PROCESS | 30503 | |2;audio-dft;166;163;163;161;162;162;163;164;164;164 09:19:58 INFO - PROCESS | 30503 | |3;audio-fft;75;78;79;116;76;76;77;78;117;80 09:19:58 INFO - PROCESS | 30503 | |4;audio-oscillator;83;81;109;82;87;80;93;81;83;114 09:19:58 INFO - PROCESS | 30503 | |5;imaging-gaussian-blur;117;117;118;117;118;117;117;117;118;117 09:19:58 INFO - PROCESS | 30503 | |6;imaging-darkroom;146;147;147;147;147;147;147;147;147;147 09:19:58 INFO - PROCESS | 30503 | |7;imaging-desaturate;85;86;87;85;87;86;85;85;86;85 09:19:58 INFO - PROCESS | 30503 | |8;json-parse-financial;54;55;57;54;54;54;59;61;55;54 09:19:58 INFO - PROCESS | 30503 | |9;json-stringify-tinderbox;61;61;61;61;62;60;60;63;60;60 09:19:58 INFO - PROCESS | 30503 | |10;stanford-crypto-aes;76;75;76;74;75;75;76;76;76;75 09:19:58 INFO - PROCESS | 30503 | |11;stanford-crypto-ccm;126;135;135;141;124;136;122;123;165;128 09:19:58 INFO - PROCESS | 30503 | |12;stanford-crypto-pbkdf2;159;159;160;159;158;159;158;159;159;157 09:19:58 INFO - PROCESS | 30503 | |13;stanford-crypto-sha256-iterative;66;65;64;64;63;63;66;64;64;65 09:19:58 INFO - PROCESS | 30503 | __end_tp_report 09:19:58 INFO - PROCESS | 30503 | __start_cc_report 09:19:58 INFO - PROCESS | 30503 | _x_x_mozilla_cycle_collect,772 09:19:58 INFO - PROCESS | 30503 | __end_cc_report 09:19:58 INFO - PROCESS | 30503 | __startTimestamp1487092798508__endTimestamp 09:19:58 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | ------- Summary: start ------- 09:19:58 INFO - PROCESS | 30503 | Number of tests: 14 09:19:58 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.50 stddev:3.33 (2.9%) stddev-sans-first:1.41 09:19:58 INFO - PROCESS | 30503 | Values: 104.0 115.0 113.0 115.0 114.0 113.0 112.0 112.0 113.0 116.0 09:19:58 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:127.50 stddev:16.40 (12.9%) stddev-sans-first:16.19 09:19:58 INFO - PROCESS | 30503 | Values: 150.0 121.0 119.0 169.0 127.0 128.0 122.0 122.0 145.0 126.0 09:19:58 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.40 (0.9%) stddev-sans-first:1.05 09:19:58 INFO - PROCESS | 30503 | Values: 166.0 163.0 163.0 161.0 162.0 162.0 163.0 164.0 164.0 164.0 09:19:58 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | [#3] audio-fft Cycles:10 Average:85.20 Median:77.50 stddev:16.57 (21.4%) stddev-sans-first:17.15 09:19:58 INFO - PROCESS | 30503 | Values: 75.0 78.0 79.0 116.0 76.0 76.0 77.0 78.0 117.0 80.0 09:19:58 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:82.50 stddev:12.36 (15.0%) stddev-sans-first:12.89 09:19:58 INFO - PROCESS | 30503 | Values: 83.0 81.0 109.0 82.0 87.0 80.0 93.0 81.0 83.0 114.0 09:19:58 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:19:58 INFO - PROCESS | 30503 | Values: 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 09:19:58 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.00 09:19:58 INFO - PROCESS | 30503 | Values: 146.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 09:19:58 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 09:19:58 INFO - PROCESS | 30503 | Values: 85.0 86.0 87.0 85.0 87.0 86.0 85.0 85.0 86.0 85.0 09:19:58 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:2.50 (4.5%) stddev-sans-first:2.57 09:19:58 INFO - PROCESS | 30503 | Values: 54.0 55.0 57.0 54.0 54.0 54.0 59.0 61.0 55.0 54.0 09:19:58 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 09:19:58 INFO - PROCESS | 30503 | Values: 61.0 61.0 61.0 61.0 62.0 60.0 60.0 63.0 60.0 60.0 09:19:58 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:76.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 09:19:58 INFO - PROCESS | 30503 | Values: 76.0 75.0 76.0 74.0 75.0 75.0 76.0 76.0 76.0 75.0 09:19:58 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:135.00 stddev:12.82 (9.5%) stddev-sans-first:13.30 09:19:58 INFO - PROCESS | 30503 | Values: 126.0 135.0 135.0 141.0 124.0 136.0 122.0 123.0 165.0 128.0 09:19:58 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:159.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 09:19:58 INFO - PROCESS | 30503 | Values: 159.0 159.0 160.0 159.0 158.0 159.0 158.0 159.0 159.0 157.0 09:19:58 INFO - PROCESS | 30503 | 09:19:58 INFO - PROCESS | 30503 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:1.07 (1.7%) stddev-sans-first:0.97 09:19:58 INFO - PROCESS | 30503 | Values: 66.0 65.0 64.0 64.0 63.0 63.0 66.0 64.0 64.0 65.0 09:19:58 INFO - PROCESS | 30503 | -------- Summary: end -------- 09:19:58 INFO - PROCESS | 30503 | 09:19:59 INFO - TEST-INFO | 30503: exit 0 09:19:59 INFO - TEST-OK | kraken | took 60791ms 09:19:59 INFO - SUITE-END | took 1173s 09:19:59 INFO - Completed test suite (00:19:33) 09:19:59 INFO - javascript benchmark 09:19:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7347.663716890751, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3246.7727259091866, 3257.315963647634, 3267.036224313827, 3273.6726327367264, 3277.5903012123485, 5666.631668941516, 5681.57388195886, 5697.6296540724825, 5714.057180565207, 5729.226554415152, 5667.234923285355, 5725.341585717643, 5735.799247026344, 5748.367679555246, 5752.539796816255, 5173.172292433212, 5213.0, 5226.0, 5243.737813109348, 5257.8948421031555, 5270.104082305998, 5271.762770675329, 5277.604179686519, 5289.788408463657, 5302.337207849019, 5013.172826483626, 5026.2209357549455, 5190.299309593194, 5216.8174113906025, 5249.973750131244, 5141.0, 5160.458151894035, 5208.192730126836, 5241.42344342122, 5274.920876186822, 5125.154349532323, 5207.244949482341, 5222.190560463135, 5229.921551176735, 5260.736963151865, 5522.66863988162, 5675.744591493351, 5696.174054762037, 5760.078387458028, 5775.220345253421, 5949.494292985101, 5995.880082398371, 5996.970015149896, 6034.426729460738, 6054.545909056838, 6093.146959425684, 6101.877962440771, 6105.145279660851, 6180.505559555225, 6192.969035154841, 5738.655680659173, 5745.080787074048, 5746.856328591735, 5750.884982300414, 5755.712214389306, 6090.543209259235, 6108.419700128481, 6138.508919286446, 6140.258962652514, 6168.537359698041, 5962.672053037125, 5972.134040564094, 5975.043992961106, 5977.163197152402, 5981.970090149608, 5894.440028197314, 5949.345571987078, 6040.939590604038, 6046.486048685823, 6046.879062418815, 5964.910526342108, 5989.101634754735, 6016.217891674142, 6070.332263451017, 6104.4505994460715, 6007.249093863267, 6041.2750469943885, 6050.971334873082, 6052.455279024909, 6054.909176362358, 4601.861944141681, 4713.505081966413, 4717.716936983792, 4729.69256998294, 4735.100330937111, 4078.592140785957, 4115.773632450244, 4123.278426275389, 4140.192662430857, 4215.78921053946, 5758.3090029196765, 5837.29952405714, 5852.297724273115, 5861.6189947653265, 5866.032104702762, 5959.46364827159, 6098.664573448415, 6119.2350956130485, 6119.296280927661, 6130.662813545208, 5717.799877004285, 5727.312722473246, 5744.167095771089, 5790.044642634002, 5838.678872662044, 5178.145605974972, 5180.922286165711, 5180.922286165711, 5185.481451854785, 5189.610779191576, 6141.7543298267565, 6263.68681565929, 6276.964300890393, 6279.560430769802, 6281.937180628227, 5888.94111058901, 5967.522598192048, 5977.521798256216, 6018.097285407224, 6046.969765151146, 6191.9690401547705, 6211.875762484635, 6224.190855188796, 6249.843753906189, 6257.342978987141, 5875.6474611523445, 5897.970510147422, 5898.94101058984, 5899.970500147472, 5936.821895343147, 5967.940320596738, 6009.729562169626, 6051.6066455682, 6057.151998720271, 6066.090086486885, 5974.761009559569, 5981.9401805983125, 5982.132590774227, 5982.730777115127, 6006.939930600813, 5849.415058494116, 5937.703114844327, 5953.791617293374, 5955.702214889325, 5973.104034394875, 5793.102069179284, 5800.76796928135, 5825.50483208915, 5907.763689452374, 5919.792807251725, 5984.611000284967, 5989.5507836913275, 6011.458968692838, 6015.819525414245, 6032.638041717511, 5802.071668533014, 5814.360420353673, 5822.126680997884, 5848.327442344185, 5858.150568167677], "value": 5599.843339554708, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.9704014799258, 607.5048835199312, 629.6725702634631, 661.7948435984848, 676.2966514824583, 44202.33696494555, 44897.0, 45210.0, 48757.26864097041, 48759.756201218945, 46225.0, 46510.53489465104, 46817.0, 46862.531374686245, 46917.0, 9158.587863546123, 9250.25997920168, 9270.258379329638, 9280.396774209688, 9285.814283714322, 9249.260059195249, 9315.767105822375, 9339.76650583734, 9340.953295233514, 9343.532823358839, 9254.305927055464, 9383.43699378036, 9383.765405864873, 9386.342955993083, 9409.482478463682, 9308.162265396113, 9329.533523323875, 9339.3462457628, 9353.95323023384, 9356.953215233949, 9150.49672268025, 9239.676611318571, 9240.306976976754, 9241.722748317561, 9243.168114869693, 44964.325535117, 45209.54790452086, 45298.320525192146, 45323.54676453259, 45389.773051134536, 3284.2446237365302, 3296.686814752619, 3313.155145437922, 3354.0608629583758, 3622.492851000862, 28602.284942876595, 29128.271793205127, 29262.853685731647, 29445.70554294451, 29695.406091878256, 3737.8878633641034, 3888.202918401721, 3888.2806680764147, 3897.123147291865, 3914.9804250978564, 322044.0, 322161.0, 323241.0, 323894.0, 324143.37928310444, 60700.69649651812, 61221.0, 61435.38564614386, 61545.692271538355, 61717.38282617116, 63673.68163159247, 64000.0, 64198.67900660467, 64304.35695643077, 64391.356086439475, 17153.571160721083, 17341.0, 17453.301867925395, 17503.03733294681, 17507.38724144649, 13560.11859229147, 13774.586762397144, 13818.93090534561, 13874.098183618033, 14105.78841317381, 17193.398231061852, 17238.138093095295, 17346.91326543359, 17541.298348065935, 17606.647867042586, 3517.75375723702, 3644.7448678592773, 3686.2443199144113, 6364.172657554581, 6714.798556043326, 1057.7038429239826, 1085.2728671789919, 1107.2581370481796, 1110.1951085463136, 1122.5734220995969, 31565.00384491364, 32383.0, 32529.186770330933, 32758.0, 32921.17697057545, 1092.9617463388743, 1104.094642393246, 1143.3470063148327, 1194.7431302270054, 1217.9025677945742, 16820.831791682172, 16961.830381696025, 16999.575010624834, 17124.229409676595, 17430.041347725743, 515328.0, 519524.0, 520874.0, 521422.0, 522373.0, 61108.0, 61355.0, 61496.69251653802, 61499.770004600556, 61599.6920015406, 1385.072001758824, 1402.3549167383119, 1404.571605660263, 1411.0757453867734, 1436.1670231265841, 31011.224719382197, 31729.68270317267, 32066.519002214518, 32726.181845454055, 33062.17344566405, 52790.47209527856, 53004.73497632487, 53186.0, 53221.0, 53255.0, 428633.0, 431259.0, 431339.0, 432523.0, 434287.0, 30089.0, 30213.244668882573, 30247.69752302449, 30302.090937271034, 30726.0, 48210.27684584664, 48581.0, 48855.267170991756, 48985.0, 49119.0, 41896.371554427315, 42781.144377112905, 43446.78276608597, 43709.69188903655, 43900.12199755923, 41290.174196516506, 41971.0, 42370.364444533974, 42558.14883702247, 42630.78684606557, 42650.78674606607, 42867.57132428761, 43552.34671479867, 43651.781741091094, 43751.78124109359, 34961.47557786686, 36736.0, 36770.448443272835, 37208.62791372051, 37389.252214955006, 28532.0, 28626.268987958872, 29012.709872901, 29187.416251675273, 29309.0], "value": 20309.47256397118, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.5755573204662, 426.726894787336, 429.72927055954744, 432.8355225014494, 438.84201687392533, 18635.0, 19097.427077187673, 20040.799592004092, 20060.598788024232, 20190.89904550477, 19035.428937131906, 19128.521786955334, 19470.610587788273, 19520.90239548804, 19721.30975415857, 5649.943500564993, 5890.028145356033, 5893.263342082239, 5908.527317814564, 5918.526517878559, 4436.64506839452, 4452.0650663360575, 5220.451852555484, 5801.6519008859395, 5882.794102206423, 6456.354364563553, 6464.482841372679, 6475.708593113298, 6484.0598113273545, 6501.057346684728, 5768.394318596529, 5787.479126878559, 5793.044147715622, 6169.321374648785, 6474.611523308593, 5637.577181711388, 5649.180868774005, 5650.406707295757, 5650.660960342392, 5659.773609055674, 13282.800757988638, 17988.820111798846, 19685.704714429296, 23225.535489290287, 23741.406464838343, 2063.7110804487384, 2183.061283648031, 2250.504888924434, 2295.3458264394567, 2697.018926973194, 5479.3424789025175, 9804.90195098047, 9810.0, 9890.0, 10162.03460671235, 1721.7073097573443, 1831.8442932350765, 1839.6044850357105, 1966.9213231470724, 1967.2229469359665, 87656.56171719101, 88487.55756221242, 89402.10597894067, 89670.0, 91679.0, 11613.0, 11855.46650400734, 11855.636601790904, 11887.346195959306, 11961.760764784829, 16889.408870689465, 16902.915485422494, 16917.830821691627, 16919.40782072646, 16980.15099245033, 8729.51987640686, 8887.822243555222, 8904.376693631384, 8905.73282801504, 9025.63897444108, 8572.657093716307, 8625.353098517511, 8653.610587523577, 8723.0, 8877.556122193993, 4750.762461876892, 4923.704577725348, 4957.752112394366, 5013.3983921928875, 5111.156659151273, 1971.8521110916738, 1994.7307113539487, 2061.093119027623, 2120.607687577803, 2159.6220661384195, 958.9808203836023, 993.965211217604, 1017.1862509991977, 1021.7854250607455, 1077.73595469109, 18738.625227495373, 18988.24047038103, 19922.103505342293, 20298.188072476936, 21232.0, 998.3311181508407, 1003.859459675646, 1005.3364779245662, 1017.8880323164447, 1063.7021633942509, 10460.424676642857, 11186.944065279622, 11204.910207774104, 11260.831087533694, 11284.943575282072, 473426.0, 478638.0, 481730.0, 484162.0, 488446.0, 81514.59242703867, 98011.0, 98440.50779746055, 99792.50103749435, 103610.0, 1015.8882522922472, 1035.2390992620417, 1065.888081751405, 1066.3974854207504, 1075.575147816608, 17554.297828087245, 17785.0, 17809.287628494716, 18006.909965450614, 18313.267469301078, 41763.0, 42553.5744642562, 43261.26954921768, 43547.0, 43613.78193109014, 60220.397796021476, 61472.38527614667, 61823.07265391113, 62394.688026559576, 63195.368046318945, 7771.572563509061, 8179.509229446252, 8736.78158046054, 9011.459312441275, 9230.630774768933, 13718.794218086936, 14021.859781402463, 14157.36291866848, 14231.786523201954, 14430.783538246726, 12195.695107622025, 12215.816762748744, 12288.38558072075, 12320.199187052813, 12461.563845265373, 11214.990650841464, 11808.76382472363, 11858.229215100991, 12029.819552706891, 12083.39583020863, 11334.14993875446, 11484.94257528707, 11780.057595392176, 11941.0, 12199.268043917393, 8049.919500804917, 8199.508029518009, 8257.95871020641, 8330.833383332421, 8802.031776504708, 11620.76758464809, 11665.183437159318, 11870.169088163746, 12087.456064476944, 12120.454579543766], "value": 9439.051615665287, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1536.5006372928797, 1540.6995635851013, 1703.8040625328083, 1827.2599597163153, 1838.2003828334666, 8442.620082096306, 8882.822343553133, 8907.37648364613, 8973.73078807636, 9280.814383712323, 9161.862572061407, 9208.263338932886, 9281.118293762082, 9294.814103717921, 9307.301952353566, 2494.638277449769, 2532.050481069599, 2553.246792196297, 2555.7316481769426, 2556.5270424971345, 2462.1505580574762, 2547.821652484327, 2547.8471291722462, 2548.120898290087, 2558.7057488388796, 2489.3403248139257, 2503.7496250374998, 2504.27376060943, 2506.1103308325555, 2513.296277042431, 2431.258466167818, 2437.7196622388474, 2468.1114798672465, 2470.3824043989002, 2474.5669507836146, 2420.140849998243, 2430.829841911067, 2450.791682706972, 2459.262221333611, 2477.182529765173, 9069.274458043341, 9206.953965230197, 9207.723768286962, 9221.0, 9272.0, 5409.9459005409835, 5558.666480011212, 5579.442055794429, 5660.066089095336, 5690.60165788395, 3327.7836940599027, 3410.488426735985, 3412.9658703412897, 3426.931461370759, 3436.879709210166, 1160.9440884946107, 1175.794236008695, 1214.4656351205442, 1251.0617037222084, 1273.2996851731602, 12406.441710123067, 12463.813042804366, 12531.874681253254, 12560.434780434902, 12619.305938173396, 4709.507479747514, 4759.643026773006, 4820.975895120502, 4881.219004959189, 4935.7532123393685, 9908.157806586521, 9932.006799320156, 9947.0, 9950.054744799232, 9970.750731231632, 5441.564674826004, 5611.270534830446, 5620.044592419298, 5625.071863142535, 5625.971870140623, 4997.075541024849, 5104.897902041938, 5210.557102646242, 5277.525022747971, 5287.206918962186, 3901.0, 3975.045988962628, 4024.678025757932, 4047.3119569673227, 4048.0, 1237.6967642927361, 1258.3205069262679, 1259.779538580763, 1271.5549557654747, 1277.495389321213, 774.5120574038319, 790.561238512631, 874.3005595523556, 938.3525367496542, 972.8978457262027, 5805.651660900359, 5895.35151133375, 5896.056630939029, 5908.970455147783, 6034.547408944347, 472.95743383095686, 482.53194401430557, 495.3980913190419, 505.94181669107786, 506.55676283252154, 3665.9083522911606, 3781.546214454283, 3821.4840996465123, 3891.610838916086, 3919.9020024499614, 10362.326448780805, 10809.78380432387, 10829.29609575375, 10843.295185812896, 10847.132229421628, 10617.628383006559, 10749.731256718645, 10758.838617420744, 10793.514291856885, 11074.114070874311, 8469.74590762278, 8664.566771661392, 8667.566621668891, 8668.046514883357, 8679.392442528962, 5553.8333849984565, 5697.316322041216, 5705.400932902152, 5719.714014299185, 5889.705514724333, 10198.490075496047, 10333.0, 10360.430176340373, 10380.844287335545, 10452.634157804441, 10299.279050466395, 10460.26778125524, 10485.213608979204, 10505.68482945513, 10571.2600117991, 7491.8501629966, 7666.578338191453, 7714.884276735741, 7718.459707820399, 7782.0, 8782.604782784661, 8789.780255493408, 8810.074942130985, 8849.51327676984, 8919.42023768453, 7730.806729831799, 7781.105172904962, 7874.84250314979, 7884.645190966306, 7922.7227047053075, 7410.740624078131, 7476.25237476248, 7481.364084052916, 7504.6247687614305, 7628.35159011468, 6811.7275308989065, 6832.077669514552, 6852.897206541807, 6886.724531018904, 6942.8611427772175, 4907.656464047625, 5038.1435156022835, 5045.646804723634, 5076.670016448919, 5205.453427390221, 4947.406311242674, 4951.133551628379, 5024.57291130258, 5087.287779710769, 5206.114960456655], "value": 4647.2815339082335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.29630627529036, 340.96760807723274, 343.4693398699008, 361.38564440451233, 363.4620761273316, 5617.550595952324, 5689.435405263549, 5699.458551437617, 5712.314522257329, 5713.200151978726, 5543.77824887005, 5576.609637325389, 5617.38208797033, 5618.831435056954, 5624.550035997121, 4399.186150562156, 4400.691951563384, 4408.184485870124, 4417.668674849383, 4419.18245124653, 4256.553061928499, 4396.340548917672, 4405.625521830648, 4411.448568928884, 4414.492333381654, 4363.563643635643, 4364.367166760818, 4378.715383500063, 4387.1006443679125, 4387.7367357958465, 4366.650667946573, 4369.759663218506, 4373.737575745466, 4380.780960951972, 4395.824167033315, 3715.294094122108, 3865.8067096645054, 3874.0, 3880.9223815523815, 3885.30064588374, 5435.31505233375, 5442.700651464168, 5446.319210098738, 5459.235707001023, 5467.17992301154, 4996.975015124901, 5015.548600625924, 5016.573591244749, 5018.47306032865, 5019.447860735316, 5598.300212473441, 5760.395158508338, 5775.509081728016, 5812.331581868097, 5822.214001109838, 4204.3903633973205, 4225.471816022997, 4225.492940847118, 4231.767252801094, 4245.45041060014, 6030.155778191057, 6056.9697151513965, 6063.575549711522, 6084.695765211722, 6101.938980610182, 4262.957370426318, 4309.569043095666, 4331.761753103547, 4338.739675619473, 4373.9125217495475, 4400.119976004812, 4414.404055452473, 4422.049259409242, 4426.26966550522, 4435.157320109169, 5013.147764879979, 5015.24771284303, 5024.748762561857, 5025.84922452327, 5038.596912247085, 5709.857253568694, 5863.442972917566, 5874.089516125007, 5911.852203694942, 5923.134212722978, 1444.270643325135, 1470.985290147085, 1481.0598116467463, 1482.2810936695694, 1486.754685476906, 1001.9749506262256, 1016.2124353625999, 1027.7358848616243, 1045.8483519889573, 1054.3621109228807, 5483.259759932358, 5487.2317875497465, 5490.368607610096, 5536.141898005815, 5540.390557038722, 5717.342505611908, 5742.827715168552, 5763.971180144073, 5830.416958304136, 5839.970800146057, 5456.6714304274365, 5462.562994960394, 5528.612997090246, 5774.88450230993, 5782.797602083991, 3125.515545090469, 3130.264387868849, 3146.166265939528, 3147.213196700825, 3148.795328303653, 6075.878482430327, 6117.0, 6129.264488261437, 6129.387061293835, 6161.291451483047, 6129.601575897642, 6140.232470941132, 6154.19995400604, 6200.162977998003, 6219.66762464076, 6293.370662933761, 6366.6180029198395, 6379.245707430401, 6379.979203327445, 6390.689908568732, 5989.910151347646, 6001.4298641628975, 6064.969675151772, 6093.720318733116, 6125.834432585706, 5983.7008149591475, 6022.156898034191, 6026.337102918763, 6036.1630033884, 6060.303065147565, 6132.9080063799975, 6298.496120310456, 6330.85329109434, 6340.270868849957, 6343.460805831556, 4356.738595684269, 4371.9344209836245, 4417.977910110429, 4452.131834292282, 4455.955440445554, 5934.584579079423, 6075.605085669417, 6209.658468784261, 6214.161088253028, 6215.378462153929, 5915.615484993462, 5923.555733319932, 5932.703364831655, 5949.702514874326, 5955.851103722442, 5841.591088623755, 5884.941150588611, 5892.587518873637, 5906.881862362815, 5948.821535353946, 5647.6893770843, 5793.449622285876, 5850.414958504116, 5863.472287493975, 5868.5305175585, 5919.852003699942, 5930.568466928538, 5935.732892019956, 5952.880942381042, 5958.510372406899, 5583.604098975256, 5736.282964629421, 5778.306603207642, 5779.393163717749, 5793.667456485116], "value": 4494.488764908526, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.0900375489333, 678.609799365365, 679.205329764176, 708.4332533972821, 746.332032830617, 14537.41850325987, 14762.11427314362, 14888.404463821435, 14905.627359316022, 14971.775423368645, 13675.247861367621, 14183.503577374768, 14385.712285754278, 14445.927770361133, 14459.987800853944, 856.648774002659, 862.874883141944, 885.751989442957, 886.2378354615026, 892.772343052524, 879.1955360844851, 881.180502133016, 885.3183049052226, 888.8488956877314, 889.6797153024905, 920.1074957291416, 927.2165020557652, 927.3137877970321, 929.8884133903907, 931.1479995803832, 914.0493886358213, 917.2616044084509, 921.4655499810127, 922.3082687984012, 924.159015296084, 677.8949262864214, 683.135833171039, 683.5249501596393, 684.1755684400285, 684.7979845945458, 15385.461508847136, 15418.614534636723, 15905.363785448568, 15938.12340321282, 15970.600734981603, 12292.323922184276, 13074.280914549696, 13643.863561364458, 13719.45122195111, 13756.587302380945, 10153.272885355856, 10700.090492308163, 10752.892471075267, 10873.891261087447, 10926.125909927187, 3735.2529494101286, 3769.830357633913, 3774.358359078963, 3795.8481660733537, 3839.9232015359535, 64064.67967660179, 64120.35879641191, 64626.030609540896, 64810.351896480905, 65066.674666626364, 9677.225821934227, 9980.589446997214, 10001.199904007663, 10079.0, 10100.84848727255, 20432.182712691327, 20441.48896277605, 20564.485887852923, 20570.58858822815, 20885.26901558438, 7290.708371665074, 7308.342249197598, 7339.073800295668, 7394.741184058532, 7573.091229052438, 4041.454403655469, 4140.0, 4152.065785198306, 4195.139996300751, 4639.164950308977, 3432.8626854925524, 3440.913977150591, 3526.982365088158, 3541.769784963969, 3545.94681079784, 609.7439075588263, 619.5013014523262, 627.2535682537765, 638.7955854126727, 649.6264647827518, 548.2133138945626, 633.9397757213058, 686.1594546680277, 688.277308825731, 691.3328637864485, 8996.640134394682, 9538.0, 9563.521823908915, 9875.703728888146, 10165.237607179492, 636.5671343486381, 687.8211664967044, 694.1184695436767, 707.5294928872345, 708.2952462300044, 4244.384564238168, 4496.527864574173, 4541.159885421208, 4554.612857907115, 4597.632189424838, 51422.742886286076, 75611.86582201271, 81106.0, 81676.59161704153, 84823.57588212019, 69593.30406695868, 71116.64441677759, 72273.0, 72533.63733181405, 72571.0, 62572.374276256654, 63947.360526395074, 64437.35562644407, 65225.0, 66681.99999999903, 9330.953345233502, 9698.806023879624, 9830.4101753895, 10142.695719128438, 10194.592216311265, 33416.1645958853, 42164.78917605515, 43134.137317254106, 44385.33421998737, 47746.76126619345, 59134.0, 60518.0, 62688.68655656693, 63257.68371158115, 63609.0, 10952.178586606196, 11019.0, 11204.719882003015, 11304.0, 11756.882431175922, 12912.418941147484, 13155.671108222372, 13455.730885382432, 13457.327133643474, 13539.187648741106, 12195.817062743889, 12304.384780760747, 12480.126391152533, 12549.435275412447, 12805.103642745291, 12765.425555850195, 12782.680432988878, 12820.23078615286, 12906.483740650268, 12935.417906194056, 12115.0, 12438.626841194779, 12473.376331183223, 12498.125131240726, 12567.685807854878, 10059.29584929048, 10164.949175254076, 10279.588816447258, 10330.638427654996, 10364.222683298933, 10283.485825708534, 10715.142788576739, 10908.78182436331, 10961.50673219691, 11071.83392249133], "value": 7017.318625722375, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1481.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 113.0, 115.0, 114.0, 113.0, 112.0, 112.0, 113.0, 116.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 119.0, 169.0, 127.0, 128.0, 122.0, 122.0, 145.0, 126.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 163.0, 161.0, 162.0, 162.0, 163.0, 164.0, 164.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 79.0, 116.0, 76.0, 76.0, 77.0, 78.0, 117.0, 80.0], "value": 85.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 109.0, 82.0, 87.0, 80.0, 93.0, 81.0, 83.0, 114.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 87.0, 85.0, 87.0, 86.0, 85.0, 85.0, 86.0, 85.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 57.0, 54.0, 54.0, 54.0, 59.0, 61.0, 55.0, 54.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 60.0, 60.0, 63.0, 60.0, 60.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 74.0, 75.0, 75.0, 76.0, 76.0, 76.0, 75.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 135.0, 135.0, 141.0, 124.0, 136.0, 122.0, 123.0, 165.0, 128.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 160.0, 159.0, 158.0, 159.0, 158.0, 159.0, 159.0, 157.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 64.0, 63.0, 63.0, 66.0, 64.0, 64.0, 65.0], "value": 64.4, "unit": "score"}]}]} 09:19:59 INFO - Return code: 0 09:19:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:19:59 ERROR - # TBPL SUCCESS # 09:19:59 INFO - Running post-action listener: _resource_record_post_action 09:19:59 INFO - [mozharness: 2017-02-14 17:19:59.807470Z] Finished run-tests step (success) 09:19:59 INFO - Running post-run listener: _resource_record_post_run 09:19:59 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320364544; Read time: 16; Write time: 234120 09:19:59 INFO - TinderboxPrint: CPU usage
13.2% 09:19:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:19:59 INFO - TinderboxPrint: I/O write bytes / time
320,364,544 / 234,120 09:19:59 INFO - TinderboxPrint: CPU idle
8,226.2 (86.8%) 09:19:59 INFO - TinderboxPrint: CPU user
1,198.2 (12.6%) 09:19:59 INFO - TinderboxPrint: Swap in / out
0 / 0 09:19:59 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 101105664; Read time: 0; Write time: 100628 09:19:59 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 219258880; Read time: 0; Write time: 133492 09:20:00 INFO - Running post-run listener: _upload_blobber_files 09:20:00 INFO - Blob upload gear active. 09:20:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:20: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 09:20: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'] 09:20: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 09:20:00 INFO - (blobuploader) - INFO - Open directory for files ... 09:20:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:20:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:20:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:01 INFO - (blobuploader) - INFO - Done attempting. 09:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:20:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:05 INFO - (blobuploader) - INFO - Done attempting. 09:20:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:20:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:20:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:07 INFO - (blobuploader) - INFO - Done attempting. 09:20:07 INFO - (blobuploader) - INFO - Iteration through files over. 09:20:07 INFO - Return code: 0 09:20:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:20:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:20:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6414bda4ee56e4bcc085ebfc059631a0bb441a9a5ed2c2742f308567115ffe228c1e589de1fd564e965f34cbba9966bc71992f46871e380c1e04fc71fd8831b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b620ab9a952b314fabeee60192380c37c9c3d711ca66f731937a6c65849ee74e6ef68409931937cbc0dae6c9632092504196106f5a38643a434ddc5186244398", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b50224ccef47a523f3ceffacc994a92ffdd550dcc8a561bc8c87eee0bf2a91aaf940800e4bd4f05f5555f73da525163ed46ce8360593ba6dde0a14453e0d03ae"} 09:20:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:20:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:20:07 INFO - Contents: 09:20:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6414bda4ee56e4bcc085ebfc059631a0bb441a9a5ed2c2742f308567115ffe228c1e589de1fd564e965f34cbba9966bc71992f46871e380c1e04fc71fd8831b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b620ab9a952b314fabeee60192380c37c9c3d711ca66f731937a6c65849ee74e6ef68409931937cbc0dae6c9632092504196106f5a38643a434ddc5186244398", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b50224ccef47a523f3ceffacc994a92ffdd550dcc8a561bc8c87eee0bf2a91aaf940800e4bd4f05f5555f73da525163ed46ce8360593ba6dde0a14453e0d03ae"} 09:20:07 INFO - Running post-run listener: copy_logs_to_upload_dir 09:20:07 INFO - Copying logs to upload dir... 09:20:07 INFO - mkdir: /builds/slave/test/build/upload/logs 09:20:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.329038 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-02-14 09:20:06.843718) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 09:20:06.848203) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805 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/e6414bda4ee56e4bcc085ebfc059631a0bb441a9a5ed2c2742f308567115ffe228c1e589de1fd564e965f34cbba9966bc71992f46871e380c1e04fc71fd8831b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b620ab9a952b314fabeee60192380c37c9c3d711ca66f731937a6c65849ee74e6ef68409931937cbc0dae6c9632092504196106f5a38643a434ddc5186244398", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b50224ccef47a523f3ceffacc994a92ffdd550dcc8a561bc8c87eee0bf2a91aaf940800e4bd4f05f5555f73da525163ed46ce8360593ba6dde0a14453e0d03ae"} build_url:https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/RrLUnlK8SIWMZISIUkIlhw/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/e6414bda4ee56e4bcc085ebfc059631a0bb441a9a5ed2c2742f308567115ffe228c1e589de1fd564e965f34cbba9966bc71992f46871e380c1e04fc71fd8831b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b620ab9a952b314fabeee60192380c37c9c3d711ca66f731937a6c65849ee74e6ef68409931937cbc0dae6c9632092504196106f5a38643a434ddc5186244398", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b50224ccef47a523f3ceffacc994a92ffdd550dcc8a561bc8c87eee0bf2a91aaf940800e4bd4f05f5555f73da525163ed46ce8360593ba6dde0a14453e0d03ae"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 09:20:06.878987) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 09:20:06.879333) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1487091571.540044-1044158805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 09:20:06.962305) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 09:20:06.962641) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 09:20:06.962939) ========= ========= Total master_lag: 0.18 =========