builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-079 starttime: 1487793939.62 results: success (0) buildid: 20170222100922 builduid: e9baa5e50b9e4defb2f80a0b145c8693 revision: 5e8888436efbedd01db019a5fd503795f3c8fdac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 12:05:39.618846) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 12:05:39.619258) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 12:05:39.619518) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 12:05:39.635783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 12:05:39.636095) ========= 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=1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-22 12:05:40-- 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-22 12:05:40 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141571 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 12:05:39.790850) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 12:05:39.791168) ========= 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=1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019344 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 12:05:39.843456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 12:05:39.844271) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5e8888436efbedd01db019a5fd503795f3c8fdac --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 5e8888436efbedd01db019a5fd503795f3c8fdac --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=1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-22 12:05:40,985 truncating revision to first 12 chars 2017-02-22 12:05:40,985 Setting DEBUG logging. 2017-02-22 12:05:40,985 attempt 1/10 2017-02-22 12:05:40,985 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5e8888436efb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-22 12:05:41,276 unpacking tar archive at: mozilla-beta-5e8888436efb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562437 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 12:05:40.420104) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 12:05:40.420425) ========= script_repo_revision: 5e8888436efbedd01db019a5fd503795f3c8fdac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 12:05:40.420791) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 12:05:40.421057) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 12:05:40.431138) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-22 12:05:40.431488) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:05:41 INFO - MultiFileLogger online at 20170222 12:05:41 in /builds/slave/test 12:05:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:05:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:05:41 INFO - {'append_to_log': False, 12:05:41 INFO - 'base_work_dir': '/builds/slave/test', 12:05:41 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:05:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:05:41 INFO - 'branch': 'Mozilla-Beta', 12:05:41 INFO - 'buildbot_json_path': 'buildprops.json', 12:05:41 INFO - 'config_files': ('talos/linux_config.py',), 12:05:41 INFO - 'default_actions': ('clobber', 12:05:41 INFO - 'read-buildbot-config', 12:05:41 INFO - 'download-and-extract', 12:05:41 INFO - 'populate-webroot', 12:05:41 INFO - 'create-virtualenv', 12:05:41 INFO - 'install', 12:05:41 INFO - 'run-tests'), 12:05:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:05:41 INFO - 'download_minidump_stackwalk': True, 12:05:41 INFO - 'download_symbols': 'ondemand', 12:05:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:05:41 INFO - 'tooltool.py': '/tools/tooltool.py', 12:05:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:05:41 INFO - '/tools/misc-python/virtualenv.py')}, 12:05:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:05:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:05:41 INFO - 'installer_path': 'installer.exe', 12:05:41 INFO - 'log_level': 'info', 12:05:41 INFO - 'log_name': 'talos', 12:05:41 INFO - 'log_to_console': True, 12:05:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:05:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:05:41 INFO - 'opt_config_files': (), 12:05:41 INFO - 'pip_index': False, 12:05:41 INFO - 'sps_profile': False, 12:05:41 INFO - 'sps_profile_interval': 0, 12:05:41 INFO - 'suite': 'dromaeojs', 12:05:41 INFO - 'system_bits': '32', 12:05:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:05:41 INFO - 'title': 'talos-linux64-ix-079', 12:05:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:05:41 INFO - 'use_talos_json': True, 12:05:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:05:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:05:41 INFO - 'work_dir': 'build'} 12:05:41 INFO - [mozharness: 2017-02-22 20:05:41.672404Z] Running clobber step. 12:05:41 INFO - Running pre-action listener: _resource_record_pre_action 12:05:41 INFO - Running main action method: clobber 12:05:41 INFO - rmtree: /builds/slave/test/build 12:05:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:05:42 INFO - Running post-action listener: _resource_record_post_action 12:05:42 INFO - [mozharness: 2017-02-22 20:05:42.601290Z] Finished clobber step (success) 12:05:42 INFO - [mozharness: 2017-02-22 20:05:42.601389Z] Running read-buildbot-config step. 12:05:42 INFO - Running pre-action listener: _resource_record_pre_action 12:05:42 INFO - Running main action method: read_buildbot_config 12:05:42 INFO - Using buildbot properties: 12:05:42 INFO - { 12:05:42 INFO - "project": "", 12:05:42 INFO - "product": "firefox", 12:05:42 INFO - "script_repo_revision": "production", 12:05:42 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:05:42 INFO - "repository": "", 12:05:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 12:05:42 INFO - "buildid": "20170222100922", 12:05:42 INFO - "pgo_build": "True", 12:05:42 INFO - "basedir": "/builds/slave/test", 12:05:42 INFO - "buildnumber": 25, 12:05:42 INFO - "slavename": "talos-linux64-ix-079", 12:05:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:05:42 INFO - "platform": "ubuntu64_hw", 12:05:42 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:05:42 INFO - "branch": "mozilla-beta", 12:05:42 INFO - "repo_path": "releases/mozilla-beta", 12:05:42 INFO - "revision": "5e8888436efbedd01db019a5fd503795f3c8fdac", 12:05:42 INFO - "stage_platform": "linux64-pgo", 12:05:42 INFO - "builduid": "e9baa5e50b9e4defb2f80a0b145c8693", 12:05:42 INFO - "slavebuilddir": "test" 12:05:42 INFO - } 12:05:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 12:05:42 INFO - Running post-action listener: _resource_record_post_action 12:05:42 INFO - [mozharness: 2017-02-22 20:05:42.603803Z] Finished read-buildbot-config step (success) 12:05:42 INFO - [mozharness: 2017-02-22 20:05:42.603891Z] Running download-and-extract step. 12:05:42 INFO - Running pre-action listener: _resource_record_pre_action 12:05:42 INFO - Running main action method: download_and_extract 12:05:42 INFO - mkdir: /builds/slave/test/build/tests 12:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:42 INFO - trying https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 12:05:42 INFO - Downloading https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/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 12:05:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/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 12:05:43 INFO - Downloaded 1327 bytes. 12:05:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 12:05:43 INFO - Using the following test package requirements: 12:05:43 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 12:05:43 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:05:43 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:05:43 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:05:43 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 12:05:43 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:05:43 INFO - u'jsshell-linux-x86_64.zip'], 12:05:43 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:05:43 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:05:43 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 12:05:43 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:05:43 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 12:05:43 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:05:43 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 12:05:43 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:05:43 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:05:43 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:05:43 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:05:43 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:05:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 12:05:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:05:43 INFO - Fetch https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 12:05:43 INFO - Http code: 200 12:05:43 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 12:05:43 INFO - x-amz-cf-id: wHV8IDbMsanlGNHUI_MG0xV5dOaqSyzcbNNBU5H6q4ATFy61Yqw-YQ== 12:05:43 INFO - x-amz-version-id: ynnX5Gkkb_FizVsBqekOwh4YEHMomHqn 12:05:44 INFO - Expected file size: 21964298 12:05:44 INFO - Obtained file size: 21964298 12:05:47 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 12:05:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 12:05:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:05:47 INFO - Fetch https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 12:05:48 INFO - Http code: 200 12:05:48 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 12:05:48 INFO - x-amz-cf-id: mdGZG-_Tj_WNQZK__oFkuG5WM0ocTvglaOBBh5l7gcrQZNDfgb8_8Q== 12:05:48 INFO - x-amz-version-id: ynnX5Gkkb_FizVsBqekOwh4YEHMomHqn 12:05:48 INFO - Expected file size: 21964298 12:05:48 INFO - Obtained file size: 21964298 12:05:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 12:05:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:05:53 INFO - Fetch https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 12:05:53 INFO - Http code: 200 12:05:53 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 12:05:53 INFO - x-amz-cf-id: HMTVmRozdR9im65AYJZALbutL5JnYXybiFw7bd5QdFFuaHAM-zex4g== 12:05:53 INFO - x-amz-version-id: bCJmVmFQXDSwFOZFRnsUwqcsn5Sej.GE 12:05:53 INFO - Expected file size: 14403005 12:05:53 INFO - Obtained file size: 14403005 12:05: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')]} 12:05:54 INFO - trying https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:05:54 INFO - Downloading https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/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 12:05:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/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 12:05:55 INFO - Downloaded 57753805 bytes. 12:05:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:05:55 INFO - mkdir: /builds/slave/test/properties 12:05:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:05:55 INFO - Writing to file /builds/slave/test/properties/build_url 12:05:55 INFO - Contents: 12:05:55 INFO - build_url:https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:05:55 INFO - Running post-action listener: _resource_record_post_action 12:05:55 INFO - Running post-action listener: set_extra_try_arguments 12:05:55 INFO - [mozharness: 2017-02-22 20:05:55.904188Z] Finished download-and-extract step (success) 12:05:55 INFO - [mozharness: 2017-02-22 20:05:55.904418Z] Running populate-webroot step. 12:05:55 INFO - Running pre-action listener: _resource_record_pre_action 12:05:55 INFO - Running main action method: populate_webroot 12:05:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:05:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:05:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:05:55 INFO - '--tppagecycles', 12:05:55 INFO - '7'], 12:05:55 INFO - 'tests': ['tsvgm']}}, 12:05:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:05:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:05:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:05:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:05:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:05:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:05:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:55 INFO - 'talos_options': ['--disable-e10s'], 12:05:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:05:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:05:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:55 INFO - 'talos_options': ['--disable-e10s'], 12:05:55 INFO - 'tests': ['damp', 'tps']}, 12:05:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:55 INFO - 'tests': ['damp', 'tps']}, 12:05:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:05:55 INFO - 'tests': ['dromaeo_dom']}, 12:05:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:05:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:05:55 INFO - 'tests': ['basic_compositor_video']}, 12:05:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:05:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:05:55 INFO - 'tests': ['a11yr', 12:05:55 INFO - 'ts_paint', 12:05:55 INFO - 'tpaint', 12:05:55 INFO - 'sessionrestore', 12:05:55 INFO - 'sessionrestore_no_auto_restore', 12:05:55 INFO - 'tabpaint']}, 12:05:55 INFO - 'other-e10s': {'tests': ['a11yr', 12:05:55 INFO - 'ts_paint', 12:05:55 INFO - 'tpaint', 12:05:55 INFO - 'sessionrestore', 12:05:55 INFO - 'sessionrestore_no_auto_restore', 12:05:55 INFO - 'tabpaint']}, 12:05:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:05:55 INFO - 'ts_paint', 12:05:55 INFO - 'tpaint', 12:05:55 INFO - 'sessionrestore', 12:05:55 INFO - 'sessionrestore_no_auto_restore', 12:05:55 INFO - 'tabpaint']}, 12:05:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:05:55 INFO - 'ts_paint', 12:05:55 INFO - 'tpaint', 12:05:55 INFO - 'sessionrestore', 12:05:55 INFO - 'sessionrestore_no_auto_restore', 12:05:55 INFO - 'tabpaint']}, 12:05:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:05:55 INFO - 'tests': ['a11yr', 12:05:55 INFO - 'ts_paint', 12:05:55 INFO - 'tpaint', 12:05:55 INFO - 'sessionrestore', 12:05:55 INFO - 'sessionrestore_no_auto_restore', 12:05:55 INFO - 'tabpaint']}, 12:05:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:05:55 INFO - 'tests': ['a11yr', 12:05:55 INFO - 'ts_paint', 12:05:55 INFO - 'tpaint', 12:05:55 INFO - 'sessionrestore', 12:05:55 INFO - 'sessionrestore_no_auto_restore', 12:05:55 INFO - 'tabpaint']}, 12:05:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:05:55 INFO - 'tests': ['tsvgx', 12:05:55 INFO - 'tsvgr_opacity', 12:05:55 INFO - 'tart', 12:05:55 INFO - 'tscrollx', 12:05:55 INFO - 'cart']}, 12:05:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:05:55 INFO - 'tsvgr_opacity', 12:05:55 INFO - 'tart', 12:05:55 INFO - 'tscrollx', 12:05:55 INFO - 'cart']}, 12:05:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:55 INFO - 'talos_options': ['--disable-e10s'], 12:05:55 INFO - 'tests': ['tp5o']}, 12:05:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:55 INFO - 'tests': ['tp5o']}, 12:05:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:55 INFO - 'talos_options': ['--disable-e10s', 12:05:55 INFO - '--xperf_path', 12:05:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:05:55 INFO - 'tests': ['tp5n']}, 12:05:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:55 INFO - 'talos_options': ['--xperf_path', 12:05:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:05:55 INFO - 'tests': ['tp5n']}}, 12:05:55 INFO - 'talos.zip': {'path': '', 12:05:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:05:55 INFO - Running post-action listener: _resource_record_post_action 12:05:55 INFO - [mozharness: 2017-02-22 20:05:55.923019Z] Finished populate-webroot step (success) 12:05:55 INFO - [mozharness: 2017-02-22 20:05:55.923107Z] Running create-virtualenv step. 12:05:55 INFO - Running pre-action listener: _resource_record_pre_action 12:05:55 INFO - Running main action method: create_virtualenv 12:05:55 INFO - Creating virtualenv /builds/slave/test/build/venv 12:05:55 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 12:05:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:05:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:05:56 INFO - Using real prefix '/usr' 12:05:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:05:56 INFO - Installing distribute.............................................................................................................................................................................................done. 12:05:58 INFO - Installing pip.................done. 12:05:58 INFO - Return code: 0 12:05:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:05:58 INFO - Reading from file tmpfile_stdout 12:05:58 INFO - Output received: 12:05:58 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) 12:05:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefbeec5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe78f60>, '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 0xe79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7a1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', '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 12:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:05:58 INFO - Using env: {'DISPLAY': ':0', 12:05:58 INFO - 'HOME': '/home/cltbld', 12:05:58 INFO - 'LANG': 'en_US.UTF-8', 12:05:58 INFO - 'LANGUAGE': 'en_US:en', 12:05:58 INFO - 'LOGNAME': 'cltbld', 12:05:58 INFO - 'MAIL': '/var/mail/cltbld', 12:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:58 INFO - 'MOZ_NO_REMOTE': '1', 12:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:58 INFO - 'NO_EM_RESTART': '1', 12:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:58 INFO - 'PWD': '/builds/slave/test', 12:05:58 INFO - 'SHELL': '/bin/bash', 12:05:58 INFO - 'SHLVL': '1', 12:05:58 INFO - 'TERM': 'linux', 12:05:58 INFO - 'TMOUT': '86400', 12:05:58 INFO - 'USER': 'cltbld', 12:05:58 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', 12:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:58 INFO - '_': '/tools/buildbot/bin/python'} 12:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:58 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 12:05:58 INFO - Cleaning up... 12:05:58 INFO - Return code: 0 12:05:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:05:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefbeec5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe78f60>, '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 0xe79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7a1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', '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 12:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:05:58 INFO - Using env: {'DISPLAY': ':0', 12:05:58 INFO - 'HOME': '/home/cltbld', 12:05:58 INFO - 'LANG': 'en_US.UTF-8', 12:05:58 INFO - 'LANGUAGE': 'en_US:en', 12:05:58 INFO - 'LOGNAME': 'cltbld', 12:05:58 INFO - 'MAIL': '/var/mail/cltbld', 12:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:58 INFO - 'MOZ_NO_REMOTE': '1', 12:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:58 INFO - 'NO_EM_RESTART': '1', 12:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:58 INFO - 'PWD': '/builds/slave/test', 12:05:58 INFO - 'SHELL': '/bin/bash', 12:05:58 INFO - 'SHLVL': '1', 12:05:58 INFO - 'TERM': 'linux', 12:05:58 INFO - 'TMOUT': '86400', 12:05:58 INFO - 'USER': 'cltbld', 12:05:58 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', 12:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:58 INFO - '_': '/tools/buildbot/bin/python'} 12:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:59 INFO - Downloading/unpacking psutil>=3.1.1 12:05: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 12:05: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 12:05: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 12:05: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 12:05: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 12:05: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 12:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:06:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:06:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:06:01 INFO - Installing collected packages: psutil 12:06:01 INFO - Running setup.py install for psutil 12:06:01 INFO - building 'psutil._psutil_linux' extension 12:06:01 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 12:06:01 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 12:06:01 INFO - building 'psutil._psutil_posix' extension 12:06:01 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 12:06:01 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 12:06:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:06:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:06:01 INFO - Successfully installed psutil 12:06:01 INFO - Cleaning up... 12:06:01 INFO - Return code: 0 12:06:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefbeec5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe78f60>, '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 0xe79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7a1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', '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 12:06:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:06:01 INFO - Using env: {'DISPLAY': ':0', 12:06:01 INFO - 'HOME': '/home/cltbld', 12:06:01 INFO - 'LANG': 'en_US.UTF-8', 12:06:01 INFO - 'LANGUAGE': 'en_US:en', 12:06:01 INFO - 'LOGNAME': 'cltbld', 12:06:01 INFO - 'MAIL': '/var/mail/cltbld', 12:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:01 INFO - 'MOZ_NO_REMOTE': '1', 12:06:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:01 INFO - 'NO_EM_RESTART': '1', 12:06:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:01 INFO - 'PWD': '/builds/slave/test', 12:06:01 INFO - 'SHELL': '/bin/bash', 12:06:01 INFO - 'SHLVL': '1', 12:06:01 INFO - 'TERM': 'linux', 12:06:01 INFO - 'TMOUT': '86400', 12:06:01 INFO - 'USER': 'cltbld', 12:06:01 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', 12:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:01 INFO - '_': '/tools/buildbot/bin/python'} 12:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:06: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 12:06: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 12:06: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 12:06: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 12:06: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 12:06: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 12:06:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:06:04 INFO - Installing collected packages: mozsystemmonitor 12:06:04 INFO - Running setup.py install for mozsystemmonitor 12:06:04 INFO - Successfully installed mozsystemmonitor 12:06:04 INFO - Cleaning up... 12:06:04 INFO - Return code: 0 12:06:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:04 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 0x7fefbeec5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe78f60>, '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 0xe79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7a1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', '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 12:06:04 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 12:06:04 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 12:06:04 INFO - Using env: {'DISPLAY': ':0', 12:06:04 INFO - 'HOME': '/home/cltbld', 12:06:04 INFO - 'LANG': 'en_US.UTF-8', 12:06:04 INFO - 'LANGUAGE': 'en_US:en', 12:06:04 INFO - 'LOGNAME': 'cltbld', 12:06:04 INFO - 'MAIL': '/var/mail/cltbld', 12:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:04 INFO - 'MOZ_NO_REMOTE': '1', 12:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:04 INFO - 'NO_EM_RESTART': '1', 12:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:04 INFO - 'PWD': '/builds/slave/test', 12:06:04 INFO - 'SHELL': '/bin/bash', 12:06:04 INFO - 'SHLVL': '1', 12:06:04 INFO - 'TERM': 'linux', 12:06:04 INFO - 'TMOUT': '86400', 12:06:04 INFO - 'USER': 'cltbld', 12:06:04 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', 12:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:04 INFO - '_': '/tools/buildbot/bin/python'} 12:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:04 INFO - Downloading/unpacking jsonschema==2.5.1 12:06:04 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 12:06:04 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 12:06:04 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 12:06:04 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 12:06:04 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 12:06:04 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 12:06:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:06:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:06 INFO - Downloading functools32-3.2.3-2.tar.gz 12:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:06:06 INFO - warning: no files found matching '*.txt' 12:06:06 INFO - no previously-included directories found matching 'build' 12:06:06 INFO - no previously-included directories found matching 'dist' 12:06:06 INFO - no previously-included directories found matching '.git*' 12:06:06 INFO - Installing collected packages: jsonschema, functools32 12:06:06 INFO - Running setup.py install for functools32 12:06:06 INFO - warning: no files found matching '*.txt' 12:06:06 INFO - no previously-included directories found matching 'build' 12:06:06 INFO - no previously-included directories found matching 'dist' 12:06:06 INFO - no previously-included directories found matching '.git*' 12:06:06 INFO - Successfully installed jsonschema functools32 12:06:06 INFO - Cleaning up... 12:06:06 INFO - Return code: 0 12:06:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:06: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')]} 12:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06: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')]} 12:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefbeec5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe78f60>, '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 0xe79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7a1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', '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 12:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:06:06 INFO - Using env: {'DISPLAY': ':0', 12:06:06 INFO - 'HOME': '/home/cltbld', 12:06:06 INFO - 'LANG': 'en_US.UTF-8', 12:06:06 INFO - 'LANGUAGE': 'en_US:en', 12:06:06 INFO - 'LOGNAME': 'cltbld', 12:06:06 INFO - 'MAIL': '/var/mail/cltbld', 12:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:06 INFO - 'MOZ_NO_REMOTE': '1', 12:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:06 INFO - 'NO_EM_RESTART': '1', 12:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:06 INFO - 'PWD': '/builds/slave/test', 12:06:06 INFO - 'SHELL': '/bin/bash', 12:06:06 INFO - 'SHLVL': '1', 12:06:06 INFO - 'TERM': 'linux', 12:06:06 INFO - 'TMOUT': '86400', 12:06:06 INFO - 'USER': 'cltbld', 12:06:06 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', 12:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:06 INFO - '_': '/tools/buildbot/bin/python'} 12:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:06:07 INFO - Cleaning up... 12:06:07 INFO - Return code: 0 12:06:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:07 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 0x7fefbeec5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe78f60>, '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 0xe79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7a1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', '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 12:06:07 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 12:06:07 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 12:06:07 INFO - Using env: {'DISPLAY': ':0', 12:06:07 INFO - 'HOME': '/home/cltbld', 12:06:07 INFO - 'LANG': 'en_US.UTF-8', 12:06:07 INFO - 'LANGUAGE': 'en_US:en', 12:06:07 INFO - 'LOGNAME': 'cltbld', 12:06:07 INFO - 'MAIL': '/var/mail/cltbld', 12:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:07 INFO - 'MOZ_NO_REMOTE': '1', 12:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:07 INFO - 'NO_EM_RESTART': '1', 12:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:07 INFO - 'PWD': '/builds/slave/test', 12:06:07 INFO - 'SHELL': '/bin/bash', 12:06:07 INFO - 'SHLVL': '1', 12:06:07 INFO - 'TERM': 'linux', 12:06:07 INFO - 'TMOUT': '86400', 12:06:07 INFO - 'USER': 'cltbld', 12:06:07 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', 12:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:07 INFO - '_': '/tools/buildbot/bin/python'} 12:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:07 INFO - Downloading/unpacking blobuploader==1.2.4 12:06:07 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 12:06:07 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 12:06:07 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 12:06:07 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 12:06:07 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 12:06:07 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 12:06:09 INFO - Downloading blobuploader-1.2.4.tar.gz 12:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:06:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:06:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:10 INFO - Downloading docopt-0.6.1.tar.gz 12:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:06:10 INFO - Installing collected packages: blobuploader, requests, docopt 12:06:10 INFO - Running setup.py install for blobuploader 12:06:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:06:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:06:10 INFO - Running setup.py install for requests 12:06:10 INFO - Running setup.py install for docopt 12:06:10 INFO - Successfully installed blobuploader requests docopt 12:06:10 INFO - Cleaning up... 12:06:10 INFO - Return code: 0 12:06:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06: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')]} 12:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06: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')]} 12:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefbeec5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe78f60>, '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 0xe79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7a1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', '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 12:06:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:06:10 INFO - Using env: {'DISPLAY': ':0', 12:06:10 INFO - 'HOME': '/home/cltbld', 12:06:10 INFO - 'LANG': 'en_US.UTF-8', 12:06:10 INFO - 'LANGUAGE': 'en_US:en', 12:06:10 INFO - 'LOGNAME': 'cltbld', 12:06:10 INFO - 'MAIL': '/var/mail/cltbld', 12:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:10 INFO - 'MOZ_NO_REMOTE': '1', 12:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:10 INFO - 'NO_EM_RESTART': '1', 12:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:10 INFO - 'PWD': '/builds/slave/test', 12:06:10 INFO - 'SHELL': '/bin/bash', 12:06:10 INFO - 'SHLVL': '1', 12:06:10 INFO - 'TERM': 'linux', 12:06:10 INFO - 'TMOUT': '86400', 12:06:10 INFO - 'USER': 'cltbld', 12:06:10 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', 12:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:10 INFO - '_': '/tools/buildbot/bin/python'} 12:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:06:11 INFO - Running setup.py (path:/tmp/pip-WqhbF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:06:11 INFO - Running setup.py (path:/tmp/pip-0BQrtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:06:11 INFO - Running setup.py (path:/tmp/pip-rsSrF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:06:11 INFO - Running setup.py (path:/tmp/pip-HjHuKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:06:11 INFO - Running setup.py (path:/tmp/pip-qsnyrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:06:11 INFO - Running setup.py (path:/tmp/pip-vPiQDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:06:11 INFO - Running setup.py (path:/tmp/pip-hQKNBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:06:11 INFO - Running setup.py (path:/tmp/pip-4NKtHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:06:11 INFO - Running setup.py (path:/tmp/pip-NdUkF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:06:11 INFO - Running setup.py (path:/tmp/pip-ekIFBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:06:11 INFO - Running setup.py (path:/tmp/pip-i7SZ4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:06:11 INFO - Running setup.py (path:/tmp/pip-jj7Ek9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:06:11 INFO - Running setup.py (path:/tmp/pip-Io2VC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:06:11 INFO - Running setup.py (path:/tmp/pip-kXfhLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:12 INFO - Running setup.py (path:/tmp/pip-Ba2Zho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:06:12 INFO - Running setup.py (path:/tmp/pip-KnINLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:06:12 INFO - Running setup.py (path:/tmp/pip-oG2V03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:06:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:06:12 INFO - Running setup.py install for manifestparser 12:06:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:06:12 INFO - Running setup.py install for mozcrash 12:06:12 INFO - Running setup.py install for mozdebug 12:06:12 INFO - Running setup.py install for mozdevice 12:06:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:06:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:06:12 INFO - Running setup.py install for mozfile 12:06:12 INFO - Running setup.py install for mozhttpd 12:06:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:06:12 INFO - Running setup.py install for mozinfo 12:06:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:06:12 INFO - Running setup.py install for mozInstall 12:06:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:06:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:06:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:06:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:06:13 INFO - Running setup.py install for mozleak 12:06:13 INFO - Running setup.py install for mozlog 12:06:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:06:13 INFO - Running setup.py install for moznetwork 12:06:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:06:13 INFO - Running setup.py install for mozprocess 12:06:13 INFO - Running setup.py install for mozprofile 12:06:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:06:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:06:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:06:13 INFO - Running setup.py install for mozrunner 12:06:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:06:13 INFO - Running setup.py install for mozscreenshot 12:06:13 INFO - Running setup.py install for moztest 12:06:13 INFO - Running setup.py install for mozversion 12:06:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:06:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:06:14 INFO - Cleaning up... 12:06:14 INFO - Return code: 0 12:06:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06:14 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')]} 12:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:14 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')]} 12:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:14 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 0x7fefbeec5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe78f60>, '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 0xe79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7a1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', '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 12:06:14 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 12:06:14 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 12:06:14 INFO - Using env: {'DISPLAY': ':0', 12:06:14 INFO - 'HOME': '/home/cltbld', 12:06:14 INFO - 'LANG': 'en_US.UTF-8', 12:06:14 INFO - 'LANGUAGE': 'en_US:en', 12:06:14 INFO - 'LOGNAME': 'cltbld', 12:06:14 INFO - 'MAIL': '/var/mail/cltbld', 12:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:14 INFO - 'MOZ_NO_REMOTE': '1', 12:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:14 INFO - 'NO_EM_RESTART': '1', 12:06:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:14 INFO - 'PWD': '/builds/slave/test', 12:06:14 INFO - 'SHELL': '/bin/bash', 12:06:14 INFO - 'SHLVL': '1', 12:06:14 INFO - 'TERM': 'linux', 12:06:14 INFO - 'TMOUT': '86400', 12:06:14 INFO - 'USER': 'cltbld', 12:06:14 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', 12:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:14 INFO - '_': '/tools/buildbot/bin/python'} 12:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:06:14 INFO - Running setup.py (path:/tmp/pip-uaZNcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:06:14 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)) 12:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:06:14 INFO - Running setup.py (path:/tmp/pip-EEB9ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:06:14 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)) 12:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:06:14 INFO - Running setup.py (path:/tmp/pip-SRzs0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:06:14 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)) 12:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:06:14 INFO - Running setup.py (path:/tmp/pip-uV29eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:06:14 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)) 12:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:06:14 INFO - Running setup.py (path:/tmp/pip-ThylMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:06:14 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)) 12:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:06:14 INFO - Running setup.py (path:/tmp/pip-X3aWs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:06:14 INFO - Running setup.py (path:/tmp/pip-Bz_5TR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:06:14 INFO - Running setup.py (path:/tmp/pip-xeJcHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:06:14 INFO - Running setup.py (path:/tmp/pip-a_oulg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:06:15 INFO - Running setup.py (path:/tmp/pip-Ujp2dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:06:15 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)) 12:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:06:15 INFO - Running setup.py (path:/tmp/pip-2CJLIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:06:15 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)) 12:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:06:15 INFO - Running setup.py (path:/tmp/pip-Fow4sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:06:15 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)) 12:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:06:15 INFO - Running setup.py (path:/tmp/pip-8UE5LE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:06:15 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)) 12:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:06:15 INFO - Running setup.py (path:/tmp/pip-lhDcHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:06:15 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)) 12:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:15 INFO - Running setup.py (path:/tmp/pip-iQBaZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:15 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)) 12:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:06:15 INFO - Running setup.py (path:/tmp/pip-xLNrbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:06:15 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)) 12:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:06:15 INFO - Running setup.py (path:/tmp/pip-r4pJPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:06:15 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)) 12:06:15 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)) 12:06:15 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)) 12:06:15 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)) 12:06:15 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)) 12:06:15 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)) 12:06:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:06:15 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 12:06:15 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 12:06:15 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 12:06:15 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 12:06:15 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 12:06:15 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 12:06:17 INFO - Downloading blessings-1.6.tar.gz 12:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:06:17 INFO - Installing collected packages: blessings 12:06:17 INFO - Running setup.py install for blessings 12:06:17 INFO - Successfully installed blessings 12:06:17 INFO - Cleaning up... 12:06:17 INFO - Return code: 0 12:06:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:06:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:06:18 INFO - Reading from file tmpfile_stdout 12:06:18 INFO - Current package versions: 12:06:18 INFO - argparse == 1.2.1 12:06:18 INFO - blessings == 1.6 12:06:18 INFO - blobuploader == 1.2.4 12:06:18 INFO - docopt == 0.6.1 12:06:18 INFO - functools32 == 3.2.3-2 12:06:18 INFO - jsonschema == 2.5.1 12:06:18 INFO - manifestparser == 1.1 12:06:18 INFO - mozInstall == 1.12 12:06:18 INFO - mozcrash == 1.0 12:06:18 INFO - mozdebug == 0.1 12:06:18 INFO - mozdevice == 0.48 12:06:18 INFO - mozfile == 1.2 12:06:18 INFO - mozhttpd == 0.7 12:06:18 INFO - mozinfo == 0.9 12:06:18 INFO - mozleak == 0.1 12:06:18 INFO - mozlog == 3.4 12:06:18 INFO - moznetwork == 0.27 12:06:18 INFO - mozprocess == 0.23 12:06:18 INFO - mozprofile == 0.28 12:06:18 INFO - mozrunner == 6.13 12:06:18 INFO - mozscreenshot == 0.1 12:06:18 INFO - mozsystemmonitor == 0.3 12:06:18 INFO - moztest == 0.8 12:06:18 INFO - mozversion == 1.4 12:06:18 INFO - psutil == 3.1.1 12:06:18 INFO - requests == 1.2.3 12:06:18 INFO - wsgiref == 0.1.2 12:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06:18 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')]} 12:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:18 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')]} 12:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:18 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 0x7fefbeec5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe78f60>, '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 0xe79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7a1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', '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 12:06:18 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 12:06:18 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 12:06:18 INFO - Using env: {'DISPLAY': ':0', 12:06:18 INFO - 'HOME': '/home/cltbld', 12:06:18 INFO - 'LANG': 'en_US.UTF-8', 12:06:18 INFO - 'LANGUAGE': 'en_US:en', 12:06:18 INFO - 'LOGNAME': 'cltbld', 12:06:18 INFO - 'MAIL': '/var/mail/cltbld', 12:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:18 INFO - 'MOZ_NO_REMOTE': '1', 12:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:18 INFO - 'NO_EM_RESTART': '1', 12:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:18 INFO - 'PWD': '/builds/slave/test', 12:06:18 INFO - 'SHELL': '/bin/bash', 12:06:18 INFO - 'SHLVL': '1', 12:06:18 INFO - 'TERM': 'linux', 12:06:18 INFO - 'TMOUT': '86400', 12:06:18 INFO - 'USER': 'cltbld', 12:06:18 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', 12:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:18 INFO - '_': '/tools/buildbot/bin/python'} 12:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:18 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)) 12:06:18 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)) 12:06:18 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)) 12:06:18 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)) 12:06:18 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)) 12:06:18 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)) 12:06:18 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)) 12:06:18 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)) 12:06:18 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)) 12:06:18 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)) 12:06:18 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)) 12:06:18 INFO - Cleaning up... 12:06:18 INFO - Return code: 0 12:06:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:06:18 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')]} 12:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:18 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')]} 12:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:18 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 0x7fefbeec5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe78f60>, '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 0xe79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7a1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', '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 12:06:18 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 12:06:18 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 12:06:18 INFO - Using env: {'DISPLAY': ':0', 12:06:18 INFO - 'HOME': '/home/cltbld', 12:06:18 INFO - 'LANG': 'en_US.UTF-8', 12:06:18 INFO - 'LANGUAGE': 'en_US:en', 12:06:18 INFO - 'LOGNAME': 'cltbld', 12:06:18 INFO - 'MAIL': '/var/mail/cltbld', 12:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:18 INFO - 'MOZ_NO_REMOTE': '1', 12:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:18 INFO - 'NO_EM_RESTART': '1', 12:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:18 INFO - 'PWD': '/builds/slave/test', 12:06:18 INFO - 'SHELL': '/bin/bash', 12:06:18 INFO - 'SHLVL': '1', 12:06:18 INFO - 'TERM': 'linux', 12:06:18 INFO - 'TMOUT': '86400', 12:06:18 INFO - 'USER': 'cltbld', 12:06:18 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', 12:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:18 INFO - '_': '/tools/buildbot/bin/python'} 12:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:06:18 INFO - Cleaning up... 12:06:18 INFO - Return code: 0 12:06:18 INFO - Running post-action listener: _resource_record_post_action 12:06:18 INFO - Running post-action listener: _start_resource_monitoring 12:06:18 INFO - Starting resource monitoring. 12:06:18 INFO - [mozharness: 2017-02-22 20:06:18.636226Z] Finished create-virtualenv step (success) 12:06:18 INFO - [mozharness: 2017-02-22 20:06:18.636683Z] Running install step. 12:06:18 INFO - Running pre-action listener: _resource_record_pre_action 12:06:18 INFO - Running main action method: install 12:06:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:06:18 INFO - Reading from file tmpfile_stdout 12:06:18 INFO - Detecting whether we're running mozinstall >=1.0... 12:06:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:06:18 INFO - Reading from file tmpfile_stdout 12:06:18 INFO - Output received: 12:06:18 INFO - Usage: mozinstall [options] installer 12:06:18 INFO - Options: 12:06:18 INFO - -h, --help show this help message and exit 12:06:18 INFO - -d DEST, --destination=DEST 12:06:18 INFO - Directory to install application into. [default: 12:06:18 INFO - "/builds/slave/test"] 12:06:18 INFO - --app=APP Application being installed. [default: firefox] 12:06:18 INFO - mkdir: /builds/slave/test/build/application 12:06:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:06:32 INFO - Reading from file tmpfile_stdout 12:06:32 INFO - Output received: 12:06:32 INFO - /builds/slave/test/build/application/firefox/firefox 12:06:32 INFO - Running post-action listener: _resource_record_post_action 12:06:32 INFO - [mozharness: 2017-02-22 20:06:32.576027Z] Finished install step (success) 12:06:32 INFO - [mozharness: 2017-02-22 20:06:32.576270Z] Running run-tests step. 12:06:32 INFO - Running pre-action listener: _resource_record_pre_action 12:06:32 INFO - Running main action method: run_tests 12:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:06:32 INFO - Python 2.7.3 12:06:32 INFO - Return code: 0 12:06:32 INFO - grabbing minidump binary from tooltool 12:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:32 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 0xe78f60>, '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 0xe79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:06:32 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 12:06:32 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 12:06:32 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 12:06:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:06:32 INFO - Return code: 0 12:06:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:06:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:06:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:06:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:06:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:06:32 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:06:32 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-079 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:06:32 INFO - Using env: {'DISPLAY': ':0', 12:06:32 INFO - 'HOME': '/home/cltbld', 12:06:32 INFO - 'LANG': 'en_US.UTF-8', 12:06:32 INFO - 'LANGUAGE': 'en_US:en', 12:06:32 INFO - 'LOGNAME': 'cltbld', 12:06:32 INFO - 'MAIL': '/var/mail/cltbld', 12:06:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:06:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:32 INFO - 'MOZ_NO_REMOTE': '1', 12:06:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:32 INFO - 'NO_EM_RESTART': '1', 12:06:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:32 INFO - 'PWD': '/builds/slave/test', 12:06:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:06:32 INFO - 'SHELL': '/bin/bash', 12:06:32 INFO - 'SHLVL': '1', 12:06:32 INFO - 'TERM': 'linux', 12:06:32 INFO - 'TMOUT': '86400', 12:06:32 INFO - 'USER': 'cltbld', 12:06:32 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695', 12:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:32 INFO - '_': '/tools/buildbot/bin/python'} 12:06:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:06:32 INFO - mozversion application_buildid: 20170222100922 12:06:32 INFO - mozversion application_changeset: 5e8888436efbedd01db019a5fd503795f3c8fdac 12:06:32 INFO - mozversion application_display_name: Firefox 12:06:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:06:32 INFO - mozversion application_name: Firefox 12:06:32 INFO - mozversion application_remotingname: firefox 12:06:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:06:32 INFO - mozversion application_vendor: Mozilla 12:06:32 INFO - mozversion application_version: 52.0 12:06:32 INFO - mozversion platform_buildid: 20170222100922 12:06:32 INFO - mozversion platform_changeset: 5e8888436efbedd01db019a5fd503795f3c8fdac 12:06:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:06:32 INFO - mozversion platform_version: 52.0 12:06:32 INFO - using testdate: 1487793992 12:06:32 INFO - actual date: 1487793992 12:06:32 INFO - starting webserver on 'localhost:42714' 12:06:32 INFO - SUITE-START | Running 2 tests 12:06:32 INFO - TEST-START | dromaeo_css 12:06:32 INFO - operating with platform_type : linux_ 12:06:32 INFO - Initialising browser for dromaeo_css test... 12:06:32 INFO - TEST-INFO | started process 9654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkw27AK/profile http://localhost:42714/getInfo.html) 12:06:36 INFO - PROCESS | 9654 | __metrics Screen width/height:1600/1200 12:06:36 INFO - PROCESS | 9654 | colorDepth:24 12:06:36 INFO - PROCESS | 9654 | Browser inner width/height: 1024/697 12:06:36 INFO - PROCESS | 9654 | __metrics 12:06:37 INFO - PROCESS | 9654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:06:37 INFO - PROCESS | 9654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:06:38 INFO - TEST-INFO | 9654: exit 0 12:06:38 INFO - Browser initialized. 12:06:38 INFO - Running cycle 1/1 for dromaeo_css test... 12:06:38 INFO - TEST-INFO | started process 9743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkw27AK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:06:50 INFO - PROCESS | 9743 | RSS: Main: 142159872 12:06:50 INFO - PROCESS | 9743 | 12:09:51 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:42714/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42714/tests/dromaeo/cssquery-ext.html) 12:09:53 INFO - PROCESS | 9743 | RSS: Main: 235991040 12:09:53 INFO - PROCESS | 9743 | 12:12:55 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:42714/tests/dromaeo/cssquery-ext.html (next: http://localhost:42714/tests/dromaeo/cssquery-jquery.html) 12:12:55 INFO - PROCESS | 9743 | RSS: Main: 228126720 12:12:55 INFO - PROCESS | 9743 | 12:15:57 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:42714/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42714/tests/dromaeo/cssquery-mootools.html) 12:15:58 INFO - PROCESS | 9743 | RSS: Main: 183844864 12:15:58 INFO - PROCESS | 9743 | 12:19:00 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:42714/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42714/tests/dromaeo/cssquery-prototype.html) 12:19:00 INFO - PROCESS | 9743 | RSS: Main: 200982528 12:19:00 INFO - PROCESS | 9743 | 12:22:03 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:42714/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42714/tests/dromaeo/cssquery-yui.html) 12:22:04 INFO - PROCESS | 9743 | RSS: Main: 173109248 12:22:04 INFO - PROCESS | 9743 | 12:25:06 INFO - PROCESS | 9743 | Cycle 1(1): loaded http://localhost:42714/tests/dromaeo/cssquery-yui.html (next: http://localhost:42714/tests/dromaeo/cssquery-dojo.html) 12:25:07 INFO - PROCESS | 9743 | RSS: Main: 266170368 12:25:07 INFO - PROCESS | 9743 | 12:25:07 INFO - PROCESS | 9743 | __start_tp_report 12:25:07 INFO - PROCESS | 9743 | _x_x_mozilla_page_load 12:25:07 INFO - PROCESS | 9743 | _x_x_mozilla_page_load_details 12:25:07 INFO - PROCESS | 9743 | |i|pagename|runs| 12:25:07 INFO - PROCESS | 9743 | |0;dojo.html;3174.6984036516533;3215.742740580754;3224.5163225516176;3242.2218667519774;3260.3153337799063;5504.669719816814;5613.522850557708;5614.66312021279;5617.550595952324;5638.943610563893;5550.056490396632;5655.57583181262;5669.177969194475;5669.404712505189;5697.173909783079;5067.569256613192;5094.1594636884865;5130.281760553526;5138.3577052868395;5172.896542069157;4996.475370086143;5168.793248270064;5190.325257716491;5195.818146364878;5199.922001169966;4951.504849515056;4986.551210391064;5057.544820966113;5062.974685126587;5113.5909127269915;5048.697078175322;5087.109755792759;5094.61790365724;5145.382554093495;5168.870778230536;5001.149804533202;5086.059079070384;5119.744012799345;5128.1794912813775;5139.665921715076;5467.425920278353;5494.835154945358;5519.668819870821;5540.36285827131;5544.417836127189;5902.61632993854;5914.556408269397;5932.495737862244;6009.519238460956;6009.789657362015;6039.758409663608;6048.304444988838;6048.576599638027;6050.092486127116;6056.666883321415;5430.8370748877205;5482.588805839578;5523.337199536081;5579.442055794388;5584.5811564132855;6049.062395328731;6072.544559157993;6079.179310793074;6082.300535438393;6083.270007599116;5836.416358364129;5843.2695913010875;5848.912266316009;5849.356570777211;5854;5816.069428891442;5879.970600147058;5892.175095486636;5958.940410595926;5992.820215393545;6021.608595441282;6028;6057.3336932937345;6058.4244496772735;6073.726682299307;5986.880262394728;6029.306629737636;6030.638161710312;6035.094735789667;6038.033914573647;4522.389477420572;4560.110778398181;4564.041551274203;4663.510331415153;4663.626909847204;4094.9385759213637;4135.60711732385;4145.709800313949;4150.460440142762;4166.83332666696;5736.71316434185;5749.655020698771;5753.453421924911;5755.510781583613;5780.219670344533;5867.266591676041;5918.289805223315;6033.095035744674;6038.094285857156;6042.154098426224;5617.775288988477;5672.347680016851;5675.290588676416;5722.399148089474;5763.971180144073;5102.056119617882;5111.667741596784;5117.5394214520875;5123.359580052494;5130.204818253177;6040.6677632730625;6197.504199664107;6225.066240064027;6234.9688251558455;6244.313125556185;5794.971025144847;5858.5898987070495;5869.618474799125;5886.852828679317;5986.2517185351835;6134.877302454015;6135.785247516315;6147.631142131487;6147.66187859672;6175.166352542529;5841.707914604168;5847.1229315603;5849.151872978309;5855.180274761622;5856.648601083949;5835.56233282497;5839.328477225174;5881.2942446906645;5920.407959204217;5948.434898684618;5775.624584402;5832.883342333214;5833.241678581757;5837.3870743571315;5857.9121313179485;5849.3858144894175;5852.356240813422;5854.092615644582;5854.590178687451;5858.355580886014;5639.6334238274385;5647.435256474319;5730.484256416776;5779.306483222041;5789;5913.231279933581;5916.26046744157;5938.554608404474;5959.970200149145;5981.162637230878;5588.217649528988;5785.074388097884;5785.913211301918;5789.8263052108505;5790.971045144747 12:25:07 INFO - PROCESS | 9743 | |1;ext.html;586.5278450847069;615.4030590327383;637.9936200637995;650.1028580558828;657.3262406033817;33068;44797.32804007938;45647;45818.7709061455;45833.54166458335;45866;45969.31046034312;46230;46243.0751384973;46276.305855412196;8144.592770361488;8367.079621241659;8872.645094196241;9019.819603607957;9025.413348132382;10574.629887953923;10799;10818.837717434244;11098.778024439507;11104;11023.338599684004;11083.113350931906;11093.1125509959;11101.333919964787;11106.555737770479;10857.51141198648;10888.29226100309;10895.618653347095;10912.345259284468;10912.836307455394;10899.727506812314;10985.340879547173;10987.285826421257;10996.450177491173;10997.395143267117;43403;43627.34558981586;43701.562984370066;43772.56227437749;43807;3563.8396272167556;3598.892033239007;3672.0452682302525;3717.6096509866343;3840.9807950960344;32444.837775811207;33001.6699833001;33090.17274568131;33269.83365083159;33330.66669333324;4470.26240670289;4500.842470513549;4698.553637404441;4810.7835147418455;4821.783019764119;337935;481126;490965;496264;497070;62777.68611157007;63182;63453;63539;63584;39049.21901561953;40076.79961600232;42250;67734;68307.65846170837;18943.62112757737;19206.61586768285;19209.231630734892;19211.61576768457;19225.711614325795;13345.93327033378;13611.183329000292;14353.712925741636;14639.780403293958;14734.852651473348;19966.30117945894;20457.2839950601;20463.79536204619;20486.282980095624;20544.79455205429;7096.787096387116;7268.927310726931;7356.668949897267;7446.106467223968;7482.139553951257;970.4129001953858;1012.7822518158631;1040.6773900090996;1103.3710784852558;1135.330155208431;31439.52840707391;31786.2053448661;31820.522692159175;31849.363012739614;32321.51517727236;997.0507657529513;1033.9121174700235;1088.1240601316017;1104.9060829829555;1173.4250217393417;16438.589035274214;16458.11982903011;16509.66980660404;16898.40855570049;16943.491695249162;493981;494370;499093;499187;500100;58211.70894145587;58550;58617.41382586119;58707.412925871045;58759;1314.3756715560032;1352.5333759852836;1359.6804750883732;1412.2656218766183;1419.6167034900518;28263.15210543687;31992;32164.03507894767;32289.35421291514;32783;49379.50620493749;49978.25032624441;49990.75004624954;50211.24683129829;50237.748811257174;374707;375492;376205;376967;379605;26963;27693.86153069222;28402.289942751595;29220.853895730386;29582.40835183241;46596.06807863756;47174.52825471701;47554.52445475639;47599.52400475951;48392.75803620959;40479.33025634835;40627.390589141774;40670;42025;42305.78847105745;41145.794271028455;41783.7910810444;41974.37038444487;42008.1598368037;43087.35368969531;38949.6105038946;41033;41114.1777164461;41450.79274603607;41566.58433415748;33410.33179336448;37024.444633329986;37090.62909370872;37587.81206093952;38367.6163238364;27631.861840690668;27675.308117297227;27975.860120699268;28009;28051.719482805725 12:25:07 INFO - PROCESS | 9743 | |2;jquery.html;385.25453247965174;390.4514157608561;403.83039123568096;408.5689597474664;425.80625815254064;18920.43238702841;19252.13365398557;19833;19919.402417927467;19987.400377988648;19017;19276;19642;20062.59874802503;20127.194912203493;5816.941830581683;5887.411258874121;6137.110119032737;6171.6297022178815;6182.1345011698395;5938.703064846741;6108.786192483264;6124.571280010378;6136;6167.568270221086;6055.909161362583;6062.696865156725;6097.298810636767;6107.236595425572;6119.816405507842;5976.983912734846;5981.671008094553;6086.634801911878;6111.480524155452;6112.297085835119;5913.349531551526;5946.613470124428;5951.285845698544;5959.910601340984;5998.820035398945;19308.517287067796;22441;22754.544909101725;23018;23250.186243481567;2325.4418939454577;2331.94170145746;2333.241696448661;2366.7869891709656;2845.573164025392;9939.90060099397;10970.177236707199;11452.942735286353;11675;15508.069515829086;1895.8009409011993;1907.904604769756;1964.8329891959202;2009.7302782779982;2013.577148798754;85476;85724.14275857224;87731;87883.56058219731;89316;11506.30962142274;11609.129315301387;11720.601025702621;11742.178047536761;11806.173567850168;16819.66360672804;16824.242909069122;16840.410585629445;16855.241514131892;16864.903781254423;8563;8860.626602876564;8880.73357799267;9055.59249833759;9090.36367454285;8535.743927682179;8620.310375169971;8668.653253869774;8841.60212790426;8871.733847984571;4901.313816065683;4999.225120106389;5012.724300163453;5123.2827404163445;5130.692158470429;1994.6808510638227;2055.8663686860305;2075.408508575079;2093.4033800366824;2097.556346855926;958.8993155718689;983.306768728045;985.7190700650424;1003.4380746781826;1039.3815679670583;18620.44138675842;19536.31622893192;19772.802271977383;19836.206551738058;19868.10593523295;1018.9032041956002;1029.2126523209752;1032.2980373346047;1052.6999805055675;1077.5366592365358;10494.895051049545;11192.608258710907;11201.66395008151;11218.439078046065;11222.382768947624;457040;459984;460367;460724;478311;89571;89996.5500172495;90199;90987.54506227426;91105;992.9772334495481;1051.348164138239;1081.1350919264557;1082.6481393547128;1093.797647435227;16465.34138634441;16750.24623891952;17392.391266305618;17544.21051052731;17804.198811053793;39781.40327895142;39868.80065599769;40301;40921.79539102285;41418.37872431856;54977.72511137419;56077.719611401684;56089.719551401984;56316.7184164093;56677.14984275157;8093.919060809317;8441.83116337682;8511.957440213007;8608.569571521273;9062.501562413867;9904.900950990397;12705.682357941125;12714.300713460849;12844.229346239255;13052.34738263064;10595.311304765166;10948;11034.944825275823;11065.944670276596;11153.107751380032;11131.276467029616;11421;11430;11442.027427668741;11482.712932176762;11055.557777688802;11355.943220283845;11508;11911.880881191077;12076.033917286772;8937.776555586162;8990.640374384951;9004.36969412135;9005.234555062892;9134.588943497425;9894.554745036634;10635.202359823199;11217.71955701114;11260.549578016788;11408.714782130513 12:25:07 INFO - PROCESS | 9743 | |3;mootools.html;1338.3796829575997;1494.9028313159645;1504.8344682084971;1666.874984376172;1802.9278828846839;7587.848243035143;8233.464824786384;8521.829563408735;8534.48793072416;8762.605682744275;8584.098669639692;8651.178138076873;8656.13438656134;8656.437331573443;8661.783455413617;2386.880655967199;2389.713234411873;2394.7964423024064;2404.5671779079757;2410.156445244168;2402;2457.852528848266;2461.7661322174363;2464.556379851626;2466.4573793765435;2371.9407014824596;2407.0371851259547;2411.3730430088217;2432.6959130108735;2463.6058230683093;2319.0491898321607;2343.0744855781954;2354.764523547649;2357.5284943011466;2361.197192954395;2372.9644055339186;2406.626972819216;2412.7345991940874;2419.9274021779374;2423.4547226873988;8554.52950087745;8562.315014798802;8625.568721563897;8629.180227878403;8636.481811091291;5211.817586384496;5408.2698835657075;5430.185472179165;5486.506214440679;5491.28613280271;3453.5855697316233;3520.2079532105327;3594.9101272468397;3597.6582224688614;3615.9638403616154;1064.414571985405;1068.369661899483;1099.1536516881956;1116.525476672411;1132.7621199548105;11758.353290569015;11771.941140294244;11853.585124520687;11868.228565143238;11933.806619337996;4286.657067434598;4619.260918253063;4619.3071039343695;4702.52974702527;4711.387519622427;9523.761905952406;9527.285453591008;9527.618895244113;9528.90471095294;9529.666461673947;5274.815381461631;5279.340082489689;5287.180487024518;5289.259503669489;5294.57643388528;4283.714885534328;4475.440569928759;4573.382593349922;4582.495925448198;4957.03337849116;3704.277665855186;3741.7754934704003;3811.085339518551;3818.7517811342173;3856.2287542491054;1164.3654208456412;1171.5782318365382;1171.83008463774;1173.7711146326556;1186.9881301186876;920.3419555018061;923.7182659288846;943.9433633981846;945.2201933404968;971.3055165556661;5522.392536820947;5522.447755224526;5543.833684989457;5644.6330988485615;5982.700864956735;904.371461834019;944.8960614332418;948.2129832239225;948.9478078705738;960.8991055939166;3692.280005398975;3705.444183372516;3722.1253005543676;3738.700903927679;3743.401055831054;10343.172546196436;10857.945710271399;10877.129829613612;10883.129349652008;10887.346759194474;10745.409002504937;10751.569937202581;10802.621908233174;10803.405812680377;10803.783924321628;8143.104258531557;8183.836323273501;8194.426390152752;8304.543250121302;8314.00231972155;5305.416404195613;5378.677279363094;5401.108817045144;5451.291332126798;5596.356419011703;9697.321187516805;9699.951500242454;9735.707928761865;9827.705168844946;9857.30998830075;8870.112988701077;9145.679901203426;9432.19826314771;9753.9024609753;9777.364471309342;7572.280633339824;7738.845223095619;7782.260685234894;7786.2213778623955;7800.531968081933;8473.237408633253;8482.575871206538;8521.147885211429;8526.701565445179;8537.146285371413;7220.819479513054;7360.815979600338;7382;7393.667284972296;7490.176080631235;7217;7292.781216563511;7374.262573742582;7459.254074592497;7500.249975002456;6842.384185423336;6852.6231057292325;6899.89650155238;6902.24075351721;6902.516823822284;4834.105690447279;4909.631777616764;4950.257461380677;4978.128827455109;4986.102501549756;4738.431388233434;4750.429948406213;4917.016596680606;4926.8768280793265;5041.319421878 12:25:07 INFO - PROCESS | 9743 | |4;prototype.html;325.44998951771504;331.5027458811782;340.9821682278399;341.67882190740704;341.9025577710353;5293.311869456965;5400.351957765069;5401.27082843816;5477;5490.670559766417;5170.4312525622245;5310.4424035476295;5318.244979156879;5325.520703136717;5329.786808527654;4277.208716387463;4281.48622165339;4287.614114729674;4292.59220374064;4295.63487103595;4161.771102589357;4238;4246.957530424703;4268.103698223361;4282.5717428257085;4242.596953289432;4245.915081698364;4246.97876510617;4256.59562341577;4262.360645903123;4240.045989652334;4259.574042595716;4265.850695225668;4271.572842715735;4281.636060934824;3650.908727281839;3760.2103558252797;3761.3041587306434;3771.830267637963;3855.4602355670227;5168.715720635363;5187.792488300463;5203.427622961472;5203.557697595709;5205.8958820823755;4777.498362671939;4817.807287708488;4843.927341089887;4857.319975203474;4865.951340486586;5364.7317634118135;5518.558515318765;5548.250986116904;5565.443455654443;5574.163875418679;4099.057216840143;4102.2410853992105;4110.671146308288;4110.77390743509;4124.649404800595;5728.22668939692;5766.682832444214;5804.506616937565;5815.331236907768;5860.384659610722;3937.6062393760967;4075.3886916962692;4088.8160032798596;4094.160697057096;4207.663386929038;4102.2410853992105;4107.404426358161;4145.150244199932;4149.149424367997;4164.9583504165175;4717.315989181549;4726.503717109723;4743.976280118577;4753.47711751714;4778.354922085474;5459.426760190123;5648.011597970339;5653.519450846724;5673.77304907799;5680.14797780328;1369.630199846036;1385.768912051596;1400.5378225185664;1435.5047508609514;1445.6772053570865;969.3117886300664;991.1129539062499;998.4708104704519;1005.3816902604991;1007.9193664506822;5260.526552610283;5266.4996825302305;5270.868228294324;5274.947250527523;5303.893922121536;5524;5537.068681236367;5546.557894947343;5570.637908536013;5574.442555744393;5204.323437953118;5235.554977826851;5237.397699264633;5248.396434410015;5512.586556008316;2984.820910745362;2987.223321936312;2987.462256793798;2988.550552981802;2991.551267309921;5800.651960882361;5819.679917604572;5820.253923822921;5839.532837373;5843.918875008138;5443.5100840923715;5635.887282254332;5648.858778530487;5671.51792097668;5685.431456854281;5792.219734527451;5836.9124463133085;5840.094785308284;5866.911996319973;5871.6770577618645;5331.653442526223;5598.944010559842;5615.494605485526;5680.176374425768;5730.283714535683;5492.615516913777;5493.23094766725;5508.788066625336;5523.226748255167;5528.318765398698;5799.217105690678;5813.331466881194;5814;5841.853953651193;5879.177454988967;4004.318186361677;4104.384342348671;4109.671226301948;4120;4122.763171048733;5496.972515137399;5549;5566.359868615161;5605.523530499953;5624.634398764068;5375.623706340519;5502.367227768857;5563;5581.609287350009;5630.887382252414;5440.836774896759;5526.784107496344;5537.8061767837935;5565.499105080562;5622.437756224344;5269.71016594091;5449.855530338673;5504.834854954358;5519.172124181245;5521.613487056028;5574.358948720949;5590.636608620589;5621.718914054362;5640.548756099584;5662.377138514842;5494.972525137348;5503.559715222693;5521.503064724194;5533.667979921218;5560.555155587463 12:25:07 INFO - PROCESS | 9743 | |5;yui.html;675.2605896543287;726.9785950739213;772.3700798780148;825.9297959673428;893.3612467086034;14497;14999.850001499968;15047.774283385757;15065.096094234326;15161.848381516182;14399.136051836897;14977.400903963855;15187.924060379682;15731.84268157318;15755.684886302268;855.7218903856241;876.0276093536202;876.1370050500252;876.2683159561774;876.5003947749785;716.4698123388681;734.7979305690951;846.8391005708926;862.5299211929513;869.6260607938584;907.5552979040289;907.7912080221553;909.077286554148;909.2453263791037;909.8180363927241;905.3029167540957;905.732808821396;905.9728208153766;906.075802681268;906.7959709065474;665.5707068940507;667.3826710292959;667.3826710293008;667.7896462614261;667.9098321726553;14155.504557340444;14258.500952466615;14306.785398218932;14308.785368219485;14885.851141488554;13793;14414.91888108396;14524.92737536316;14564.41742330316;14757.565001774694;11412.31526108436;11616.303021818718;11664.416779161093;11829;12148.635540933787;3806.365391278545;3814.408766641175;3837.6929845612563;3904.531456225243;3914.9804250978564;44975;45283.320750188774;45453.31820022669;45502;58865.70567147137;11248.94375528117;11257.887421125848;11300.208985370946;11331.943340283246;11392.145589080852;18718.532036698918;18794.436166915013;18881.055947202585;19017.809821901603;19029.714554281698;8404.957975210085;8460.619272132646;8571.271441927505;8615.22462978335;8777.166169213915;4566.292224705176;4733.5503127202865;4757.619390448755;4776.880577985578;4879.999600081975;3522.84147213376;3636.9818150909605;3654.561452625702;3661.2860492203763;3745.3258413485833;667.2093569120608;675.6081472745796;676.8781619308473;679.8504329047602;683.4737252315689;717.9389751871149;718.8382613911828;747.2191559819893;747.9476436649383;752.6725874244612;8796.78008049791;8951.194392504705;9212;9450.952745236229;9549.904500955041;536.495694047594;574.3911453858923;629.4115002472703;658.4501940879323;659.6866488417963;4088.0393107619684;4253.787310634456;4276.978615106967;4283.87148385549;4343.391925130484;69413;80277;81544.18455815366;85491;86033.56983215043;70125.2987470129;70966;72064;72684.63657681784;75036.62481687557;43396;43921;53683.463165367844;58577.414225857196;67089;8507.95746021266;8538.914610853812;8897.73306800797;9263.814723705624;9266.397684150508;30264.394712105193;36303.81848090742;44868.32697509605;46487;50083.49916500788;61850.69074654598;62820.37179628328;62986.37013629805;63607.68196158989;66361.66819165873;13519.121257118255;13833.30833458303;13850.16898986064;13872.514461993782;13923.373448195058;14473.203973781543;14784.778228326799;14814.40742370293;14819.555413337617;15660.608484787972;13431.731365372832;13928.930355348159;14360.712785744436;14464.349104290122;14499.565013049625;11967.162298639012;12332.753344933231;12535.373231338213;12538.498460061495;12964.805527917277;11757.941210293893;12212;12297.200681956003;12527.37363131858;12686.365681715693;10878.238523303293;11240.381779002233;11371.715707107389;11484.598039068593;11590.652280431601;11122.555097796321;11366.431678416211;11405.600803972153;11576.66868310155;11607.941960290145 12:25:07 INFO - PROCESS | 9743 | __end_tp_report 12:25:07 INFO - PROCESS | 9743 | __start_cc_report 12:25:07 INFO - PROCESS | 9743 | _x_x_mozilla_cycle_collect,962 12:25:07 INFO - PROCESS | 9743 | __end_cc_report 12:25:07 INFO - PROCESS | 9743 | __startTimestamp1487795107021__endTimestamp 12:25:07 INFO - PROCESS | 9743 | 12:25:07 INFO - PROCESS | 9743 | ------- Summary: start ------- 12:25:07 INFO - PROCESS | 9743 | Number of tests: 6 12:25:07 INFO - PROCESS | 9743 | 12:25:07 INFO - PROCESS | 9743 | [#0] dojo.html Cycles:165 Average:5552.40 Median:5785.91 stddev:621.86 (10.7%) stddev-sans-first:595.14 12:25:07 INFO - PROCESS | 9743 | Values: 3174.7 3215.7 3224.5 3242.2 3260.3 5504.7 5613.5 5614.7 5617.6 5638.9 5550.1 5655.6 5669.2 5669.4 5697.2 5067.6 5094.2 5130.3 5138.4 5172.9 4996.5 5168.8 5190.3 5195.8 5199.9 4951.5 4986.6 5057.5 5063.0 5113.6 5048.7 5087.1 5094.6 5145.4 5168.9 5001.1 5086.1 5119.7 5128.2 5139.7 5467.4 5494.8 5519.7 5540.4 5544.4 5902.6 5914.6 5932.5 6009.5 6009.8 6039.8 6048.3 6048.6 6050.1 6056.7 5430.8 5482.6 5523.3 5579.4 5584.6 6049.1 6072.5 6079.2 6082.3 6083.3 5836.4 5843.3 5848.9 5849.4 5854.0 5816.1 5880.0 5892.2 5958.9 5992.8 6021.6 6028.0 6057.3 6058.4 6073.7 5986.9 6029.3 6030.6 6035.1 6038.0 4522.4 4560.1 4564.0 4663.5 4663.6 4094.9 4135.6 4145.7 4150.5 4166.8 5736.7 5749.7 5753.5 5755.5 5780.2 5867.3 5918.3 6033.1 6038.1 6042.2 5617.8 5672.3 5675.3 5722.4 5764.0 5102.1 5111.7 5117.5 5123.4 5130.2 6040.7 6197.5 6225.1 6235.0 6244.3 5795.0 5858.6 5869.6 5886.9 5986.3 6134.9 6135.8 6147.6 6147.7 6175.2 5841.7 5847.1 5849.2 5855.2 5856.6 5835.6 5839.3 5881.3 5920.4 5948.4 5775.6 5832.9 5833.2 5837.4 5857.9 5849.4 5852.4 5854.1 5854.6 5858.4 5639.6 5647.4 5730.5 5779.3 5789.0 5913.2 5916.3 5938.6 5960.0 5981.2 5588.2 5785.1 5785.9 5789.8 5791.0 12:25:07 INFO - PROCESS | 9743 | 12:25:07 INFO - PROCESS | 9743 | [#1] ext.html Cycles:180 Average:60950.12 Median:376586.00 stddev:118824.72 (31.6%) stddev-sans-first:119071.63 12:25:07 INFO - PROCESS | 9743 | Values: 586.5 615.4 638.0 650.1 657.3 33068.0 44797.3 45647.0 45818.8 45833.5 45866.0 45969.3 46230.0 46243.1 46276.3 8144.6 8367.1 8872.6 9019.8 9025.4 10574.6 10799.0 10818.8 11098.8 11104.0 11023.3 11083.1 11093.1 11101.3 11106.6 10857.5 10888.3 10895.6 10912.3 10912.8 10899.7 10985.3 10987.3 10996.5 10997.4 43403.0 43627.3 43701.6 43772.6 43807.0 3563.8 3598.9 3672.0 3717.6 3841.0 32444.8 33001.7 33090.2 33269.8 33330.7 4470.3 4500.8 4698.6 4810.8 4821.8 337935.0 481126.0 490965.0 496264.0 497070.0 62777.7 63182.0 63453.0 63539.0 63584.0 39049.2 40076.8 42250.0 67734.0 68307.7 18943.6 19206.6 19209.2 19211.6 19225.7 13345.9 13611.2 14353.7 14639.8 14734.9 19966.3 20457.3 20463.8 20486.3 20544.8 7096.8 7268.9 7356.7 7446.1 7482.1 970.4 1012.8 1040.7 1103.4 1135.3 31439.5 31786.2 31820.5 31849.4 32321.5 997.1 1033.9 1088.1 1104.9 1173.4 16438.6 16458.1 16509.7 16898.4 16943.5 493981.0 494370.0 499093.0 499187.0 500100.0 58211.7 58550.0 58617.4 58707.4 58759.0 1314.4 1352.5 1359.7 1412.3 1419.6 28263.2 31992.0 32164.0 32289.4 32783.0 49379.5 49978.3 49990.8 50211.2 50237.7 374707.0 375492.0 376205.0 376967.0 379605.0 26963.0 27693.9 28402.3 29220.9 29582.4 46596.1 47174.5 47554.5 47599.5 48392.8 40479.3 40627.4 40670.0 42025.0 42305.8 41145.8 41783.8 41974.4 42008.2 43087.4 38949.6 41033.0 41114.2 41450.8 41566.6 33410.3 37024.4 37090.6 37587.8 38367.6 27631.9 27675.3 27975.9 28009.0 28051.7 12:25:07 INFO - PROCESS | 9743 | 12:25:07 INFO - PROCESS | 9743 | [#2] jquery.html Cycles:180 Average:28454.83 Median:2350.01 stddev:76573.55 (3258.4%) stddev-sans-first:76759.35 12:25:07 INFO - PROCESS | 9743 | Values: 385.3 390.5 403.8 408.6 425.8 18920.4 19252.1 19833.0 19919.4 19987.4 19017.0 19276.0 19642.0 20062.6 20127.2 5816.9 5887.4 6137.1 6171.6 6182.1 5938.7 6108.8 6124.6 6136.0 6167.6 6055.9 6062.7 6097.3 6107.2 6119.8 5977.0 5981.7 6086.6 6111.5 6112.3 5913.3 5946.6 5951.3 5959.9 5998.8 19308.5 22441.0 22754.5 23018.0 23250.2 2325.4 2331.9 2333.2 2366.8 2845.6 9939.9 10970.2 11452.9 11675.0 15508.1 1895.8 1907.9 1964.8 2009.7 2013.6 85476.0 85724.1 87731.0 87883.6 89316.0 11506.3 11609.1 11720.6 11742.2 11806.2 16819.7 16824.2 16840.4 16855.2 16864.9 8563.0 8860.6 8880.7 9055.6 9090.4 8535.7 8620.3 8668.7 8841.6 8871.7 4901.3 4999.2 5012.7 5123.3 5130.7 1994.7 2055.9 2075.4 2093.4 2097.6 958.9 983.3 985.7 1003.4 1039.4 18620.4 19536.3 19772.8 19836.2 19868.1 1018.9 1029.2 1032.3 1052.7 1077.5 10494.9 11192.6 11201.7 11218.4 11222.4 457040.0 459984.0 460367.0 460724.0 478311.0 89571.0 89996.6 90199.0 90987.5 91105.0 993.0 1051.3 1081.1 1082.6 1093.8 16465.3 16750.2 17392.4 17544.2 17804.2 39781.4 39868.8 40301.0 40921.8 41418.4 54977.7 56077.7 56089.7 56316.7 56677.1 8093.9 8441.8 8512.0 8608.6 9062.5 9904.9 12705.7 12714.3 12844.2 13052.3 10595.3 10948.0 11034.9 11065.9 11153.1 11131.3 11421.0 11430.0 11442.0 11482.7 11055.6 11355.9 11508.0 11911.9 12076.0 8937.8 8990.6 9004.4 9005.2 9134.6 9894.6 10635.2 11217.7 11260.5 11408.7 12:25:07 INFO - PROCESS | 9743 | 12:25:07 INFO - PROCESS | 9743 | [#3] mootools.html Cycles:180 Average:5646.19 Median:5243.32 stddev:3164.66 (60.4%) stddev-sans-first:3156.98 12:25:07 INFO - PROCESS | 9743 | Values: 1338.4 1494.9 1504.8 1666.9 1802.9 7587.8 8233.5 8521.8 8534.5 8762.6 8584.1 8651.2 8656.1 8656.4 8661.8 2386.9 2389.7 2394.8 2404.6 2410.2 2402.0 2457.9 2461.8 2464.6 2466.5 2371.9 2407.0 2411.4 2432.7 2463.6 2319.0 2343.1 2354.8 2357.5 2361.2 2373.0 2406.6 2412.7 2419.9 2423.5 8554.5 8562.3 8625.6 8629.2 8636.5 5211.8 5408.3 5430.2 5486.5 5491.3 3453.6 3520.2 3594.9 3597.7 3616.0 1064.4 1068.4 1099.2 1116.5 1132.8 11758.4 11771.9 11853.6 11868.2 11933.8 4286.7 4619.3 4619.3 4702.5 4711.4 9523.8 9527.3 9527.6 9528.9 9529.7 5274.8 5279.3 5287.2 5289.3 5294.6 4283.7 4475.4 4573.4 4582.5 4957.0 3704.3 3741.8 3811.1 3818.8 3856.2 1164.4 1171.6 1171.8 1173.8 1187.0 920.3 923.7 943.9 945.2 971.3 5522.4 5522.4 5543.8 5644.6 5982.7 904.4 944.9 948.2 948.9 960.9 3692.3 3705.4 3722.1 3738.7 3743.4 10343.2 10857.9 10877.1 10883.1 10887.3 10745.4 10751.6 10802.6 10803.4 10803.8 8143.1 8183.8 8194.4 8304.5 8314.0 5305.4 5378.7 5401.1 5451.3 5596.4 9697.3 9700.0 9735.7 9827.7 9857.3 8870.1 9145.7 9432.2 9753.9 9777.4 7572.3 7738.8 7782.3 7786.2 7800.5 8473.2 8482.6 8521.1 8526.7 8537.1 7220.8 7360.8 7382.0 7393.7 7490.2 7217.0 7292.8 7374.3 7459.3 7500.2 6842.4 6852.6 6899.9 6902.2 6902.5 4834.1 4909.6 4950.3 4978.1 4986.1 4738.4 4750.4 4917.0 4926.9 5041.3 12:25:07 INFO - PROCESS | 9743 | 12:25:07 INFO - PROCESS | 9743 | [#4] prototype.html Cycles:180 Average:4691.89 Median:5321.88 stddev:1350.93 (25.4%) stddev-sans-first:1314.36 12:25:07 INFO - PROCESS | 9743 | Values: 325.4 331.5 341.0 341.7 341.9 5293.3 5400.4 5401.3 5477.0 5490.7 5170.4 5310.4 5318.2 5325.5 5329.8 4277.2 4281.5 4287.6 4292.6 4295.6 4161.8 4238.0 4247.0 4268.1 4282.6 4242.6 4245.9 4247.0 4256.6 4262.4 4240.0 4259.6 4265.9 4271.6 4281.6 3650.9 3760.2 3761.3 3771.8 3855.5 5168.7 5187.8 5203.4 5203.6 5205.9 4777.5 4817.8 4843.9 4857.3 4866.0 5364.7 5518.6 5548.3 5565.4 5574.2 4099.1 4102.2 4110.7 4110.8 4124.6 5728.2 5766.7 5804.5 5815.3 5860.4 3937.6 4075.4 4088.8 4094.2 4207.7 4102.2 4107.4 4145.2 4149.1 4165.0 4717.3 4726.5 4744.0 4753.5 4778.4 5459.4 5648.0 5653.5 5673.8 5680.1 1369.6 1385.8 1400.5 1435.5 1445.7 969.3 991.1 998.5 1005.4 1007.9 5260.5 5266.5 5270.9 5274.9 5303.9 5524.0 5537.1 5546.6 5570.6 5574.4 5204.3 5235.6 5237.4 5248.4 5512.6 2984.8 2987.2 2987.5 2988.6 2991.6 5800.7 5819.7 5820.3 5839.5 5843.9 5443.5 5635.9 5648.9 5671.5 5685.4 5792.2 5836.9 5840.1 5866.9 5871.7 5331.7 5598.9 5615.5 5680.2 5730.3 5492.6 5493.2 5508.8 5523.2 5528.3 5799.2 5813.3 5814.0 5841.9 5879.2 4004.3 4104.4 4109.7 4120.0 4122.8 5497.0 5549.0 5566.4 5605.5 5624.6 5375.6 5502.4 5563.0 5581.6 5630.9 5440.8 5526.8 5537.8 5565.5 5622.4 5269.7 5449.9 5504.8 5519.2 5521.6 5574.4 5590.6 5621.7 5640.5 5662.4 5495.0 5503.6 5521.5 5533.7 5560.6 12:25:07 INFO - PROCESS | 9743 | 12:25:07 INFO - PROCESS | 9743 | [#5] yui.html Cycles:180 Average:16681.65 Median:45129.16 stddev:20996.13 (46.5%) stddev-sans-first:21020.62 12:25:07 INFO - PROCESS | 9743 | Values: 675.3 727.0 772.4 825.9 893.4 14497.0 14999.9 15047.8 15065.1 15161.8 14399.1 14977.4 15187.9 15731.8 15755.7 855.7 876.0 876.1 876.3 876.5 716.5 734.8 846.8 862.5 869.6 907.6 907.8 909.1 909.2 909.8 905.3 905.7 906.0 906.1 906.8 665.6 667.4 667.4 667.8 667.9 14155.5 14258.5 14306.8 14308.8 14885.9 13793.0 14414.9 14524.9 14564.4 14757.6 11412.3 11616.3 11664.4 11829.0 12148.6 3806.4 3814.4 3837.7 3904.5 3915.0 44975.0 45283.3 45453.3 45502.0 58865.7 11248.9 11257.9 11300.2 11331.9 11392.1 18718.5 18794.4 18881.1 19017.8 19029.7 8405.0 8460.6 8571.3 8615.2 8777.2 4566.3 4733.6 4757.6 4776.9 4880.0 3522.8 3637.0 3654.6 3661.3 3745.3 667.2 675.6 676.9 679.9 683.5 717.9 718.8 747.2 747.9 752.7 8796.8 8951.2 9212.0 9451.0 9549.9 536.5 574.4 629.4 658.5 659.7 4088.0 4253.8 4277.0 4283.9 4343.4 69413.0 80277.0 81544.2 85491.0 86033.6 70125.3 70966.0 72064.0 72684.6 75036.6 43396.0 43921.0 53683.5 58577.4 67089.0 8508.0 8538.9 8897.7 9263.8 9266.4 30264.4 36303.8 44868.3 46487.0 50083.5 61850.7 62820.4 62986.4 63607.7 66361.7 13519.1 13833.3 13850.2 13872.5 13923.4 14473.2 14784.8 14814.4 14819.6 15660.6 13431.7 13928.9 14360.7 14464.3 14499.6 11967.2 12332.8 12535.4 12538.5 12964.8 11757.9 12212.0 12297.2 12527.4 12686.4 10878.2 11240.4 11371.7 11484.6 11590.7 11122.6 11366.4 11405.6 11576.7 11607.9 12:25:07 INFO - PROCESS | 9743 | -------- Summary: end -------- 12:25:07 INFO - PROCESS | 9743 | 12:25:07 INFO - TEST-INFO | 9743: exit 0 12:25:07 INFO - TEST-OK | dromaeo_css | took 1114955ms 12:25:07 INFO - TEST-START | kraken 12:25:07 INFO - operating with platform_type : linux_ 12:25:07 INFO - Initialising browser for kraken test... 12:25:07 INFO - TEST-INFO | started process 10050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOEKQQR/profile http://localhost:42714/getInfo.html) 12:25:11 INFO - PROCESS | 10050 | __metrics Screen width/height:1600/1200 12:25:11 INFO - PROCESS | 10050 | colorDepth:24 12:25:11 INFO - PROCESS | 10050 | Browser inner width/height: 1024/697 12:25:11 INFO - PROCESS | 10050 | __metrics 12:25:12 INFO - PROCESS | 10050 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:25:12 INFO - PROCESS | 10050 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:25:13 INFO - TEST-INFO | 10050: exit 0 12:25:13 INFO - Browser initialized. 12:25:13 INFO - Running cycle 1/1 for kraken test... 12:25:13 INFO - TEST-INFO | started process 10143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOEKQQR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:25:25 INFO - PROCESS | 10143 | RSS: Main: 141484032 12:25:25 INFO - PROCESS | 10143 | 12:25:28 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:42714/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42714/tests/kraken/driver.html?testName=audio-beat-detection) 12:25:28 INFO - PROCESS | 10143 | RSS: Main: 183443456 12:25:28 INFO - PROCESS | 10143 | 12:25:31 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:42714/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42714/tests/kraken/driver.html?testName=audio-dft) 12:25:32 INFO - PROCESS | 10143 | RSS: Main: 173510656 12:25:32 INFO - PROCESS | 10143 | 12:25:34 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:42714/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42714/tests/kraken/driver.html?testName=audio-fft) 12:25:35 INFO - PROCESS | 10143 | RSS: Main: 264581120 12:25:35 INFO - PROCESS | 10143 | 12:25:37 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:42714/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42714/tests/kraken/driver.html?testName=audio-oscillator) 12:25:38 INFO - PROCESS | 10143 | RSS: Main: 171036672 12:25:38 INFO - PROCESS | 10143 | 12:25:40 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:42714/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42714/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:25:40 INFO - PROCESS | 10143 | RSS: Main: 174108672 12:25:40 INFO - PROCESS | 10143 | 12:25:43 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:42714/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42714/tests/kraken/driver.html?testName=imaging-darkroom) 12:25:44 INFO - PROCESS | 10143 | RSS: Main: 211513344 12:25:44 INFO - PROCESS | 10143 | 12:25:47 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:42714/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42714/tests/kraken/driver.html?testName=imaging-desaturate) 12:25:48 INFO - PROCESS | 10143 | RSS: Main: 211439616 12:25:48 INFO - PROCESS | 10143 | 12:25:50 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:42714/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42714/tests/kraken/driver.html?testName=json-parse-financial) 12:25:51 INFO - PROCESS | 10143 | RSS: Main: 210280448 12:25:51 INFO - PROCESS | 10143 | 12:25:52 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:42714/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42714/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:25:53 INFO - PROCESS | 10143 | RSS: Main: 172220416 12:25:53 INFO - PROCESS | 10143 | 12:25:55 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:42714/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42714/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:25:55 INFO - PROCESS | 10143 | RSS: Main: 179326976 12:25:55 INFO - PROCESS | 10143 | 12:25:57 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:42714/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42714/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:25:58 INFO - PROCESS | 10143 | RSS: Main: 187662336 12:25:58 INFO - PROCESS | 10143 | 12:26:00 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:42714/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:26:01 INFO - PROCESS | 10143 | RSS: Main: 196722688 12:26:01 INFO - PROCESS | 10143 | 12:26:04 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:42714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:26:04 INFO - PROCESS | 10143 | RSS: Main: 192954368 12:26:04 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | Cycle 1(1): loaded http://localhost:42714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42714/tests/kraken/driver.html?testName=ai-astar) 12:26:06 INFO - PROCESS | 10143 | RSS: Main: 245075968 12:26:06 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | __start_tp_report 12:26:06 INFO - PROCESS | 10143 | _x_x_mozilla_page_load 12:26:06 INFO - PROCESS | 10143 | _x_x_mozilla_page_load_details 12:26:06 INFO - PROCESS | 10143 | |i|pagename|runs| 12:26:06 INFO - PROCESS | 10143 | |0;ai-astar;102;111;111;114;113;111;111;111;111;110 12:26:06 INFO - PROCESS | 10143 | |1;audio-beat-detection;145;118;117;156;141;120;122;117;148;118 12:26:06 INFO - PROCESS | 10143 | |2;audio-dft;160;160;161;159;161;160;160;161;161;161 12:26:06 INFO - PROCESS | 10143 | |3;audio-fft;73;74;74;111;76;75;76;76;100;75 12:26:06 INFO - PROCESS | 10143 | |4;audio-oscillator;81;82;126;82;82;82;106;82;83;115 12:26:06 INFO - PROCESS | 10143 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;116;117;118 12:26:06 INFO - PROCESS | 10143 | |6;imaging-darkroom;146;146;145;146;146;145;145;146;145;145 12:26:06 INFO - PROCESS | 10143 | |7;imaging-desaturate;84;85;84;84;84;84;84;85;84;84 12:26:06 INFO - PROCESS | 10143 | |8;json-parse-financial;53;51;54;51;53;51;52;52;52;52 12:26:06 INFO - PROCESS | 10143 | |9;json-stringify-tinderbox;60;59;59;59;59;59;60;59;59;58 12:26:06 INFO - PROCESS | 10143 | |10;stanford-crypto-aes;75;74;74;75;74;74;75;75;77;75 12:26:06 INFO - PROCESS | 10143 | |11;stanford-crypto-ccm;132;123;137;130;131;121;129;130;161;123 12:26:06 INFO - PROCESS | 10143 | |12;stanford-crypto-pbkdf2;163;158;157;155;155;158;156;156;156;154 12:26:06 INFO - PROCESS | 10143 | |13;stanford-crypto-sha256-iterative;63;65;65;62;69;64;62;63;63;62 12:26:06 INFO - PROCESS | 10143 | __end_tp_report 12:26:06 INFO - PROCESS | 10143 | __start_cc_report 12:26:06 INFO - PROCESS | 10143 | _x_x_mozilla_cycle_collect,1569 12:26:06 INFO - PROCESS | 10143 | __end_cc_report 12:26:06 INFO - PROCESS | 10143 | __startTimestamp1487795166888__endTimestamp 12:26:06 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | ------- Summary: start ------- 12:26:06 INFO - PROCESS | 10143 | Number of tests: 14 12:26:06 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:3.21 (2.9%) stddev-sans-first:1.24 12:26:06 INFO - PROCESS | 10143 | Values: 102.0 111.0 111.0 114.0 113.0 111.0 111.0 111.0 111.0 110.0 12:26:06 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | [#1] audio-beat-detection Cycles:10 Average:130.20 Median:131.50 stddev:15.40 (11.7%) stddev-sans-first:15.38 12:26:06 INFO - PROCESS | 10143 | Values: 145.0 118.0 117.0 156.0 141.0 120.0 122.0 117.0 148.0 118.0 12:26:06 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 12:26:06 INFO - PROCESS | 10143 | Values: 160.0 160.0 161.0 159.0 161.0 160.0 160.0 161.0 161.0 161.0 12:26:06 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:13.21 (17.6%) stddev-sans-first:13.69 12:26:06 INFO - PROCESS | 10143 | Values: 73.0 74.0 74.0 111.0 76.0 75.0 76.0 76.0 100.0 75.0 12:26:06 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:82.00 stddev:16.94 (20.7%) stddev-sans-first:17.49 12:26:06 INFO - PROCESS | 10143 | Values: 81.0 82.0 126.0 82.0 82.0 82.0 106.0 82.0 83.0 115.0 12:26:06 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 12:26:06 INFO - PROCESS | 10143 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 118.0 12:26:06 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 12:26:06 INFO - PROCESS | 10143 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 12:26:06 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 12:26:06 INFO - PROCESS | 10143 | Values: 84.0 85.0 84.0 84.0 84.0 84.0 84.0 85.0 84.0 84.0 12:26:06 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:0.99 (1.9%) stddev-sans-first:1.00 12:26:06 INFO - PROCESS | 10143 | Values: 53.0 51.0 54.0 51.0 53.0 51.0 52.0 52.0 52.0 52.0 12:26:06 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.50 12:26:06 INFO - PROCESS | 10143 | Values: 60.0 59.0 59.0 59.0 59.0 59.0 60.0 59.0 59.0 58.0 12:26:06 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:75.00 stddev:0.92 (1.2%) stddev-sans-first:0.97 12:26:06 INFO - PROCESS | 10143 | Values: 75.0 74.0 74.0 75.0 74.0 74.0 75.0 75.0 77.0 75.0 12:26:06 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:130.50 stddev:11.38 (8.7%) stddev-sans-first:12.07 12:26:06 INFO - PROCESS | 10143 | Values: 132.0 123.0 137.0 130.0 131.0 121.0 129.0 130.0 161.0 123.0 12:26:06 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:156.50 stddev:2.53 (1.6%) stddev-sans-first:1.36 12:26:06 INFO - PROCESS | 10143 | Values: 163.0 158.0 157.0 155.0 155.0 158.0 156.0 156.0 156.0 154.0 12:26:06 INFO - PROCESS | 10143 | 12:26:06 INFO - PROCESS | 10143 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:2.15 (3.4%) stddev-sans-first:2.26 12:26:06 INFO - PROCESS | 10143 | Values: 63.0 65.0 65.0 62.0 69.0 64.0 62.0 63.0 63.0 62.0 12:26:06 INFO - PROCESS | 10143 | -------- Summary: end -------- 12:26:06 INFO - PROCESS | 10143 | 12:26:07 INFO - TEST-INFO | 10143: exit 0 12:26:07 INFO - TEST-OK | kraken | took 60119ms 12:26:07 INFO - SUITE-END | took 1175s 12:26:08 INFO - Completed test suite (00:19:35) 12:26:08 INFO - javascript benchmark 12:26:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3174.6984036516533, 3215.742740580754, 3224.5163225516176, 3242.2218667519774, 3260.3153337799063, 5504.669719816814, 5613.522850557708, 5614.66312021279, 5617.550595952324, 5638.943610563893, 5550.056490396632, 5655.57583181262, 5669.177969194475, 5669.404712505189, 5697.173909783079, 5067.569256613192, 5094.1594636884865, 5130.281760553526, 5138.3577052868395, 5172.896542069157, 4996.475370086143, 5168.793248270064, 5190.325257716491, 5195.818146364878, 5199.922001169966, 4951.504849515056, 4986.551210391064, 5057.544820966113, 5062.974685126587, 5113.5909127269915, 5048.697078175322, 5087.109755792759, 5094.61790365724, 5145.382554093495, 5168.870778230536, 5001.149804533202, 5086.059079070384, 5119.744012799345, 5128.1794912813775, 5139.665921715076, 5467.425920278353, 5494.835154945358, 5519.668819870821, 5540.36285827131, 5544.417836127189, 5902.61632993854, 5914.556408269397, 5932.495737862244, 6009.519238460956, 6009.789657362015, 6039.758409663608, 6048.304444988838, 6048.576599638027, 6050.092486127116, 6056.666883321415, 5430.8370748877205, 5482.588805839578, 5523.337199536081, 5579.442055794388, 5584.5811564132855, 6049.062395328731, 6072.544559157993, 6079.179310793074, 6082.300535438393, 6083.270007599116, 5836.416358364129, 5843.2695913010875, 5848.912266316009, 5849.356570777211, 5854.0, 5816.069428891442, 5879.970600147058, 5892.175095486636, 5958.940410595926, 5992.820215393545, 6021.608595441282, 6028.0, 6057.3336932937345, 6058.4244496772735, 6073.726682299307, 5986.880262394728, 6029.306629737636, 6030.638161710312, 6035.094735789667, 6038.033914573647, 4522.389477420572, 4560.110778398181, 4564.041551274203, 4663.510331415153, 4663.626909847204, 4094.9385759213637, 4135.60711732385, 4145.709800313949, 4150.460440142762, 4166.83332666696, 5736.71316434185, 5749.655020698771, 5753.453421924911, 5755.510781583613, 5780.219670344533, 5867.266591676041, 5918.289805223315, 6033.095035744674, 6038.094285857156, 6042.154098426224, 5617.775288988477, 5672.347680016851, 5675.290588676416, 5722.399148089474, 5763.971180144073, 5102.056119617882, 5111.667741596784, 5117.5394214520875, 5123.359580052494, 5130.204818253177, 6040.6677632730625, 6197.504199664107, 6225.066240064027, 6234.9688251558455, 6244.313125556185, 5794.971025144847, 5858.5898987070495, 5869.618474799125, 5886.852828679317, 5986.2517185351835, 6134.877302454015, 6135.785247516315, 6147.631142131487, 6147.66187859672, 6175.166352542529, 5841.707914604168, 5847.1229315603, 5849.151872978309, 5855.180274761622, 5856.648601083949, 5835.56233282497, 5839.328477225174, 5881.2942446906645, 5920.407959204217, 5948.434898684618, 5775.624584402, 5832.883342333214, 5833.241678581757, 5837.3870743571315, 5857.9121313179485, 5849.3858144894175, 5852.356240813422, 5854.092615644582, 5854.590178687451, 5858.355580886014, 5639.6334238274385, 5647.435256474319, 5730.484256416776, 5779.306483222041, 5789.0, 5913.231279933581, 5916.26046744157, 5938.554608404474, 5959.970200149145, 5981.162637230878, 5588.217649528988, 5785.074388097884, 5785.913211301918, 5789.8263052108505, 5790.971045144747], "value": 5510.77761277833, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.5278450847069, 615.4030590327383, 637.9936200637995, 650.1028580558828, 657.3262406033817, 33068.0, 44797.32804007938, 45647.0, 45818.7709061455, 45833.54166458335, 45866.0, 45969.31046034312, 46230.0, 46243.0751384973, 46276.305855412196, 8144.592770361488, 8367.079621241659, 8872.645094196241, 9019.819603607957, 9025.413348132382, 10574.629887953923, 10799.0, 10818.837717434244, 11098.778024439507, 11104.0, 11023.338599684004, 11083.113350931906, 11093.1125509959, 11101.333919964787, 11106.555737770479, 10857.51141198648, 10888.29226100309, 10895.618653347095, 10912.345259284468, 10912.836307455394, 10899.727506812314, 10985.340879547173, 10987.285826421257, 10996.450177491173, 10997.395143267117, 43403.0, 43627.34558981586, 43701.562984370066, 43772.56227437749, 43807.0, 3563.8396272167556, 3598.892033239007, 3672.0452682302525, 3717.6096509866343, 3840.9807950960344, 32444.837775811207, 33001.6699833001, 33090.17274568131, 33269.83365083159, 33330.66669333324, 4470.26240670289, 4500.842470513549, 4698.553637404441, 4810.7835147418455, 4821.783019764119, 337935.0, 481126.0, 490965.0, 496264.0, 497070.0, 62777.68611157007, 63182.0, 63453.0, 63539.0, 63584.0, 39049.21901561953, 40076.79961600232, 42250.0, 67734.0, 68307.65846170837, 18943.62112757737, 19206.61586768285, 19209.231630734892, 19211.61576768457, 19225.711614325795, 13345.93327033378, 13611.183329000292, 14353.712925741636, 14639.780403293958, 14734.852651473348, 19966.30117945894, 20457.2839950601, 20463.79536204619, 20486.282980095624, 20544.79455205429, 7096.787096387116, 7268.927310726931, 7356.668949897267, 7446.106467223968, 7482.139553951257, 970.4129001953858, 1012.7822518158631, 1040.6773900090996, 1103.3710784852558, 1135.330155208431, 31439.52840707391, 31786.2053448661, 31820.522692159175, 31849.363012739614, 32321.51517727236, 997.0507657529513, 1033.9121174700235, 1088.1240601316017, 1104.9060829829555, 1173.4250217393417, 16438.589035274214, 16458.11982903011, 16509.66980660404, 16898.40855570049, 16943.491695249162, 493981.0, 494370.0, 499093.0, 499187.0, 500100.0, 58211.70894145587, 58550.0, 58617.41382586119, 58707.412925871045, 58759.0, 1314.3756715560032, 1352.5333759852836, 1359.6804750883732, 1412.2656218766183, 1419.6167034900518, 28263.15210543687, 31992.0, 32164.03507894767, 32289.35421291514, 32783.0, 49379.50620493749, 49978.25032624441, 49990.75004624954, 50211.24683129829, 50237.748811257174, 374707.0, 375492.0, 376205.0, 376967.0, 379605.0, 26963.0, 27693.86153069222, 28402.289942751595, 29220.853895730386, 29582.40835183241, 46596.06807863756, 47174.52825471701, 47554.52445475639, 47599.52400475951, 48392.75803620959, 40479.33025634835, 40627.390589141774, 40670.0, 42025.0, 42305.78847105745, 41145.794271028455, 41783.7910810444, 41974.37038444487, 42008.1598368037, 43087.35368969531, 38949.6105038946, 41033.0, 41114.1777164461, 41450.79274603607, 41566.58433415748, 33410.33179336448, 37024.444633329986, 37090.62909370872, 37587.81206093952, 38367.6163238364, 27631.861840690668, 27675.308117297227, 27975.860120699268, 28009.0, 28051.719482805725], "value": 20886.586243104048, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.25453247965174, 390.4514157608561, 403.83039123568096, 408.5689597474664, 425.80625815254064, 18920.43238702841, 19252.13365398557, 19833.0, 19919.402417927467, 19987.400377988648, 19017.0, 19276.0, 19642.0, 20062.59874802503, 20127.194912203493, 5816.941830581683, 5887.411258874121, 6137.110119032737, 6171.6297022178815, 6182.1345011698395, 5938.703064846741, 6108.786192483264, 6124.571280010378, 6136.0, 6167.568270221086, 6055.909161362583, 6062.696865156725, 6097.298810636767, 6107.236595425572, 6119.816405507842, 5976.983912734846, 5981.671008094553, 6086.634801911878, 6111.480524155452, 6112.297085835119, 5913.349531551526, 5946.613470124428, 5951.285845698544, 5959.910601340984, 5998.820035398945, 19308.517287067796, 22441.0, 22754.544909101725, 23018.0, 23250.186243481567, 2325.4418939454577, 2331.94170145746, 2333.241696448661, 2366.7869891709656, 2845.573164025392, 9939.90060099397, 10970.177236707199, 11452.942735286353, 11675.0, 15508.069515829086, 1895.8009409011993, 1907.904604769756, 1964.8329891959202, 2009.7302782779982, 2013.577148798754, 85476.0, 85724.14275857224, 87731.0, 87883.56058219731, 89316.0, 11506.30962142274, 11609.129315301387, 11720.601025702621, 11742.178047536761, 11806.173567850168, 16819.66360672804, 16824.242909069122, 16840.410585629445, 16855.241514131892, 16864.903781254423, 8563.0, 8860.626602876564, 8880.73357799267, 9055.59249833759, 9090.36367454285, 8535.743927682179, 8620.310375169971, 8668.653253869774, 8841.60212790426, 8871.733847984571, 4901.313816065683, 4999.225120106389, 5012.724300163453, 5123.2827404163445, 5130.692158470429, 1994.6808510638227, 2055.8663686860305, 2075.408508575079, 2093.4033800366824, 2097.556346855926, 958.8993155718689, 983.306768728045, 985.7190700650424, 1003.4380746781826, 1039.3815679670583, 18620.44138675842, 19536.31622893192, 19772.802271977383, 19836.206551738058, 19868.10593523295, 1018.9032041956002, 1029.2126523209752, 1032.2980373346047, 1052.6999805055675, 1077.5366592365358, 10494.895051049545, 11192.608258710907, 11201.66395008151, 11218.439078046065, 11222.382768947624, 457040.0, 459984.0, 460367.0, 460724.0, 478311.0, 89571.0, 89996.5500172495, 90199.0, 90987.54506227426, 91105.0, 992.9772334495481, 1051.348164138239, 1081.1350919264557, 1082.6481393547128, 1093.797647435227, 16465.34138634441, 16750.24623891952, 17392.391266305618, 17544.21051052731, 17804.198811053793, 39781.40327895142, 39868.80065599769, 40301.0, 40921.79539102285, 41418.37872431856, 54977.72511137419, 56077.719611401684, 56089.719551401984, 56316.7184164093, 56677.14984275157, 8093.919060809317, 8441.83116337682, 8511.957440213007, 8608.569571521273, 9062.501562413867, 9904.900950990397, 12705.682357941125, 12714.300713460849, 12844.229346239255, 13052.34738263064, 10595.311304765166, 10948.0, 11034.944825275823, 11065.944670276596, 11153.107751380032, 11131.276467029616, 11421.0, 11430.0, 11442.027427668741, 11482.712932176762, 11055.557777688802, 11355.943220283845, 11508.0, 11911.880881191077, 12076.033917286772, 8937.776555586162, 8990.640374384951, 9004.36969412135, 9005.234555062892, 9134.588943497425, 9894.554745036634, 10635.202359823199, 11217.71955701114, 11260.549578016788, 11408.714782130513], "value": 9439.929587255763, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.3796829575997, 1494.9028313159645, 1504.8344682084971, 1666.874984376172, 1802.9278828846839, 7587.848243035143, 8233.464824786384, 8521.829563408735, 8534.48793072416, 8762.605682744275, 8584.098669639692, 8651.178138076873, 8656.13438656134, 8656.437331573443, 8661.783455413617, 2386.880655967199, 2389.713234411873, 2394.7964423024064, 2404.5671779079757, 2410.156445244168, 2402.0, 2457.852528848266, 2461.7661322174363, 2464.556379851626, 2466.4573793765435, 2371.9407014824596, 2407.0371851259547, 2411.3730430088217, 2432.6959130108735, 2463.6058230683093, 2319.0491898321607, 2343.0744855781954, 2354.764523547649, 2357.5284943011466, 2361.197192954395, 2372.9644055339186, 2406.626972819216, 2412.7345991940874, 2419.9274021779374, 2423.4547226873988, 8554.52950087745, 8562.315014798802, 8625.568721563897, 8629.180227878403, 8636.481811091291, 5211.817586384496, 5408.2698835657075, 5430.185472179165, 5486.506214440679, 5491.28613280271, 3453.5855697316233, 3520.2079532105327, 3594.9101272468397, 3597.6582224688614, 3615.9638403616154, 1064.414571985405, 1068.369661899483, 1099.1536516881956, 1116.525476672411, 1132.7621199548105, 11758.353290569015, 11771.941140294244, 11853.585124520687, 11868.228565143238, 11933.806619337996, 4286.657067434598, 4619.260918253063, 4619.3071039343695, 4702.52974702527, 4711.387519622427, 9523.761905952406, 9527.285453591008, 9527.618895244113, 9528.90471095294, 9529.666461673947, 5274.815381461631, 5279.340082489689, 5287.180487024518, 5289.259503669489, 5294.57643388528, 4283.714885534328, 4475.440569928759, 4573.382593349922, 4582.495925448198, 4957.03337849116, 3704.277665855186, 3741.7754934704003, 3811.085339518551, 3818.7517811342173, 3856.2287542491054, 1164.3654208456412, 1171.5782318365382, 1171.83008463774, 1173.7711146326556, 1186.9881301186876, 920.3419555018061, 923.7182659288846, 943.9433633981846, 945.2201933404968, 971.3055165556661, 5522.392536820947, 5522.447755224526, 5543.833684989457, 5644.6330988485615, 5982.700864956735, 904.371461834019, 944.8960614332418, 948.2129832239225, 948.9478078705738, 960.8991055939166, 3692.280005398975, 3705.444183372516, 3722.1253005543676, 3738.700903927679, 3743.401055831054, 10343.172546196436, 10857.945710271399, 10877.129829613612, 10883.129349652008, 10887.346759194474, 10745.409002504937, 10751.569937202581, 10802.621908233174, 10803.405812680377, 10803.783924321628, 8143.104258531557, 8183.836323273501, 8194.426390152752, 8304.543250121302, 8314.00231972155, 5305.416404195613, 5378.677279363094, 5401.108817045144, 5451.291332126798, 5596.356419011703, 9697.321187516805, 9699.951500242454, 9735.707928761865, 9827.705168844946, 9857.30998830075, 8870.112988701077, 9145.679901203426, 9432.19826314771, 9753.9024609753, 9777.364471309342, 7572.280633339824, 7738.845223095619, 7782.260685234894, 7786.2213778623955, 7800.531968081933, 8473.237408633253, 8482.575871206538, 8521.147885211429, 8526.701565445179, 8537.146285371413, 7220.819479513054, 7360.815979600338, 7382.0, 7393.667284972296, 7490.176080631235, 7217.0, 7292.781216563511, 7374.262573742582, 7459.254074592497, 7500.249975002456, 6842.384185423336, 6852.6231057292325, 6899.89650155238, 6902.24075351721, 6902.516823822284, 4834.105690447279, 4909.631777616764, 4950.257461380677, 4978.128827455109, 4986.102501549756, 4738.431388233434, 4750.429948406213, 4917.016596680606, 4926.8768280793265, 5041.319421878], "value": 4546.9887613303645, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.44998951771504, 331.5027458811782, 340.9821682278399, 341.67882190740704, 341.9025577710353, 5293.311869456965, 5400.351957765069, 5401.27082843816, 5477.0, 5490.670559766417, 5170.4312525622245, 5310.4424035476295, 5318.244979156879, 5325.520703136717, 5329.786808527654, 4277.208716387463, 4281.48622165339, 4287.614114729674, 4292.59220374064, 4295.63487103595, 4161.771102589357, 4238.0, 4246.957530424703, 4268.103698223361, 4282.5717428257085, 4242.596953289432, 4245.915081698364, 4246.97876510617, 4256.59562341577, 4262.360645903123, 4240.045989652334, 4259.574042595716, 4265.850695225668, 4271.572842715735, 4281.636060934824, 3650.908727281839, 3760.2103558252797, 3761.3041587306434, 3771.830267637963, 3855.4602355670227, 5168.715720635363, 5187.792488300463, 5203.427622961472, 5203.557697595709, 5205.8958820823755, 4777.498362671939, 4817.807287708488, 4843.927341089887, 4857.319975203474, 4865.951340486586, 5364.7317634118135, 5518.558515318765, 5548.250986116904, 5565.443455654443, 5574.163875418679, 4099.057216840143, 4102.2410853992105, 4110.671146308288, 4110.77390743509, 4124.649404800595, 5728.22668939692, 5766.682832444214, 5804.506616937565, 5815.331236907768, 5860.384659610722, 3937.6062393760967, 4075.3886916962692, 4088.8160032798596, 4094.160697057096, 4207.663386929038, 4102.2410853992105, 4107.404426358161, 4145.150244199932, 4149.149424367997, 4164.9583504165175, 4717.315989181549, 4726.503717109723, 4743.976280118577, 4753.47711751714, 4778.354922085474, 5459.426760190123, 5648.011597970339, 5653.519450846724, 5673.77304907799, 5680.14797780328, 1369.630199846036, 1385.768912051596, 1400.5378225185664, 1435.5047508609514, 1445.6772053570865, 969.3117886300664, 991.1129539062499, 998.4708104704519, 1005.3816902604991, 1007.9193664506822, 5260.526552610283, 5266.4996825302305, 5270.868228294324, 5274.947250527523, 5303.893922121536, 5524.0, 5537.068681236367, 5546.557894947343, 5570.637908536013, 5574.442555744393, 5204.323437953118, 5235.554977826851, 5237.397699264633, 5248.396434410015, 5512.586556008316, 2984.820910745362, 2987.223321936312, 2987.462256793798, 2988.550552981802, 2991.551267309921, 5800.651960882361, 5819.679917604572, 5820.253923822921, 5839.532837373, 5843.918875008138, 5443.5100840923715, 5635.887282254332, 5648.858778530487, 5671.51792097668, 5685.431456854281, 5792.219734527451, 5836.9124463133085, 5840.094785308284, 5866.911996319973, 5871.6770577618645, 5331.653442526223, 5598.944010559842, 5615.494605485526, 5680.176374425768, 5730.283714535683, 5492.615516913777, 5493.23094766725, 5508.788066625336, 5523.226748255167, 5528.318765398698, 5799.217105690678, 5813.331466881194, 5814.0, 5841.853953651193, 5879.177454988967, 4004.318186361677, 4104.384342348671, 4109.671226301948, 4120.0, 4122.763171048733, 5496.972515137399, 5549.0, 5566.359868615161, 5605.523530499953, 5624.634398764068, 5375.623706340519, 5502.367227768857, 5563.0, 5581.609287350009, 5630.887382252414, 5440.836774896759, 5526.784107496344, 5537.8061767837935, 5565.499105080562, 5622.437756224344, 5269.71016594091, 5449.855530338673, 5504.834854954358, 5519.172124181245, 5521.613487056028, 5574.358948720949, 5590.636608620589, 5621.718914054362, 5640.548756099584, 5662.377138514842, 5494.972525137348, 5503.559715222693, 5521.503064724194, 5533.667979921218, 5560.555155587463], "value": 4262.54221543576, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.2605896543287, 726.9785950739213, 772.3700798780148, 825.9297959673428, 893.3612467086034, 14497.0, 14999.850001499968, 15047.774283385757, 15065.096094234326, 15161.848381516182, 14399.136051836897, 14977.400903963855, 15187.924060379682, 15731.84268157318, 15755.684886302268, 855.7218903856241, 876.0276093536202, 876.1370050500252, 876.2683159561774, 876.5003947749785, 716.4698123388681, 734.7979305690951, 846.8391005708926, 862.5299211929513, 869.6260607938584, 907.5552979040289, 907.7912080221553, 909.077286554148, 909.2453263791037, 909.8180363927241, 905.3029167540957, 905.732808821396, 905.9728208153766, 906.075802681268, 906.7959709065474, 665.5707068940507, 667.3826710292959, 667.3826710293008, 667.7896462614261, 667.9098321726553, 14155.504557340444, 14258.500952466615, 14306.785398218932, 14308.785368219485, 14885.851141488554, 13793.0, 14414.91888108396, 14524.92737536316, 14564.41742330316, 14757.565001774694, 11412.31526108436, 11616.303021818718, 11664.416779161093, 11829.0, 12148.635540933787, 3806.365391278545, 3814.408766641175, 3837.6929845612563, 3904.531456225243, 3914.9804250978564, 44975.0, 45283.320750188774, 45453.31820022669, 45502.0, 58865.70567147137, 11248.94375528117, 11257.887421125848, 11300.208985370946, 11331.943340283246, 11392.145589080852, 18718.532036698918, 18794.436166915013, 18881.055947202585, 19017.809821901603, 19029.714554281698, 8404.957975210085, 8460.619272132646, 8571.271441927505, 8615.22462978335, 8777.166169213915, 4566.292224705176, 4733.5503127202865, 4757.619390448755, 4776.880577985578, 4879.999600081975, 3522.84147213376, 3636.9818150909605, 3654.561452625702, 3661.2860492203763, 3745.3258413485833, 667.2093569120608, 675.6081472745796, 676.8781619308473, 679.8504329047602, 683.4737252315689, 717.9389751871149, 718.8382613911828, 747.2191559819893, 747.9476436649383, 752.6725874244612, 8796.78008049791, 8951.194392504705, 9212.0, 9450.952745236229, 9549.904500955041, 536.495694047594, 574.3911453858923, 629.4115002472703, 658.4501940879323, 659.6866488417963, 4088.0393107619684, 4253.787310634456, 4276.978615106967, 4283.87148385549, 4343.391925130484, 69413.0, 80277.0, 81544.18455815366, 85491.0, 86033.56983215043, 70125.2987470129, 70966.0, 72064.0, 72684.63657681784, 75036.62481687557, 43396.0, 43921.0, 53683.463165367844, 58577.414225857196, 67089.0, 8507.95746021266, 8538.914610853812, 8897.73306800797, 9263.814723705624, 9266.397684150508, 30264.394712105193, 36303.81848090742, 44868.32697509605, 46487.0, 50083.49916500788, 61850.69074654598, 62820.37179628328, 62986.37013629805, 63607.68196158989, 66361.66819165873, 13519.121257118255, 13833.30833458303, 13850.16898986064, 13872.514461993782, 13923.373448195058, 14473.203973781543, 14784.778228326799, 14814.40742370293, 14819.555413337617, 15660.608484787972, 13431.731365372832, 13928.930355348159, 14360.712785744436, 14464.349104290122, 14499.565013049625, 11967.162298639012, 12332.753344933231, 12535.373231338213, 12538.498460061495, 12964.805527917277, 11757.941210293893, 12212.0, 12297.200681956003, 12527.37363131858, 12686.365681715693, 10878.238523303293, 11240.381779002233, 11371.715707107389, 11484.598039068593, 11590.652280431601, 11122.555097796321, 11366.431678416211, 11405.600803972153, 11576.66868310155, 11607.941960290145], "value": 7121.020635542495, "unit": "score"}], "name": "dromaeo_css", "value": 7289.063532548803, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 114.0, 113.0, 111.0, 111.0, 111.0, 111.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 117.0, 156.0, 141.0, 120.0, 122.0, 117.0, 148.0, 118.0], "value": 130.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 159.0, 161.0, 160.0, 160.0, 161.0, 161.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 111.0, 76.0, 75.0, 76.0, 76.0, 100.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 126.0, 82.0, 82.0, 82.0, 106.0, 82.0, 83.0, 115.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 54.0, 51.0, 53.0, 51.0, 52.0, 52.0, 52.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 58.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 75.0, 74.0, 74.0, 75.0, 75.0, 77.0, 75.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 123.0, 137.0, 130.0, 131.0, 121.0, 129.0, 130.0, 161.0, 123.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 158.0, 157.0, 155.0, 155.0, 158.0, 156.0, 156.0, 156.0, 154.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 65.0, 62.0, 69.0, 64.0, 62.0, 63.0, 63.0, 62.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1459.0, "alertThreshold": 2.0}]} 12:26:08 INFO - Return code: 0 12:26:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:26:08 INFO - # TBPL SUCCESS # 12:26:08 INFO - Running post-action listener: _resource_record_post_action 12:26:08 INFO - [mozharness: 2017-02-22 20:26:08.208050Z] Finished run-tests step (success) 12:26:08 INFO - Running post-run listener: _resource_record_post_run 12:26:08 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 320929792; Read time: 0; Write time: 242580 12:26:08 INFO - TinderboxPrint: CPU usage
13.0% 12:26:08 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:26:08 INFO - TinderboxPrint: I/O write bytes / time
320,929,792 / 242,580 12:26:08 INFO - TinderboxPrint: CPU idle
8,258.0 (87.0%) 12:26:08 INFO - TinderboxPrint: CPU user
1,190.5 (12.5%) 12:26:08 INFO - TinderboxPrint: Swap in / out
0 / 0 12:26:08 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101302272; Read time: 0; Write time: 80496 12:26:08 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 219627520; Read time: 0; Write time: 162084 12:26:08 INFO - Running post-run listener: _upload_blobber_files 12:26:08 INFO - Blob upload gear active. 12:26:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:26:08 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 12:26:08 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'] 12:26:08 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 12:26:09 INFO - (blobuploader) - INFO - Open directory for files ... 12:26:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:26:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:26:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:26:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:26:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:26:09 INFO - (blobuploader) - INFO - Done attempting. 12:26:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:26:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:26:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:26:12 INFO - (blobuploader) - INFO - Done attempting. 12:26:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:26:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:26:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:26:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:26:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:26:13 INFO - (blobuploader) - INFO - Done attempting. 12:26:13 INFO - (blobuploader) - INFO - Iteration through files over. 12:26:13 INFO - Return code: 0 12:26:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:26:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:26:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/61e5a5ab54ba0ea6f17d607985d74d0b14b52891996441256263f2cb25a9120fabbce5e8fb6c32773510201279c3b818da01bac70c222e0bda10c503b301b5d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6c542d8d9b218afdbf153c7d5bb4a9dc93e8d2b28853a3467791f5ff924ea69128af1800f83001a4d0395d6c68d4b7ad241e37c45fe994328228a464ece6f01c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62b08bee7280bcf1741fc9b60718c1024dff2c7143f0d4a34f91bd8cb085e8ec0aeee786d52966b4191ec272774e01d2d8d5e869e65cc25810b4846dc8fc4ddc"} 12:26:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:26:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:26:13 INFO - Contents: 12:26:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/61e5a5ab54ba0ea6f17d607985d74d0b14b52891996441256263f2cb25a9120fabbce5e8fb6c32773510201279c3b818da01bac70c222e0bda10c503b301b5d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6c542d8d9b218afdbf153c7d5bb4a9dc93e8d2b28853a3467791f5ff924ea69128af1800f83001a4d0395d6c68d4b7ad241e37c45fe994328228a464ece6f01c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62b08bee7280bcf1741fc9b60718c1024dff2c7143f0d4a34f91bd8cb085e8ec0aeee786d52966b4191ec272774e01d2d8d5e869e65cc25810b4846dc8fc4ddc"} 12:26:13 INFO - Running post-run listener: copy_logs_to_upload_dir 12:26:13 INFO - Copying logs to upload dir... 12:26:13 INFO - mkdir: /builds/slave/test/build/upload/logs 12:26:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.367444 ========= master_lag: -0.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-22 12:26:12.518871) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 12:26:12.522311) ========= 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=1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/61e5a5ab54ba0ea6f17d607985d74d0b14b52891996441256263f2cb25a9120fabbce5e8fb6c32773510201279c3b818da01bac70c222e0bda10c503b301b5d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6c542d8d9b218afdbf153c7d5bb4a9dc93e8d2b28853a3467791f5ff924ea69128af1800f83001a4d0395d6c68d4b7ad241e37c45fe994328228a464ece6f01c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62b08bee7280bcf1741fc9b60718c1024dff2c7143f0d4a34f91bd8cb085e8ec0aeee786d52966b4191ec272774e01d2d8d5e869e65cc25810b4846dc8fc4ddc"} build_url:https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011405 build_url: 'https://queue.taskcluster.net/v1/task/AqEmg9AjQLuiySKFlGmmpQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/61e5a5ab54ba0ea6f17d607985d74d0b14b52891996441256263f2cb25a9120fabbce5e8fb6c32773510201279c3b818da01bac70c222e0bda10c503b301b5d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6c542d8d9b218afdbf153c7d5bb4a9dc93e8d2b28853a3467791f5ff924ea69128af1800f83001a4d0395d6c68d4b7ad241e37c45fe994328228a464ece6f01c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62b08bee7280bcf1741fc9b60718c1024dff2c7143f0d4a34f91bd8cb085e8ec0aeee786d52966b4191ec272774e01d2d8d5e869e65cc25810b4846dc8fc4ddc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 12:26:12.546645) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 12:26:12.546970) ========= 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=1258088b6da462a47ba2cd90000001a2-1487793940.159615-1120556695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 12:26:12.631774) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 12:26:12.632088) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 12:26:12.632374) ========= ========= Total master_lag: -0.13 =========