builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1479961151.92 results: success (0) buildid: 20161123185735 builduid: ae46e924bc1a45a09a439eebf476adca revision: 50f234c53a7a97548a655efd992d04c2792a1954 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 20:19:11.918168) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 20:19:11.918627) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 20:19:11.918905) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 20:19:11.933833) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 20:19:11.934181) ========= 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=0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-23 20:19:11-- 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% 209M=0s 2016-11-23 20:19:12 (209 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087766 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 20:19:12.036045) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 20:19:12.036376) ========= 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=0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016692 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 20:19:12.086111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 20:19:12.086451) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 50f234c53a7a97548a655efd992d04c2792a1954 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 50f234c53a7a97548a655efd992d04c2792a1954 --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=0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-23 20:19:12,189 truncating revision to first 12 chars 2016-11-23 20:19:12,189 Setting DEBUG logging. 2016-11-23 20:19:12,189 attempt 1/10 2016-11-23 20:19:12,189 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/50f234c53a7a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 20:19:12,530 unpacking tar archive at: graphics-50f234c53a7a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646969 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 20:19:12.746490) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 20:19:12.746786) ========= script_repo_revision: 50f234c53a7a97548a655efd992d04c2792a1954 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 20:19:12.747489) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 20:19:12.747759) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 20:19:12.759023) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-11-23 20:19:12.759389) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:19:12 INFO - MultiFileLogger online at 20161123 20:19:12 in /builds/slave/test 20:19:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 20:19:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:19:12 INFO - {'append_to_log': False, 20:19:12 INFO - 'base_work_dir': '/builds/slave/test', 20:19:12 INFO - 'blob_upload_branch': 'Graphics', 20:19:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:19:12 INFO - 'branch': 'Graphics', 20:19:12 INFO - 'buildbot_json_path': 'buildprops.json', 20:19:12 INFO - 'config_files': ('talos/linux_config.py',), 20:19:12 INFO - 'default_actions': ('clobber', 20:19:12 INFO - 'read-buildbot-config', 20:19:12 INFO - 'download-and-extract', 20:19:12 INFO - 'populate-webroot', 20:19:12 INFO - 'create-virtualenv', 20:19:12 INFO - 'install', 20:19:12 INFO - 'run-tests'), 20:19:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:19:12 INFO - 'download_minidump_stackwalk': True, 20:19:12 INFO - 'download_symbols': 'ondemand', 20:19:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:19:12 INFO - 'tooltool.py': '/tools/tooltool.py', 20:19:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:19:12 INFO - '/tools/misc-python/virtualenv.py')}, 20:19:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:19:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:19:12 INFO - 'installer_path': 'installer.exe', 20:19:12 INFO - 'log_level': 'info', 20:19:12 INFO - 'log_name': 'talos', 20:19:12 INFO - 'log_to_console': True, 20:19:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:19:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:19:12 INFO - 'opt_config_files': (), 20:19:12 INFO - 'pip_index': False, 20:19:12 INFO - 'sps_profile': False, 20:19:12 INFO - 'sps_profile_interval': 0, 20:19:12 INFO - 'suite': 'dromaeojs', 20:19:12 INFO - 'system_bits': '32', 20:19:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:19:12 INFO - 'title': 'talos-linux64-ix-058', 20:19:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:19:12 INFO - 'use_talos_json': True, 20:19:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:19:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:19:12 INFO - 'work_dir': 'build'} 20:19:12 INFO - [mozharness: 2016-11-24 04:19:12.968795Z] Running clobber step. 20:19:12 INFO - Running pre-action listener: _resource_record_pre_action 20:19:12 INFO - Running main action method: clobber 20:19:12 INFO - rmtree: /builds/slave/test/build 20:19:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:19:13 INFO - Running post-action listener: _resource_record_post_action 20:19:13 INFO - [mozharness: 2016-11-24 04:19:13.431743Z] Finished clobber step (success) 20:19:13 INFO - [mozharness: 2016-11-24 04:19:13.432141Z] Running read-buildbot-config step. 20:19:13 INFO - Running pre-action listener: _resource_record_pre_action 20:19:13 INFO - Running main action method: read_buildbot_config 20:19:13 INFO - Using buildbot properties: 20:19:13 INFO - { 20:19:13 INFO - "project": "", 20:19:13 INFO - "product": "firefox", 20:19:13 INFO - "script_repo_revision": "default", 20:19:13 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 20:19:13 INFO - "repository": "", 20:19:13 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 20:19:13 INFO - "buildid": "20161123185735", 20:19:13 INFO - "pgo_build": "False", 20:19:13 INFO - "basedir": "/builds/slave/test", 20:19:13 INFO - "buildnumber": 10, 20:19:13 INFO - "slavename": "talos-linux64-ix-058", 20:19:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:19:13 INFO - "platform": "ubuntu64_hw", 20:19:13 INFO - "scheduler": "tests-graphics-linux64-talos", 20:19:13 INFO - "branch": "graphics", 20:19:13 INFO - "repo_path": "projects/graphics", 20:19:13 INFO - "revision": "50f234c53a7a97548a655efd992d04c2792a1954", 20:19:13 INFO - "stage_platform": "linux64", 20:19:13 INFO - "builduid": "ae46e924bc1a45a09a439eebf476adca", 20:19:13 INFO - "slavebuilddir": "test" 20:19:13 INFO - } 20:19:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 20:19:13 INFO - Running post-action listener: _resource_record_post_action 20:19:13 INFO - [mozharness: 2016-11-24 04:19:13.434558Z] Finished read-buildbot-config step (success) 20:19:13 INFO - [mozharness: 2016-11-24 04:19:13.434646Z] Running download-and-extract step. 20:19:13 INFO - Running pre-action listener: _resource_record_pre_action 20:19:13 INFO - Running main action method: download_and_extract 20:19:13 INFO - mkdir: /builds/slave/test/build/tests 20:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:13 INFO - trying https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:19:13 INFO - Downloading https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:19:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:19:14 INFO - Downloaded 1361 bytes. 20:19:14 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:19:14 INFO - Using the following test package requirements: 20:19:14 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:19:14 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:19:14 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:19:14 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:14 INFO - u'jsshell-linux-x86_64.zip'], 20:19:14 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:19:14 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:19:14 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:19:14 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:19:14 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:19:14 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:19:14 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:19:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:19:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:19:14 INFO - Fetch https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:19:14 INFO - Http code: 200 20:19:14 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 20:19:14 INFO - x-amz-cf-id: rSlFDCm7k1XAOtpxBlaaOGDLG_CN1HePF2Oo7MM2NOEIpv4_BkLqyw== 20:19:14 INFO - x-amz-version-id: CujJGn8lAIMGd9WAwfwCv914KK7vEDC4 20:19:15 INFO - Expected file size: 20202013 20:19:15 INFO - Obtained file size: 20202013 20:19:19 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:19:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:19:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:19:19 INFO - Fetch https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:19:20 INFO - Http code: 200 20:19:20 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 20:19:20 INFO - x-amz-cf-id: zZQWKZy73B4_nT4ZkOVVmgkkL_zMMpkWid9bx_gglk217zdMaCQqcA== 20:19:20 INFO - x-amz-version-id: CujJGn8lAIMGd9WAwfwCv914KK7vEDC4 20:19:20 INFO - Expected file size: 20202013 20:19:20 INFO - Obtained file size: 20202013 20:19:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 20:19:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:19:25 INFO - Fetch https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:19:25 INFO - Http code: 200 20:19:25 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 20:19:25 INFO - x-amz-cf-id: tpAQNLkwxXw2_oyf139VIJSVie4c7pAN3zhcjv-AjSxAfBL07Foq9g== 20:19:25 INFO - x-amz-version-id: ga7NhnE5yH3h9.cEtgADUB.j06UJjmwj 20:19:26 INFO - Expected file size: 14409506 20:19:26 INFO - Obtained file size: 14409506 20:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:26 INFO - trying https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:19:26 INFO - Downloading https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:19:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:19:29 INFO - Downloaded 55602536 bytes. 20:19:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:19:29 INFO - mkdir: /builds/slave/test/properties 20:19:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:19:29 INFO - Writing to file /builds/slave/test/properties/build_url 20:19:29 INFO - Contents: 20:19:29 INFO - build_url:https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:19:29 INFO - Running post-action listener: _resource_record_post_action 20:19:29 INFO - Running post-action listener: set_extra_try_arguments 20:19:29 INFO - [mozharness: 2016-11-24 04:19:29.907867Z] Finished download-and-extract step (success) 20:19:29 INFO - [mozharness: 2016-11-24 04:19:29.908095Z] Running populate-webroot step. 20:19:29 INFO - Running pre-action listener: _resource_record_pre_action 20:19:29 INFO - Running main action method: populate_webroot 20:19:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:19:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:19:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:19:29 INFO - '--tppagecycles', 20:19:29 INFO - '7'], 20:19:29 INFO - 'tests': ['tsvgm']}}, 20:19:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:19:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:19:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:19:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:19:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:19:29 INFO - 'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:19:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:19:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:19:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:19:29 INFO - 'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['damp', 'tps']}, 20:19:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:19:29 INFO - 'tests': ['damp', 'tps']}, 20:19:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['dromaeo_dom']}, 20:19:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:19:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['basic_compositor_video']}, 20:19:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:19:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['a11yr', 20:19:29 INFO - 'ts_paint', 20:19:29 INFO - 'tpaint', 20:19:29 INFO - 'sessionrestore', 20:19:29 INFO - 'sessionrestore_no_auto_restore', 20:19:29 INFO - 'tabpaint']}, 20:19:29 INFO - 'other-e10s': {'tests': ['a11yr', 20:19:29 INFO - 'ts_paint', 20:19:29 INFO - 'tpaint', 20:19:29 INFO - 'sessionrestore', 20:19:29 INFO - 'sessionrestore_no_auto_restore', 20:19:29 INFO - 'tabpaint']}, 20:19:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:19:29 INFO - 'ts_paint', 20:19:29 INFO - 'tpaint', 20:19:29 INFO - 'sessionrestore', 20:19:29 INFO - 'sessionrestore_no_auto_restore', 20:19:29 INFO - 'tabpaint']}, 20:19:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:19:29 INFO - 'ts_paint', 20:19:29 INFO - 'tpaint', 20:19:29 INFO - 'sessionrestore', 20:19:29 INFO - 'sessionrestore_no_auto_restore', 20:19:29 INFO - 'tabpaint']}, 20:19:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['a11yr', 20:19:29 INFO - 'ts_paint', 20:19:29 INFO - 'tpaint', 20:19:29 INFO - 'sessionrestore', 20:19:29 INFO - 'sessionrestore_no_auto_restore', 20:19:29 INFO - 'tabpaint']}, 20:19:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['a11yr', 20:19:29 INFO - 'ts_paint', 20:19:29 INFO - 'tpaint', 20:19:29 INFO - 'sessionrestore', 20:19:29 INFO - 'sessionrestore_no_auto_restore', 20:19:29 INFO - 'tabpaint']}, 20:19:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['tsvgx', 20:19:29 INFO - 'tsvgr_opacity', 20:19:29 INFO - 'tart', 20:19:29 INFO - 'tscrollx', 20:19:29 INFO - 'cart']}, 20:19:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:19:29 INFO - 'tsvgr_opacity', 20:19:29 INFO - 'tart', 20:19:29 INFO - 'tscrollx', 20:19:29 INFO - 'cart']}, 20:19:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:19:29 INFO - 'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['tp5o']}, 20:19:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:19:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:19:29 INFO - 'talos_options': ['--disable-e10s', 20:19:29 INFO - '--xperf_path', 20:19:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:19:29 INFO - 'tests': ['tp5n']}, 20:19:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:19:29 INFO - 'talos_options': ['--xperf_path', 20:19:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:19:29 INFO - 'tests': ['tp5n']}}, 20:19:29 INFO - 'talos.zip': {'path': '', 20:19:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:19:29 INFO - Running post-action listener: _resource_record_post_action 20:19:29 INFO - [mozharness: 2016-11-24 04:19:29.923312Z] Finished populate-webroot step (success) 20:19:29 INFO - [mozharness: 2016-11-24 04:19:29.923399Z] Running create-virtualenv step. 20:19:29 INFO - Running pre-action listener: _resource_record_pre_action 20:19:29 INFO - Running main action method: create_virtualenv 20:19:29 INFO - Creating virtualenv /builds/slave/test/build/venv 20:19:29 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 20:19:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:19:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:19:30 INFO - Using real prefix '/usr' 20:19:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:19:30 INFO - Installing distribute.............................................................................................................................................................................................done. 20:19:32 INFO - Installing pip.................done. 20:19:32 INFO - Return code: 0 20:19:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:19:32 INFO - Reading from file tmpfile_stdout 20:19:32 INFO - Output received: 20:19:32 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) 20:19:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:19: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')]} 20:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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')]} 20:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:32 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 0x7f812eb36e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4efc0>, '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 0x1d4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50350>, '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': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', '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 20:19:32 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 20:19:32 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 20:19:32 INFO - Using env: {'DISPLAY': ':0', 20:19:32 INFO - 'HOME': '/home/cltbld', 20:19:32 INFO - 'LANG': 'en_US.UTF-8', 20:19:32 INFO - 'LANGUAGE': 'en_US:en', 20:19:32 INFO - 'LOGNAME': 'cltbld', 20:19:32 INFO - 'MAIL': '/var/mail/cltbld', 20:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:32 INFO - 'MOZ_NO_REMOTE': '1', 20:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:32 INFO - 'NO_EM_RESTART': '1', 20:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:32 INFO - 'PWD': '/builds/slave/test', 20:19:32 INFO - 'SHELL': '/bin/bash', 20:19:32 INFO - 'SHLVL': '1', 20:19:32 INFO - 'TERM': 'linux', 20:19:32 INFO - 'TMOUT': '86400', 20:19:32 INFO - 'USER': 'cltbld', 20:19:32 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', 20:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:32 INFO - '_': '/tools/buildbot/bin/python'} 20:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:32 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 20:19:32 INFO - Cleaning up... 20:19:32 INFO - Return code: 0 20:19:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:19: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')]} 20:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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')]} 20:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:32 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 0x7f812eb36e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4efc0>, '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 0x1d4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50350>, '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': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', '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 20:19:32 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 20:19:32 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 20:19:32 INFO - Using env: {'DISPLAY': ':0', 20:19:32 INFO - 'HOME': '/home/cltbld', 20:19:32 INFO - 'LANG': 'en_US.UTF-8', 20:19:32 INFO - 'LANGUAGE': 'en_US:en', 20:19:32 INFO - 'LOGNAME': 'cltbld', 20:19:32 INFO - 'MAIL': '/var/mail/cltbld', 20:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:32 INFO - 'MOZ_NO_REMOTE': '1', 20:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:32 INFO - 'NO_EM_RESTART': '1', 20:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:32 INFO - 'PWD': '/builds/slave/test', 20:19:32 INFO - 'SHELL': '/bin/bash', 20:19:32 INFO - 'SHLVL': '1', 20:19:32 INFO - 'TERM': 'linux', 20:19:32 INFO - 'TMOUT': '86400', 20:19:32 INFO - 'USER': 'cltbld', 20:19:32 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', 20:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:32 INFO - '_': '/tools/buildbot/bin/python'} 20:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:33 INFO - Downloading/unpacking psutil>=3.1.1 20:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:19:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:19:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:19:35 INFO - Installing collected packages: psutil 20:19:35 INFO - Running setup.py install for psutil 20:19:35 INFO - building 'psutil._psutil_linux' extension 20:19:35 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 20:19:35 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 20:19:35 INFO - building 'psutil._psutil_posix' extension 20:19:35 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 20:19:35 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 20:19:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:19:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:19:35 INFO - Successfully installed psutil 20:19:35 INFO - Cleaning up... 20:19:35 INFO - Return code: 0 20:19:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:35 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 0x7f812eb36e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4efc0>, '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 0x1d4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50350>, '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': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', '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 20:19:35 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 20:19:35 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 20:19:35 INFO - Using env: {'DISPLAY': ':0', 20:19:35 INFO - 'HOME': '/home/cltbld', 20:19:35 INFO - 'LANG': 'en_US.UTF-8', 20:19:35 INFO - 'LANGUAGE': 'en_US:en', 20:19:35 INFO - 'LOGNAME': 'cltbld', 20:19:35 INFO - 'MAIL': '/var/mail/cltbld', 20:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:35 INFO - 'MOZ_NO_REMOTE': '1', 20:19:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:35 INFO - 'NO_EM_RESTART': '1', 20:19:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:35 INFO - 'PWD': '/builds/slave/test', 20:19:35 INFO - 'SHELL': '/bin/bash', 20:19:35 INFO - 'SHLVL': '1', 20:19:35 INFO - 'TERM': 'linux', 20:19:35 INFO - 'TMOUT': '86400', 20:19:35 INFO - 'USER': 'cltbld', 20:19:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', 20:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:35 INFO - '_': '/tools/buildbot/bin/python'} 20:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:19:35 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 20:19:35 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 20:19:35 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 20:19:35 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 20:19:35 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 20:19:35 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 20:19:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:19:37 INFO - Installing collected packages: mozsystemmonitor 20:19:37 INFO - Running setup.py install for mozsystemmonitor 20:19:38 INFO - Successfully installed mozsystemmonitor 20:19:38 INFO - Cleaning up... 20:19:38 INFO - Return code: 0 20:19:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:19:38 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')]} 20:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:38 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')]} 20:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:38 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 0x7f812eb36e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4efc0>, '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 0x1d4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50350>, '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': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', '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 20:19:38 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 20:19:38 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 20:19:38 INFO - Using env: {'DISPLAY': ':0', 20:19:38 INFO - 'HOME': '/home/cltbld', 20:19:38 INFO - 'LANG': 'en_US.UTF-8', 20:19:38 INFO - 'LANGUAGE': 'en_US:en', 20:19:38 INFO - 'LOGNAME': 'cltbld', 20:19:38 INFO - 'MAIL': '/var/mail/cltbld', 20:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:38 INFO - 'MOZ_NO_REMOTE': '1', 20:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:38 INFO - 'NO_EM_RESTART': '1', 20:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:38 INFO - 'PWD': '/builds/slave/test', 20:19:38 INFO - 'SHELL': '/bin/bash', 20:19:38 INFO - 'SHLVL': '1', 20:19:38 INFO - 'TERM': 'linux', 20:19:38 INFO - 'TMOUT': '86400', 20:19:38 INFO - 'USER': 'cltbld', 20:19:38 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', 20:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:38 INFO - '_': '/tools/buildbot/bin/python'} 20:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:38 INFO - Downloading/unpacking jsonschema==2.5.1 20:19:38 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 20:19:38 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 20:19:38 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 20:19:38 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 20:19:38 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 20:19:38 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 20:19:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:19:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:19:40 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 20:19:40 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 20:19:40 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 20:19:40 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 20:19:40 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 20:19:40 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 20:19:40 INFO - Downloading functools32-3.2.3-2.tar.gz 20:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:19:40 INFO - warning: no files found matching '*.txt' 20:19:40 INFO - no previously-included directories found matching 'build' 20:19:40 INFO - no previously-included directories found matching 'dist' 20:19:40 INFO - no previously-included directories found matching '.git*' 20:19:40 INFO - Installing collected packages: jsonschema, functools32 20:19:40 INFO - Running setup.py install for functools32 20:19:40 INFO - warning: no files found matching '*.txt' 20:19:40 INFO - no previously-included directories found matching 'build' 20:19:40 INFO - no previously-included directories found matching 'dist' 20:19:40 INFO - no previously-included directories found matching '.git*' 20:19:40 INFO - Successfully installed jsonschema functools32 20:19:40 INFO - Cleaning up... 20:19:40 INFO - Return code: 0 20:19:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:19:40 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')]} 20:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:40 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')]} 20:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:40 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 0x7f812eb36e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4efc0>, '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 0x1d4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50350>, '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': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', '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 20:19:40 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 20:19:40 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 20:19:40 INFO - Using env: {'DISPLAY': ':0', 20:19:40 INFO - 'HOME': '/home/cltbld', 20:19:40 INFO - 'LANG': 'en_US.UTF-8', 20:19:40 INFO - 'LANGUAGE': 'en_US:en', 20:19:40 INFO - 'LOGNAME': 'cltbld', 20:19:40 INFO - 'MAIL': '/var/mail/cltbld', 20:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:40 INFO - 'MOZ_NO_REMOTE': '1', 20:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:40 INFO - 'NO_EM_RESTART': '1', 20:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:40 INFO - 'PWD': '/builds/slave/test', 20:19:40 INFO - 'SHELL': '/bin/bash', 20:19:40 INFO - 'SHLVL': '1', 20:19:40 INFO - 'TERM': 'linux', 20:19:40 INFO - 'TMOUT': '86400', 20:19:40 INFO - 'USER': 'cltbld', 20:19:40 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', 20:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:40 INFO - '_': '/tools/buildbot/bin/python'} 20:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:19:40 INFO - Cleaning up... 20:19:41 INFO - Return code: 0 20:19:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:19:41 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')]} 20:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:41 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')]} 20:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:41 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 0x7f812eb36e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4efc0>, '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 0x1d4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50350>, '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': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', '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 20:19:41 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 20:19:41 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 20:19:41 INFO - Using env: {'DISPLAY': ':0', 20:19:41 INFO - 'HOME': '/home/cltbld', 20:19:41 INFO - 'LANG': 'en_US.UTF-8', 20:19:41 INFO - 'LANGUAGE': 'en_US:en', 20:19:41 INFO - 'LOGNAME': 'cltbld', 20:19:41 INFO - 'MAIL': '/var/mail/cltbld', 20:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:41 INFO - 'MOZ_NO_REMOTE': '1', 20:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:41 INFO - 'NO_EM_RESTART': '1', 20:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:41 INFO - 'PWD': '/builds/slave/test', 20:19:41 INFO - 'SHELL': '/bin/bash', 20:19:41 INFO - 'SHLVL': '1', 20:19:41 INFO - 'TERM': 'linux', 20:19:41 INFO - 'TMOUT': '86400', 20:19:41 INFO - 'USER': 'cltbld', 20:19:41 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', 20:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:41 INFO - '_': '/tools/buildbot/bin/python'} 20:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:41 INFO - Downloading/unpacking blobuploader==1.2.4 20:19:41 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 20:19:41 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 20:19:41 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 20:19:41 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 20:19:41 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 20:19:41 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 20:19:43 INFO - Downloading blobuploader-1.2.4.tar.gz 20:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:19:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:19:43 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 20:19:43 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 20:19:43 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 20:19:43 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 20:19:43 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 20:19:43 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 20:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:19:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:19:43 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 20:19:43 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 20:19:43 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 20:19:43 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 20:19:43 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 20:19:43 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 20:19:43 INFO - Downloading docopt-0.6.1.tar.gz 20:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:19:44 INFO - Installing collected packages: blobuploader, requests, docopt 20:19:44 INFO - Running setup.py install for blobuploader 20:19:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:19:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:19:44 INFO - Running setup.py install for requests 20:19:44 INFO - Running setup.py install for docopt 20:19:44 INFO - Successfully installed blobuploader requests docopt 20:19:44 INFO - Cleaning up... 20:19:44 INFO - Return code: 0 20:19:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19:44 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')]} 20:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:44 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')]} 20:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:44 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 0x7f812eb36e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4efc0>, '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 0x1d4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50350>, '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': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', '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 20:19:44 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 20:19:44 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 20:19:44 INFO - Using env: {'DISPLAY': ':0', 20:19:44 INFO - 'HOME': '/home/cltbld', 20:19:44 INFO - 'LANG': 'en_US.UTF-8', 20:19:44 INFO - 'LANGUAGE': 'en_US:en', 20:19:44 INFO - 'LOGNAME': 'cltbld', 20:19:44 INFO - 'MAIL': '/var/mail/cltbld', 20:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:44 INFO - 'MOZ_NO_REMOTE': '1', 20:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:44 INFO - 'NO_EM_RESTART': '1', 20:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:44 INFO - 'PWD': '/builds/slave/test', 20:19:44 INFO - 'SHELL': '/bin/bash', 20:19:44 INFO - 'SHLVL': '1', 20:19:44 INFO - 'TERM': 'linux', 20:19:44 INFO - 'TMOUT': '86400', 20:19:44 INFO - 'USER': 'cltbld', 20:19:44 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', 20:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:44 INFO - '_': '/tools/buildbot/bin/python'} 20:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:19:44 INFO - Running setup.py (path:/tmp/pip-Wj_u5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:19:44 INFO - Running setup.py (path:/tmp/pip-wNkIXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:19:44 INFO - Running setup.py (path:/tmp/pip-WQtEq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:19:45 INFO - Running setup.py (path:/tmp/pip-8bJ5NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:19:45 INFO - Running setup.py (path:/tmp/pip-mhBypP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:19:45 INFO - Running setup.py (path:/tmp/pip-ekoRBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:19:45 INFO - Running setup.py (path:/tmp/pip-XqQRv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:19:45 INFO - Running setup.py (path:/tmp/pip-jdrjFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:19:45 INFO - Running setup.py (path:/tmp/pip-wnRRfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:19:45 INFO - Running setup.py (path:/tmp/pip-SiCXfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:19:45 INFO - Running setup.py (path:/tmp/pip-ddyJ3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:19:45 INFO - Running setup.py (path:/tmp/pip-6NGk89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:19:45 INFO - Running setup.py (path:/tmp/pip-AuRk7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:19:45 INFO - Running setup.py (path:/tmp/pip-jg1HFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:45 INFO - Running setup.py (path:/tmp/pip-LDqRUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:19:45 INFO - Running setup.py (path:/tmp/pip-jqEfYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:19:45 INFO - Running setup.py (path:/tmp/pip-E_8wr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:19:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:19:46 INFO - Running setup.py install for manifestparser 20:19:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:19:46 INFO - Running setup.py install for mozcrash 20:19:46 INFO - Running setup.py install for mozdebug 20:19:46 INFO - Running setup.py install for mozdevice 20:19:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:19:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:19:46 INFO - Running setup.py install for mozfile 20:19:46 INFO - Running setup.py install for mozhttpd 20:19:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:19:46 INFO - Running setup.py install for mozinfo 20:19:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:19:46 INFO - Running setup.py install for mozInstall 20:19:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:19:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:19:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:19:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:19:46 INFO - Running setup.py install for mozleak 20:19:46 INFO - Running setup.py install for mozlog 20:19:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:19:47 INFO - Running setup.py install for moznetwork 20:19:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:19:47 INFO - Running setup.py install for mozprocess 20:19:47 INFO - Running setup.py install for mozprofile 20:19:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:19:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:19:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:19:47 INFO - Running setup.py install for mozrunner 20:19:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:19:47 INFO - Running setup.py install for mozscreenshot 20:19:47 INFO - Running setup.py install for moztest 20:19:47 INFO - Running setup.py install for mozversion 20:19:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:19:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:19:47 INFO - Cleaning up... 20:19:47 INFO - Return code: 0 20:19:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19:47 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')]} 20:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:47 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')]} 20:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:47 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 0x7f812eb36e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4efc0>, '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 0x1d4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50350>, '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': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', '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 20:19:47 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 20:19:47 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 20:19:47 INFO - Using env: {'DISPLAY': ':0', 20:19:47 INFO - 'HOME': '/home/cltbld', 20:19:47 INFO - 'LANG': 'en_US.UTF-8', 20:19:47 INFO - 'LANGUAGE': 'en_US:en', 20:19:47 INFO - 'LOGNAME': 'cltbld', 20:19:47 INFO - 'MAIL': '/var/mail/cltbld', 20:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:47 INFO - 'MOZ_NO_REMOTE': '1', 20:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:47 INFO - 'NO_EM_RESTART': '1', 20:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:47 INFO - 'PWD': '/builds/slave/test', 20:19:47 INFO - 'SHELL': '/bin/bash', 20:19:47 INFO - 'SHLVL': '1', 20:19:47 INFO - 'TERM': 'linux', 20:19:47 INFO - 'TMOUT': '86400', 20:19:47 INFO - 'USER': 'cltbld', 20:19:47 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', 20:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:47 INFO - '_': '/tools/buildbot/bin/python'} 20:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:19:48 INFO - Running setup.py (path:/tmp/pip-q2u8du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:19:48 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)) 20:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:19:48 INFO - Running setup.py (path:/tmp/pip-s252WN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:19:48 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)) 20:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:19:48 INFO - Running setup.py (path:/tmp/pip-ZrlGg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:19:48 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)) 20:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:19:48 INFO - Running setup.py (path:/tmp/pip-PvyYHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:19:48 INFO - Running setup.py (path:/tmp/pip-fNA7zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:19:48 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)) 20:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:19:48 INFO - Running setup.py (path:/tmp/pip-t67xC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:19:48 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)) 20:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:19:48 INFO - Running setup.py (path:/tmp/pip-Fj129Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:19:48 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)) 20:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:19:48 INFO - Running setup.py (path:/tmp/pip-caZMIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:19:48 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)) 20:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:19:48 INFO - Running setup.py (path:/tmp/pip-kg_BKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:19:48 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)) 20:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:19:48 INFO - Running setup.py (path:/tmp/pip-7pY6GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:19:48 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)) 20:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:19:48 INFO - Running setup.py (path:/tmp/pip-hZhz0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:19:48 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)) 20:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:19:48 INFO - Running setup.py (path:/tmp/pip-6mjyJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:19:48 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)) 20:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:19:48 INFO - Running setup.py (path:/tmp/pip-rLqucu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:19:49 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)) 20:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:19:49 INFO - Running setup.py (path:/tmp/pip-GBzP9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:19:49 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)) 20:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:49 INFO - Running setup.py (path:/tmp/pip-OrQudj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:49 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)) 20:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:19:49 INFO - Running setup.py (path:/tmp/pip-2DrYGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:19:49 INFO - Running setup.py (path:/tmp/pip-yn2mut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:19:49 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)) 20:19:49 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)) 20:19:49 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)) 20:19:49 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)) 20:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:19:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:19:49 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 20:19:49 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 20:19:49 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 20:19:49 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 20:19:49 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 20:19:49 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 20:19:51 INFO - Downloading blessings-1.6.tar.gz 20:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:19:51 INFO - Installing collected packages: blessings 20:19:51 INFO - Running setup.py install for blessings 20:19:51 INFO - Successfully installed blessings 20:19:51 INFO - Cleaning up... 20:19:51 INFO - Return code: 0 20:19:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:19:51 INFO - Reading from file tmpfile_stdout 20:19:51 INFO - Current package versions: 20:19:51 INFO - argparse == 1.2.1 20:19:51 INFO - blessings == 1.6 20:19:51 INFO - blobuploader == 1.2.4 20:19:51 INFO - docopt == 0.6.1 20:19:51 INFO - functools32 == 3.2.3-2 20:19:51 INFO - jsonschema == 2.5.1 20:19:51 INFO - manifestparser == 1.1 20:19:51 INFO - mozInstall == 1.12 20:19:51 INFO - mozcrash == 1.0 20:19:51 INFO - mozdebug == 0.1 20:19:51 INFO - mozdevice == 0.49 20:19:51 INFO - mozfile == 1.2 20:19:51 INFO - mozhttpd == 0.7 20:19:51 INFO - mozinfo == 0.9 20:19:51 INFO - mozleak == 0.1 20:19:51 INFO - mozlog == 3.4 20:19:51 INFO - moznetwork == 0.27 20:19:51 INFO - mozprocess == 0.23 20:19:51 INFO - mozprofile == 0.28 20:19:51 INFO - mozrunner == 6.13 20:19:51 INFO - mozscreenshot == 0.1 20:19:51 INFO - mozsystemmonitor == 0.3 20:19:51 INFO - moztest == 0.7 20:19:51 INFO - mozversion == 1.4 20:19:51 INFO - psutil == 3.1.1 20:19:51 INFO - requests == 1.2.3 20:19:51 INFO - wsgiref == 0.1.2 20:19:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:51 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 0x7f812eb36e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4efc0>, '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 0x1d4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50350>, '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': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', '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 20:19:51 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 20:19:51 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 20:19:51 INFO - Using env: {'DISPLAY': ':0', 20:19:51 INFO - 'HOME': '/home/cltbld', 20:19:51 INFO - 'LANG': 'en_US.UTF-8', 20:19:51 INFO - 'LANGUAGE': 'en_US:en', 20:19:51 INFO - 'LOGNAME': 'cltbld', 20:19:51 INFO - 'MAIL': '/var/mail/cltbld', 20:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:51 INFO - 'MOZ_NO_REMOTE': '1', 20:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:51 INFO - 'NO_EM_RESTART': '1', 20:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:51 INFO - 'PWD': '/builds/slave/test', 20:19:51 INFO - 'SHELL': '/bin/bash', 20:19:51 INFO - 'SHLVL': '1', 20:19:51 INFO - 'TERM': 'linux', 20:19:51 INFO - 'TMOUT': '86400', 20:19:51 INFO - 'USER': 'cltbld', 20:19:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', 20:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:51 INFO - '_': '/tools/buildbot/bin/python'} 20:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:51 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)) 20:19:51 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)) 20:19:51 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)) 20:19:51 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)) 20:19:51 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)) 20:19:51 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)) 20:19:51 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)) 20:19:51 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)) 20:19:51 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)) 20:19:51 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)) 20:19:51 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)) 20:19:51 INFO - Cleaning up... 20:19:51 INFO - Return code: 0 20:19:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f812eb36e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b24b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4efc0>, '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 0x1d4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50350>, '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': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', '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 20:19:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:19:52 INFO - Using env: {'DISPLAY': ':0', 20:19:52 INFO - 'HOME': '/home/cltbld', 20:19:52 INFO - 'LANG': 'en_US.UTF-8', 20:19:52 INFO - 'LANGUAGE': 'en_US:en', 20:19:52 INFO - 'LOGNAME': 'cltbld', 20:19:52 INFO - 'MAIL': '/var/mail/cltbld', 20:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:52 INFO - 'MOZ_NO_REMOTE': '1', 20:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:52 INFO - 'NO_EM_RESTART': '1', 20:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:52 INFO - 'PWD': '/builds/slave/test', 20:19:52 INFO - 'SHELL': '/bin/bash', 20:19:52 INFO - 'SHLVL': '1', 20:19:52 INFO - 'TERM': 'linux', 20:19:52 INFO - 'TMOUT': '86400', 20:19:52 INFO - 'USER': 'cltbld', 20:19:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', 20:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:52 INFO - '_': '/tools/buildbot/bin/python'} 20:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:19:52 INFO - Cleaning up... 20:19:52 INFO - Return code: 0 20:19:52 INFO - Running post-action listener: _resource_record_post_action 20:19:52 INFO - Running post-action listener: _start_resource_monitoring 20:19:52 INFO - Starting resource monitoring. 20:19:52 INFO - [mozharness: 2016-11-24 04:19:52.258627Z] Finished create-virtualenv step (success) 20:19:52 INFO - [mozharness: 2016-11-24 04:19:52.259221Z] Running install step. 20:19:52 INFO - Running pre-action listener: _resource_record_pre_action 20:19:52 INFO - Running main action method: install 20:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:19:52 INFO - Reading from file tmpfile_stdout 20:19:52 INFO - Detecting whether we're running mozinstall >=1.0... 20:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:19:52 INFO - Reading from file tmpfile_stdout 20:19:52 INFO - Output received: 20:19:52 INFO - Usage: mozinstall [options] installer 20:19:52 INFO - Options: 20:19:52 INFO - -h, --help show this help message and exit 20:19:52 INFO - -d DEST, --destination=DEST 20:19:52 INFO - Directory to install application into. [default: 20:19:52 INFO - "/builds/slave/test"] 20:19:52 INFO - --app=APP Application being installed. [default: firefox] 20:19:52 INFO - mkdir: /builds/slave/test/build/application 20:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:20:08 INFO - Reading from file tmpfile_stdout 20:20:08 INFO - Output received: 20:20:08 INFO - /builds/slave/test/build/application/firefox/firefox 20:20:08 INFO - Running post-action listener: _resource_record_post_action 20:20:08 INFO - [mozharness: 2016-11-24 04:20:08.588282Z] Finished install step (success) 20:20:08 INFO - [mozharness: 2016-11-24 04:20:08.588536Z] Running run-tests step. 20:20:08 INFO - Running pre-action listener: _resource_record_pre_action 20:20:08 INFO - Running main action method: run_tests 20:20:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:20:08 INFO - Python 2.7.3 20:20:08 INFO - Return code: 0 20:20:08 INFO - grabbing minidump binary from tooltool 20:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:08 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 0x1d4efc0>, '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 0x1d4fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:20:08 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 20:20:08 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 20:20:08 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 20:20:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:20:08 INFO - Return code: 0 20:20:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:20:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:20:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:20:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:20:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:20:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 20:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 20:20:08 INFO - Using env: {'DISPLAY': ':0', 20:20:08 INFO - 'HOME': '/home/cltbld', 20:20:08 INFO - 'LANG': 'en_US.UTF-8', 20:20:08 INFO - 'LANGUAGE': 'en_US:en', 20:20:08 INFO - 'LOGNAME': 'cltbld', 20:20:08 INFO - 'MAIL': '/var/mail/cltbld', 20:20:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:20:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:08 INFO - 'MOZ_NO_REMOTE': '1', 20:20:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:08 INFO - 'NO_EM_RESTART': '1', 20:20:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:08 INFO - 'PWD': '/builds/slave/test', 20:20:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:20:08 INFO - 'SHELL': '/bin/bash', 20:20:08 INFO - 'SHLVL': '1', 20:20:08 INFO - 'TERM': 'linux', 20:20:08 INFO - 'TMOUT': '86400', 20:20:08 INFO - 'USER': 'cltbld', 20:20:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188', 20:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:08 INFO - '_': '/tools/buildbot/bin/python'} 20:20:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 20:20:08 INFO - mozversion application_buildid: 20161123185735 20:20:08 INFO - mozversion application_changeset: 50f234c53a7a97548a655efd992d04c2792a1954 20:20:08 INFO - mozversion application_display_name: Nightly 20:20:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:20:08 INFO - mozversion application_name: Firefox 20:20:08 INFO - mozversion application_remotingname: firefox 20:20:08 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 20:20:08 INFO - mozversion application_vendor: Mozilla 20:20:08 INFO - mozversion application_version: 53.0a1 20:20:08 INFO - mozversion platform_buildid: 20161123185735 20:20:08 INFO - mozversion platform_changeset: 50f234c53a7a97548a655efd992d04c2792a1954 20:20:08 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 20:20:08 INFO - mozversion platform_version: 53.0a1 20:20:08 INFO - using testdate: 1479961208 20:20:08 INFO - actual date: 1479961208 20:20:08 INFO - starting webserver on 'localhost:42329' 20:20:08 INFO - SUITE-START | Running 2 tests 20:20:08 INFO - TEST-START | dromaeo_css 20:20:08 INFO - operating with platform_type : linux_ 20:20:08 INFO - Initialising browser for dromaeo_css test... 20:20:08 INFO - TEST-INFO | started process 24735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4CxPtV/profile http://localhost:42329/getInfo.html) 20:20:13 INFO - PROCESS | 24735 | __metrics Screen width/height:1600/1200 20:20:13 INFO - PROCESS | 24735 | colorDepth:24 20:20:13 INFO - PROCESS | 24735 | Browser inner width/height: 1024/697 20:20:13 INFO - PROCESS | 24735 | __metrics 20:20:13 INFO - PROCESS | 24735 | 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" 20:20:13 INFO - PROCESS | 24735 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:20:14 INFO - PROCESS | 24735 | console.error: PushService: 20:20:14 INFO - PROCESS | 24735 | stateChangeProcessEnqueue: Error transitioning state 20:20:14 INFO - PROCESS | 24735 | UnknownError 20:20:15 INFO - TEST-INFO | 24735: exit 0 20:20:15 INFO - Browser initialized. 20:20:15 INFO - Running cycle 1/1 for dromaeo_css test... 20:20:15 INFO - TEST-INFO | started process 24817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4CxPtV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:20:27 INFO - PROCESS | 24817 | RSS: Main: 174223360 20:20:27 INFO - PROCESS | 24817 | 20:21:18 INFO - PROCESS | 24817 | 1479961278358 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:23:32 INFO - PROCESS | 24817 | Cycle 1(1): loaded http://localhost:42329/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42329/tests/dromaeo/cssquery-ext.html) 20:23:34 INFO - PROCESS | 24817 | RSS: Main: 343793664 20:23:34 INFO - PROCESS | 24817 | 20:26:36 INFO - PROCESS | 24817 | Cycle 1(1): loaded http://localhost:42329/tests/dromaeo/cssquery-ext.html (next: http://localhost:42329/tests/dromaeo/cssquery-jquery.html) 20:26:37 INFO - PROCESS | 24817 | RSS: Main: 284934144 20:26:37 INFO - PROCESS | 24817 | 20:29:39 INFO - PROCESS | 24817 | Cycle 1(1): loaded http://localhost:42329/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42329/tests/dromaeo/cssquery-mootools.html) 20:29:40 INFO - PROCESS | 24817 | RSS: Main: 219176960 20:29:40 INFO - PROCESS | 24817 | 20:32:42 INFO - PROCESS | 24817 | Cycle 1(1): loaded http://localhost:42329/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42329/tests/dromaeo/cssquery-prototype.html) 20:32:43 INFO - PROCESS | 24817 | RSS: Main: 220569600 20:32:43 INFO - PROCESS | 24817 | 20:35:46 INFO - PROCESS | 24817 | Cycle 1(1): loaded http://localhost:42329/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42329/tests/dromaeo/cssquery-yui.html) 20:35:47 INFO - PROCESS | 24817 | RSS: Main: 218898432 20:35:47 INFO - PROCESS | 24817 | 20:38:50 INFO - PROCESS | 24817 | Cycle 1(1): loaded http://localhost:42329/tests/dromaeo/cssquery-yui.html (next: http://localhost:42329/tests/dromaeo/cssquery-dojo.html) 20:38:50 INFO - PROCESS | 24817 | RSS: Main: 316948480 20:38:50 INFO - PROCESS | 24817 | 20:38:50 INFO - PROCESS | 24817 | __start_tp_report 20:38:50 INFO - PROCESS | 24817 | _x_x_mozilla_page_load 20:38:50 INFO - PROCESS | 24817 | _x_x_mozilla_page_load_details 20:38:50 INFO - PROCESS | 24817 | |i|pagename|runs| 20:38:50 INFO - PROCESS | 24817 | |0;dojo.html;2559.654446649702;2594.7016093149296;2617.22791776426;2630.644862943503;2643.6695413073353;4481.753503557303;4549.408576885;4672.813087476501;4689;4714.787834547445;4557.179707652621;4630.930536041962;4681.39141911551;4704.411948506437;4723.149833030053;4215.40984262202;4268;4305.397244385788;4312.094460163369;4396.472423309207;4000.2413698668374;4295.849645262417;4363.367311739796;4391.165678521071;4437.4009508716235;4252.87241382759;4298.31227003681;4398.626116780078;4430.933535996963;4476.082403107372;4275.080857615628;4312.892177695551;4314.115606300732;4328.04782947751;4407.118576284756;4305.095929854734;4309.418228539138;4314.805833737458;4321.24378233811;4363.781810909441;4642.280446530759;4685.812567497296;4687.343771871941;4688.413948256468;4691.038337140878;4882.487338829407;4887.853364399074;4932.654714170009;4943.233798761198;5039.924401133986;4937.753112344369;4956.207006878882;4958.107540642683;4974.52741989514;4989.426215985136;4608.97695511527;4609.239475486507;4609.654275929319;4615.815367385334;4653.069386122721;5024.824131155392;5032.094223039815;5048.646594738407;5064.721440320818;5076.035553244872;4794.712317260975;4852.587530059914;4859.684120532154;4866.197077482247;4924.482929292444;5038.874028149252;5040.7731652075745;5043.2435134730085;5074.67014644047;5096.949030509648;5005.124103281911;5018.172001619692;5021.347224860745;5021.824236151717;5029.84910452687;4831.903361932742;4889.413270407503;4898.681585696918;5046.7476626168545;5054.09026375256;3985.740926839746;4004.2992476316526;4021.738586991836;4022.517297924268;4062.045419326456;3553.6446355364774;3557.021818999744;3557.0395993081725;3579.570451545779;3590.1383667920036;4187.413762073312;4326.848560300375;4328.718633288826;4330.17726631939;4365.061511774984;4873.80504779812;4956.430010548761;4959.132151873408;4987.825426110141;4993.425756038029;4330.935035974463;4348.021695118573;4367.650587952956;4376.081022985209;4378.036831896978;4567.086582683411;4568.383268258809;4568.88577785558;4614;4618.861434156981;4528.252838281778;4556.749378784199;4668.626509879269;4668.85993420198;4675.13510000651;4941.827036053721;4951.232558953368;4981.6014718823135;5011.223260394645;5056.949430505795;4659.953400465952;4662.603678687349;4670.229412146958;4671.416072990876;4709.152352576569;4810.182269014206;4944.505549445027;4945.554900059012;4951.851444456672;4956.925646115384;4916.3362946001835;4965.652404331662;4975.776090075883;4977.875553111056;4984.028114517634;4820.39745031871;4851.369321988119;4851.611871050378;4853.344798452164;4855.150348689036;4847.394075740533;4848.030393921159;4856.223004319292;4857.222844344888;4857.635677324144;4755.83354582588;4799;4809.062232864558;4827.493113223061;4893.632977526629;4904.288878112725;4914.729689867092;4937.950620493749;4958.7024778513405;4993;4604.58558729716;4645.279981602857;4818.469968303554;4843.418789745253;4856.1987272099705 20:38:50 INFO - PROCESS | 24817 | |1;ext.html;540.905341565226;553.1509133480107;564.9322081350236;565.9094544872821;567.5147748674881;28166.155015349523;41705.79147104268;42908.78545607268;42972.57027429732;43112.13775724483;39746.40380394289;40107.59892401075;40114.39828402576;40157.59842401575;40172.59827401725;7255.8911616325795;7391.260873912593;7391.482596218267;7393.03890494235;7397.075365579302;7360.337569618733;7581.886271705929;9563.80872382552;9841.409515429097;9849.950750246238;9925;9964.103230709236;9987.201023918069;9989.200863930904;10009.599616015386;9757.902420975806;9775.31572789905;9795.461249631267;9812.362196457207;9822.754431139207;9586.808263834753;9648.807023859554;9656.082672146205;9657.275704322134;9659.420434773865;36255;36486.27027459462;36528.26943461142;36594;36600.81699591485;2871.6984716604875;3034.878604855803;3044.9543256850943;3069.8311592862383;3130.827804470753;27842.860785696146;28323.433531329465;28440.28899277514;28898.27754306138;29001.274968125756;3403.40440422925;3425.657434256579;3485.860565577374;3493.074335301147;3531.1525233943926;167048.16475917664;167461;167477.16261418737;167741;170114;50947;51268.48731512712;51307.74346128246;51332;51380.74309628428;53398;53689;53695.46304536983;53764;53792.73103634535;11978.041756659446;12266.877331226751;12461.314627695383;12466.314352710506;12467.88302924269;7962.08436029864;8453.66185352579;8498.830023399498;8500.48997060166;8523.445976011539;13624.386902589407;15510.457134000257;16004.359825607078;16112.113833739257;16474.588135296475;5332.200169974535;5458.918116228259;5460.754266058037;5466.289382380344;5478.945210547923;772.4862966127462;811.9106898241189;852.7058164933088;917.4266083697689;919.2416256588341;24905.750942490704;26498.205053848415;26942.461150776875;27029.594556081676;27156.592651110248;931.2968708624945;936.6066252174103;940.5156344482597;945.7351941456403;994.8857279846474;13417.262050587116;14000.159990400609;14436.566902992927;14594.489192878198;14690.63273418173;115525.4223728876;115761;115763;116291;116753.41623291829;40826.79586602107;41497.377539336936;45492.772536137105;46073.53926460692;46091.30863037057;1079.3955384984433;1091.4324551233315;1107.5182295701395;1109.0129784491808;1118.2340097033557;26296.21111366662;27554.862225688743;27614;27924;28298;44103;45470.31794523151;49585;49667.75166124146;49980.250296244856;337732;339416;339851;340561;341890;23924.12910450757;24057.75942240555;24501.632475512524;24521;24556.50886982286;39452.605473944895;39468.60531394649;39788;39999.20001599893;41026.17947640971;34238.657613423544;34278.14304642404;34756.82621586876;34796.65203347934;34990.65009349976;34169.31661366808;34196;34630.30739385248;34653.82673086618;34981.30037399289;33187.66812331846;33996.32007359889;34078.48882266817;34117;34385.312293753486;29629;31151.84424077865;31212.219694507818;31367.21581960469;31475.84262078675;23824.40438989039;24124.51750965006;24323.75676243215;24588.87705561461;24709.382265443506 20:38:50 INFO - PROCESS | 24817 | |2;jquery.html;343.4230492772145;358.61628057977975;369.5270054330457;369.92786406650697;381.64316364199476;12528.749425011494;15539.844601553981;15701.528954131365;16731.83268167318;16930.49208523743;16275.430359937405;16309.755353669674;16512.917435412837;16639.33442662292;16668.33326666932;3897.941530877039;4917.090338287419;5135.691858488484;5164.612654050961;5203.427622961472;3663.358912190369;3872.9225415491674;5699.344575373823;5977.850553736148;5979.282486101674;5833.649981001132;6023.066424704178;6026.8493287667725;6032.125341825433;6040.637561746309;6018.097285407181;6024.0662697282;6051.273847138327;6059.818205453844;6074.362191969846;4682.508336624639;4961.975190124026;5371.75827087782;5374.113271310229;5374.91937620936;11915.344656043913;12131.575394861138;12138.15032947694;12145.514179432812;13137.934310328386;1674.3972170018783;1756.0780590190252;1763.7266223735342;1816.300724221171;1968.980310196894;8850.468971861708;8878.156575125353;9008.369414141012;9021.684241051531;9415.199708024826;1701.2514493622891;1743.1425289985154;1745.8341457561512;1763.206557049333;1805.6749785038687;64775;64886.351136488505;66185.66907165434;66421.335786642;67821.32178678199;9846.212303015742;9858.112769850748;10111.59553617847;10125.797484050277;10156.4921753912;13877.375518101508;13878.306084695927;13881.652958676113;13888.722225555432;13909.860901390857;6415.101885736;6561.40947314744;6601.429247279738;6731.394174524218;6748.358905903931;5792.739326730223;5820.76716931318;5967.1347654589845;6075;6088.786892458743;4315.741055536615;4320.157569273962;4325.545817689161;4428.867133985986;4470.351798989193;1608.5254849819098;1685.7808484896884;1739.4086010756403;1758.7625670534314;1821.0013512907155;791.2404092071561;803.1807556292665;803.369355056278;804.8430556041633;826.7643721539332;16131.919340403458;16203.351865925466;16253.59366015859;16742.83257167437;17016.744748828776;819.8524265632243;847.4957400346784;848.3425345357274;868.2055918834196;912.7307444303814;8596.570171491401;9407.106324899261;9430.669926552675;9431.151196392357;9506.144446999802;335736;336652;338805;344552;345951;73657.10557378978;74033;75242.24757752461;76155.19594462868;78018;838.3209600223838;875.4703404440222;882.1122797214095;884.0408157149436;886.1050339157497;14083.155010699391;14498.637534061732;14919.328630211883;14925.46267134568;14954.626134346729;24192.153274635304;24918.750812491642;33070.83464582662;35373.82313088418;35604.82197588996;46748.29877551908;47406.28890566575;47476.7626161867;48136.27795582999;49763.75118124386;7132.251113632994;7339.8532029360185;7399.371053460516;7465.44009199323;7577.204393538599;8144.5520496373265;10624.787504250025;10736.194785390971;11013.118950483782;11350.262232954832;9283.72148835536;9777.9022209777;9812.411255324418;9880.85178722334;9928.354656947275;9188;9293.953530232306;9479.47862867549;9840.409575425498;9883.406995580288;7077.752278670222;7583;7814.101378341564;9060.592273347584;10515.05364517197;10311.175105991353;10363.378197308186;10517.15862730995;10823.458827058774;11105;9884.30809843304;10505.264631475724;10521.78956420852;10663.520141593803;10694.62568810088 20:38:50 INFO - PROCESS | 24817 | |3;mootools.html;1324.3179762422353;1341.4231880291475;1410.9576712698615;1607.0759313394801;1650.1171873047922;7066.858662826747;7590.8861367079535;7591.658375373115;7592.12690540588;7592.354649854762;6279.403456671609;6613.305602911697;7054.118235220598;7348.669309881055;7359.264073592638;2080.9479763005893;2119.07820098257;2121.416610432128;2125.3836387447623;2125.7555381131215;2076.3044380132674;2102.915883364671;2172.022589834573;2176.6517357222847;2181.214762685432;1795.9102044897768;1856.9814301857011;2037.2360364863177;2111.7254756881584;2112.2501511963264;2076.09689784944;2114.2177394364107;2118.6821976703463;2119.618468675638;2120.257909731597;2095.9790402095937;2112.039022244875;2118.3433135727973;2126.128287402173;2134.0503475953205;7240.493165478419;7316.122065352191;7350.558966462029;7380.704771809121;7397.556146631219;4422.579854913778;4548.56788605082;4561.452625684906;4565.269556870918;4568.132054909556;2705.2019654201863;2774.209350335165;2886.4660037892845;2909.345397285615;2928.765698744117;819.2749416766145;865.7835541114721;883.3198437203317;895.5835536475505;901.2069378946551;9828.508574571242;9905.504724763732;9908.355956862853;9944.353617014944;9981.401115933068;3856.2865869814173;4030.9922519370157;4132.049628585442;4149.543550209474;4194.2869712148395;8683;8713.695020674246;8717.041125476193;8718.17177368149;8738.38831281817;4533.705309154961;4541.84103556374;4542.31865220213;4543.204939135638;4545.0909818036525;4053.5946405359227;4057.350823868167;4064.5935406459116;4068.6541643960595;4071.42999980003;3153.1801731549963;3183.697548732867;3240.7569432292203;3245.464498357792;3263.5267886156375;901.2474583722534;906.7869050773063;914.7713071732067;918.7978644698155;946.8201041802173;644.3556443556444;738.2322384719938;827.3463963468793;839.1147339556826;861.814709837388;5013.147764879979;5115.667481613683;5185.377754669388;5212.592599997979;5236.711980841014;784.4626430894855;792.8424500229614;793.1196372027046;835.1648351648352;837.535167981776;3306.669333066722;3325.600927888669;3387.2548039431285;3415.624281329052;3439.071450708295;8649.135086491426;8787.604557794915;8904.154105359981;8920.464772113693;8923.598438070172;8698.434601750865;8847.203751662253;8872.556372181365;8909.10908909117;8926.330525210635;6737.124173857367;6879.759208427681;6884.105066341343;6888.207856096513;6914.861702765917;5019.874503137451;5077.882865769525;5092.872678182927;5119.436861945258;5366.597505187048;8219.506829590004;8296.875546866922;8312;8429;8492.363072769444;8409.62156702962;8555.743327700178;8601.39790214679;8619.396642234984;8643.394962352575;6042.607230530178;6174.938250617616;6176.4441200292185;6263.96868015657;6526.314736952551;7233.0597022386755;7349.448791340564;7358.632068396666;7361.8159546011775;7366.226546212571;6258.311585725475;6275.811725648238;6370.872582548416;6447.645994341241;6562.146920900444;6135.539834512519;6160.414760597736;6166.414190651881;6287.402696743802;6357.205349331333;5933.732982015906;6036.33600303975;6036.9094463582205;6047.0627052806885;6051.515878729603;4350.260455722471;4509.954900450954;4520.34455004016;4561.840335588238;4565.817367305271;4397.164538737629;4453.242948698664;4554.749488778149;4567.680262381734;4682.0869930364615 20:38:50 INFO - PROCESS | 24817 | |4;prototype.html;286.1701066905973;288.99711002889967;292.8082106220424;294.1352423873811;295.7028186672395;4780.8804779880475;4828.6721151683305;4829.275608658699;4913.413208357901;4914.311996320518;4554.94818471624;4791.466730646194;4798.328234047236;4806.711597304165;4854.8833768233235;3651.827162838107;3668.63313668633;3743.0829446785574;3792.2794669012937;3813.1229817142075;3779.225258821935;3787.1668232988836;3797.5632802227683;3805.2009078093633;3813.9976512330973;3565.7682250653756;3737.177820879402;3775.528058992626;3777.7544459610035;3780.8676696315633;3658.9268214635827;3699.5190625218684;3742.9625703742886;3771.3211621908044;3772.9056773580605;3292.42382583047;3302.2734998300334;3308.2225676965895;3321.78408403453;3322.318924620447;4672.556107169813;4675.007994883277;4677.228257337535;4681.789319480597;4685.5314468553215;4094.754314741125;4209.810558524843;4217.177650358181;4225.577442255781;4244.151169766059;4953.182724850395;4978.05855716271;4994.800207991676;5001.949980500185;5007.949920500785;3613.168971136627;3617;3618.5657721073376;3625.583057948343;3632.146445585285;5109.872253193663;5166.9224961625605;5281.894362112736;5290.989424018887;5299.54953828925;3656.2321912398693;3659.249853779969;3663.157473781045;3663.7435379523176;3669.7247706422127;3726.5341832270965;3745.7752534847996;3751.1934933989323;3771.4908487353855;3778;4240.791374458265;4244.617984381359;4245.448091748053;4272.829086836492;4303.4190384298345;4784.258439941815;5006.749662516932;5028.622853285945;5040.218766091261;5045.293658887758;1225.5526732742485;1234.919730217533;1239.7520495900856;1244.807054906491;1246.8030690537005;778.8247644279992;788.6254029336134;836.272442974616;843.7848348671049;847.7117779954845;4206.221848957953;4207.76857272853;4211.820690206747;4217;4244.405783190356;5057.064443078042;5187.377514698261;5199.29809475716;5204.219367094966;5238.711870847063;4347.891302717458;4452.710573812692;4455.821767129343;4462.464504259445;4464.441944756905;2636.1959602321094;2645.232882464064;2649.244965184913;2650.893964241409;2663.347479867406;4633.976830115827;4646.070785842845;4660.673752837337;4668.136394766979;4687.695299805502;5006.974965125151;5146.794128234904;5148.253503242009;5149.6910185389;5155.6391052626705;4640.211164102111;4654.208784506642;4656.953430465652;4661.184292748755;4661.836835710734;4936.8765780855765;4951.331570237971;4955.900881982412;4988.900221995613;5002.17464118431;4858.441279252931;4860.24666176729;4864.464908860094;4871.707697538159;4903.485134060872;4850.83022094225;4871;4882.365292512093;4884.9511504884495;4885.853424397274;3572.4284114541547;3590.8025058622025;3598.784072955631;3605.152789094508;3614.7831130132276;5097.490250974873;5270.8155214567305;5284.339457567804;5289.57683385336;5293.497117773805;5031.949680503149;5062.848114556569;5072.416672082758;5078.847634570969;5092.159793634009;5049.141645920129;5054.4187418447345;5072;5074.644774865724;5076.593872490266;4816.590589799906;4992.675476094042;4996.7001979881325;5024.0956627807345;5027.4218464877;4872.317875497504;4985.775640096277;4987.202047672355;5056.963322518948;5129.153689641167;4944.145945270524;4978.4523702393435;4989;4994.500549944976;4994.9750251248515 20:38:50 INFO - PROCESS | 24817 | |5;yui.html;642.6047980491998;662.2549631664381;672.4754691340754;678.3420082519954;732.3482100930173;11536.884631153685;11791.115666325028;11799.587014454495;11813.822792658106;11821;11590.710232244199;11653.184277100607;11680.591179308705;11693;11770.705732356695;608.595284136049;624.9281332646735;727.8435136445677;739.9223081576438;757.2427572427572;753.638253638254;754.2645920227761;756.7427074794568;758.8254701418649;759.2407592407592;806.0206848678854;806.2542148512632;807.229096213118;807.6809660184224;807.7536351412816;648.5233353485185;666.453508123339;768.2317682317682;792.3700657976922;803.317180396664;590.9290885093774;591.1280860730432;591.3967752892069;591.7632946821263;591.8224532640234;12299.508019679202;12320.199187052902;12329.075319350995;12332.81500777489;12353.876461235363;11223.607173748962;11296.54813807455;11342.432878356049;11557;11786.469608867621;9283.25733941283;9398.201152902011;9626.566804493814;9723.708288751279;10847.728806779814;3912.471816304791;3923.941140882889;3941.881743547698;3981.880543583697;4006.959930400688;40928.59071409307;45787.77106114481;48338.5166148341;49684;49873.75063124698;9229.215516681023;9260.120288572574;9294.44233345988;9397.859032114524;9441.103095205945;15349.15579643108;15731.68536629261;15873.603159920864;15930.840691593168;15944.760828587581;6180.81457556265;6191.504679625619;6225.28409232944;6264.37356264379;6354.682265886687;3411.164264755101;3535.4343305071066;3538.2569660371096;3581.552305961755;3594.101474631342;2704.986475067612;2806.789490788158;2807.6350074490188;2814.183886672842;2961.925951851221;544.1375419959329;547.8110052032042;549.851540084175;552.5110277404445;570.1618620627671;571.674145736926;578.7511370110808;583.4515555377931;588.399832171183;594.4145017158182;6455.644939528277;7583.544987300779;7586;7856.135825059239;7944.9205507945335;489.904468628614;566.1168577019862;570.3697414357158;580.5674772294583;585.8623223542464;3696.5564132303757;3762.2287431076566;3794.753341032824;3820.388737801994;3993.820278087493;68134.63730725358;69094.3090569098;69142.04866440424;72938.63530682419;73014.26985730181;63550.36449635537;63779.681101595124;63789.681051594445;63852.68073659695;64078.6796066026;44531.10937781226;47054;51557.74221128871;51782.74108629433;55842;8273.958630206811;8563.657453701782;8612.698555550525;8628.439151455135;8663.95668021656;33808;33902.491462627586;34328.313433730684;34775.304493909476;35353.292934140656;42520.36219456772;48191.5180848187;49025.5097449021;49202;49262.75368623134;10293.948530257301;10489.160867130764;10607;10752.51613677402;10779.568817247222;11853.466594003117;11940.402979851146;11964.547267809903;12157.513699451923;12326.630201093982;10527.578896844041;10782.838257426301;11152;11243.494042767932;11501;11218;11520.700477780314;11651.592194273499;11752.76494470123;12036.097292703258;11349.432528373713;11420.771584568096;11577.479013444246;11884.702882428008;11943.701407464883;9396.906030939877;9645.855312170463;9705.369151005161;9853.704388868346;9946.24856687653;8880.644774208959;9127.58925848325;9165.633374664938;9172.587233574639;9227.35408521424 20:38:50 INFO - PROCESS | 24817 | __end_tp_report 20:38:50 INFO - PROCESS | 24817 | __start_cc_report 20:38:50 INFO - PROCESS | 24817 | _x_x_mozilla_cycle_collect,1855 20:38:50 INFO - PROCESS | 24817 | __end_cc_report 20:38:50 INFO - PROCESS | 24817 | __startTimestamp1479962330634__endTimestamp 20:38:50 INFO - PROCESS | 24817 | 20:38:50 INFO - PROCESS | 24817 | ------- Summary: start ------- 20:38:50 INFO - PROCESS | 24817 | Number of tests: 6 20:38:50 INFO - PROCESS | 24817 | 20:38:50 INFO - PROCESS | 24817 | [#0] dojo.html Cycles:165 Average:4600.47 Median:4691.04 stddev:489.28 (10.4%) stddev-sans-first:463.85 20:38:50 INFO - PROCESS | 24817 | Values: 2559.7 2594.7 2617.2 2630.6 2643.7 4481.8 4549.4 4672.8 4689.0 4714.8 4557.2 4630.9 4681.4 4704.4 4723.1 4215.4 4268.0 4305.4 4312.1 4396.5 4000.2 4295.8 4363.4 4391.2 4437.4 4252.9 4298.3 4398.6 4430.9 4476.1 4275.1 4312.9 4314.1 4328.0 4407.1 4305.1 4309.4 4314.8 4321.2 4363.8 4642.3 4685.8 4687.3 4688.4 4691.0 4882.5 4887.9 4932.7 4943.2 5039.9 4937.8 4956.2 4958.1 4974.5 4989.4 4609.0 4609.2 4609.7 4615.8 4653.1 5024.8 5032.1 5048.6 5064.7 5076.0 4794.7 4852.6 4859.7 4866.2 4924.5 5038.9 5040.8 5043.2 5074.7 5096.9 5005.1 5018.2 5021.3 5021.8 5029.8 4831.9 4889.4 4898.7 5046.7 5054.1 3985.7 4004.3 4021.7 4022.5 4062.0 3553.6 3557.0 3557.0 3579.6 3590.1 4187.4 4326.8 4328.7 4330.2 4365.1 4873.8 4956.4 4959.1 4987.8 4993.4 4330.9 4348.0 4367.7 4376.1 4378.0 4567.1 4568.4 4568.9 4614.0 4618.9 4528.3 4556.7 4668.6 4668.9 4675.1 4941.8 4951.2 4981.6 5011.2 5056.9 4660.0 4662.6 4670.2 4671.4 4709.2 4810.2 4944.5 4945.6 4951.9 4956.9 4916.3 4965.7 4975.8 4977.9 4984.0 4820.4 4851.4 4851.6 4853.3 4855.2 4847.4 4848.0 4856.2 4857.2 4857.6 4755.8 4799.0 4809.1 4827.5 4893.6 4904.3 4914.7 4938.0 4958.7 4993.0 4604.6 4645.3 4818.5 4843.4 4856.2 20:38:50 INFO - PROCESS | 24817 | 20:38:50 INFO - PROCESS | 24817 | [#1] ext.html Cycles:180 Average:37598.82 Median:19260.90 stddev:60559.94 (314.4%) stddev-sans-first:60665.91 20:38:50 INFO - PROCESS | 24817 | Values: 540.9 553.2 564.9 565.9 567.5 28166.2 41705.8 42908.8 42972.6 43112.1 39746.4 40107.6 40114.4 40157.6 40172.6 7255.9 7391.3 7391.5 7393.0 7397.1 7360.3 7581.9 9563.8 9841.4 9850.0 9925.0 9964.1 9987.2 9989.2 10009.6 9757.9 9775.3 9795.5 9812.4 9822.8 9586.8 9648.8 9656.1 9657.3 9659.4 36255.0 36486.3 36528.3 36594.0 36600.8 2871.7 3034.9 3045.0 3069.8 3130.8 27842.9 28323.4 28440.3 28898.3 29001.3 3403.4 3425.7 3485.9 3493.1 3531.2 167048.2 167461.0 167477.2 167741.0 170114.0 50947.0 51268.5 51307.7 51332.0 51380.7 53398.0 53689.0 53695.5 53764.0 53792.7 11978.0 12266.9 12461.3 12466.3 12467.9 7962.1 8453.7 8498.8 8500.5 8523.4 13624.4 15510.5 16004.4 16112.1 16474.6 5332.2 5458.9 5460.8 5466.3 5478.9 772.5 811.9 852.7 917.4 919.2 24905.8 26498.2 26942.5 27029.6 27156.6 931.3 936.6 940.5 945.7 994.9 13417.3 14000.2 14436.6 14594.5 14690.6 115525.4 115761.0 115763.0 116291.0 116753.4 40826.8 41497.4 45492.8 46073.5 46091.3 1079.4 1091.4 1107.5 1109.0 1118.2 26296.2 27554.9 27614.0 27924.0 28298.0 44103.0 45470.3 49585.0 49667.8 49980.3 337732.0 339416.0 339851.0 340561.0 341890.0 23924.1 24057.8 24501.6 24521.0 24556.5 39452.6 39468.6 39788.0 39999.2 41026.2 34238.7 34278.1 34756.8 34796.7 34990.7 34169.3 34196.0 34630.3 34653.8 34981.3 33187.7 33996.3 34078.5 34117.0 34385.3 29629.0 31151.8 31212.2 31367.2 31475.8 23824.4 24124.5 24323.8 24588.9 24709.4 20:38:50 INFO - PROCESS | 24817 | 20:38:50 INFO - PROCESS | 24817 | [#2] jquery.html Cycles:180 Average:22129.34 Median:4939.53 stddev:56441.32 (1142.6%) stddev-sans-first:56575.95 20:38:50 INFO - PROCESS | 24817 | Values: 343.4 358.6 369.5 369.9 381.6 12528.7 15539.8 15701.5 16731.8 16930.5 16275.4 16309.8 16512.9 16639.3 16668.3 3897.9 4917.1 5135.7 5164.6 5203.4 3663.4 3872.9 5699.3 5977.9 5979.3 5833.6 6023.1 6026.8 6032.1 6040.6 6018.1 6024.1 6051.3 6059.8 6074.4 4682.5 4962.0 5371.8 5374.1 5374.9 11915.3 12131.6 12138.2 12145.5 13137.9 1674.4 1756.1 1763.7 1816.3 1969.0 8850.5 8878.2 9008.4 9021.7 9415.2 1701.3 1743.1 1745.8 1763.2 1805.7 64775.0 64886.4 66185.7 66421.3 67821.3 9846.2 9858.1 10111.6 10125.8 10156.5 13877.4 13878.3 13881.7 13888.7 13909.9 6415.1 6561.4 6601.4 6731.4 6748.4 5792.7 5820.8 5967.1 6075.0 6088.8 4315.7 4320.2 4325.5 4428.9 4470.4 1608.5 1685.8 1739.4 1758.8 1821.0 791.2 803.2 803.4 804.8 826.8 16131.9 16203.4 16253.6 16742.8 17016.7 819.9 847.5 848.3 868.2 912.7 8596.6 9407.1 9430.7 9431.2 9506.1 335736.0 336652.0 338805.0 344552.0 345951.0 73657.1 74033.0 75242.2 76155.2 78018.0 838.3 875.5 882.1 884.0 886.1 14083.2 14498.6 14919.3 14925.5 14954.6 24192.2 24918.8 33070.8 35373.8 35604.8 46748.3 47406.3 47476.8 48136.3 49763.8 7132.3 7339.9 7399.4 7465.4 7577.2 8144.6 10624.8 10736.2 11013.1 11350.3 9283.7 9777.9 9812.4 9880.9 9928.4 9188.0 9294.0 9479.5 9840.4 9883.4 7077.8 7583.0 7814.1 9060.6 10515.1 10311.2 10363.4 10517.2 10823.5 11105.0 9884.3 10505.3 10521.8 10663.5 10694.6 20:38:50 INFO - PROCESS | 24817 | 20:38:50 INFO - PROCESS | 24817 | [#3] mootools.html Cycles:180 Average:4870.04 Median:6093.53 stddev:2686.97 (44.1%) stddev-sans-first:2681.29 20:38:50 INFO - PROCESS | 24817 | Values: 1324.3 1341.4 1411.0 1607.1 1650.1 7066.9 7590.9 7591.7 7592.1 7592.4 6279.4 6613.3 7054.1 7348.7 7359.3 2080.9 2119.1 2121.4 2125.4 2125.8 2076.3 2102.9 2172.0 2176.7 2181.2 1795.9 1857.0 2037.2 2111.7 2112.3 2076.1 2114.2 2118.7 2119.6 2120.3 2096.0 2112.0 2118.3 2126.1 2134.1 7240.5 7316.1 7350.6 7380.7 7397.6 4422.6 4548.6 4561.5 4565.3 4568.1 2705.2 2774.2 2886.5 2909.3 2928.8 819.3 865.8 883.3 895.6 901.2 9828.5 9905.5 9908.4 9944.4 9981.4 3856.3 4031.0 4132.0 4149.5 4194.3 8683.0 8713.7 8717.0 8718.2 8738.4 4533.7 4541.8 4542.3 4543.2 4545.1 4053.6 4057.4 4064.6 4068.7 4071.4 3153.2 3183.7 3240.8 3245.5 3263.5 901.2 906.8 914.8 918.8 946.8 644.4 738.2 827.3 839.1 861.8 5013.1 5115.7 5185.4 5212.6 5236.7 784.5 792.8 793.1 835.2 837.5 3306.7 3325.6 3387.3 3415.6 3439.1 8649.1 8787.6 8904.2 8920.5 8923.6 8698.4 8847.2 8872.6 8909.1 8926.3 6737.1 6879.8 6884.1 6888.2 6914.9 5019.9 5077.9 5092.9 5119.4 5366.6 8219.5 8296.9 8312.0 8429.0 8492.4 8409.6 8555.7 8601.4 8619.4 8643.4 6042.6 6174.9 6176.4 6264.0 6526.3 7233.1 7349.4 7358.6 7361.8 7366.2 6258.3 6275.8 6370.9 6447.6 6562.1 6135.5 6160.4 6166.4 6287.4 6357.2 5933.7 6036.3 6036.9 6047.1 6051.5 4350.3 4510.0 4520.3 4561.8 4565.8 4397.2 4453.2 4554.7 4567.7 4682.1 20:38:50 INFO - PROCESS | 24817 | 20:38:50 INFO - PROCESS | 24817 | [#4] prototype.html Cycles:180 Average:4144.41 Median:4673.78 stddev:1206.90 (25.8%) stddev-sans-first:1175.03 20:38:50 INFO - PROCESS | 24817 | Values: 286.2 289.0 292.8 294.1 295.7 4780.9 4828.7 4829.3 4913.4 4914.3 4554.9 4791.5 4798.3 4806.7 4854.9 3651.8 3668.6 3743.1 3792.3 3813.1 3779.2 3787.2 3797.6 3805.2 3814.0 3565.8 3737.2 3775.5 3777.8 3780.9 3658.9 3699.5 3743.0 3771.3 3772.9 3292.4 3302.3 3308.2 3321.8 3322.3 4672.6 4675.0 4677.2 4681.8 4685.5 4094.8 4209.8 4217.2 4225.6 4244.2 4953.2 4978.1 4994.8 5001.9 5007.9 3613.2 3617.0 3618.6 3625.6 3632.1 5109.9 5166.9 5281.9 5291.0 5299.5 3656.2 3659.2 3663.2 3663.7 3669.7 3726.5 3745.8 3751.2 3771.5 3778.0 4240.8 4244.6 4245.4 4272.8 4303.4 4784.3 5006.7 5028.6 5040.2 5045.3 1225.6 1234.9 1239.8 1244.8 1246.8 778.8 788.6 836.3 843.8 847.7 4206.2 4207.8 4211.8 4217.0 4244.4 5057.1 5187.4 5199.3 5204.2 5238.7 4347.9 4452.7 4455.8 4462.5 4464.4 2636.2 2645.2 2649.2 2650.9 2663.3 4634.0 4646.1 4660.7 4668.1 4687.7 5007.0 5146.8 5148.3 5149.7 5155.6 4640.2 4654.2 4657.0 4661.2 4661.8 4936.9 4951.3 4955.9 4988.9 5002.2 4858.4 4860.2 4864.5 4871.7 4903.5 4850.8 4871.0 4882.4 4885.0 4885.9 3572.4 3590.8 3598.8 3605.2 3614.8 5097.5 5270.8 5284.3 5289.6 5293.5 5031.9 5062.8 5072.4 5078.8 5092.2 5049.1 5054.4 5072.0 5074.6 5076.6 4816.6 4992.7 4996.7 5024.1 5027.4 4872.3 4985.8 4987.2 5057.0 5129.2 4944.1 4978.5 4989.0 4994.5 4995.0 20:38:50 INFO - PROCESS | 24817 | 20:38:50 INFO - PROCESS | 24817 | [#5] yui.html Cycles:180 Average:14266.94 Median:26163.44 stddev:18277.35 (69.9%) stddev-sans-first:18299.99 20:38:50 INFO - PROCESS | 24817 | Values: 642.6 662.3 672.5 678.3 732.3 11536.9 11791.1 11799.6 11813.8 11821.0 11590.7 11653.2 11680.6 11693.0 11770.7 608.6 624.9 727.8 739.9 757.2 753.6 754.3 756.7 758.8 759.2 806.0 806.3 807.2 807.7 807.8 648.5 666.5 768.2 792.4 803.3 590.9 591.1 591.4 591.8 591.8 12299.5 12320.2 12329.1 12332.8 12353.9 11223.6 11296.5 11342.4 11557.0 11786.5 9283.3 9398.2 9626.6 9723.7 10847.7 3912.5 3923.9 3941.9 3981.9 4007.0 40928.6 45787.8 48338.5 49684.0 49873.8 9229.2 9260.1 9294.4 9397.9 9441.1 15349.2 15731.7 15873.6 15930.8 15944.8 6180.8 6191.5 6225.3 6264.4 6354.7 3411.2 3535.4 3538.3 3581.6 3594.1 2705.0 2806.8 2807.6 2814.2 2961.9 544.1 547.8 549.9 552.5 570.2 571.7 578.8 583.5 588.4 594.4 6455.6 7583.5 7586.0 7856.1 7944.9 489.9 566.1 570.4 580.6 585.9 3696.6 3762.2 3794.8 3820.4 3993.8 68134.6 69094.3 69142.0 72938.6 73014.3 63550.4 63779.7 63789.7 63852.7 64078.7 44531.1 47054.0 51557.7 51782.7 55842.0 8274.0 8563.7 8612.7 8628.4 8664.0 33808.0 33902.5 34328.3 34775.3 35353.3 42520.4 48191.5 49025.5 49202.0 49262.8 10293.9 10489.2 10607.0 10752.5 10779.6 11853.5 11940.4 11964.5 12157.5 12326.6 10527.6 10782.8 11152.0 11243.5 11501.0 11218.0 11520.7 11651.6 11752.8 12036.1 11349.4 11420.8 11577.5 11884.7 11943.7 9396.9 9645.9 9705.4 9853.7 9946.2 8880.6 9127.6 9165.6 9172.6 9227.4 20:38:50 INFO - PROCESS | 24817 | -------- Summary: end -------- 20:38:50 INFO - PROCESS | 24817 | 20:38:51 INFO - TEST-INFO | 24817: exit 0 20:38:51 INFO - TEST-OK | dromaeo_css | took 1122756ms 20:38:51 INFO - TEST-START | kraken 20:38:51 INFO - operating with platform_type : linux_ 20:38:51 INFO - Initialising browser for kraken test... 20:38:51 INFO - TEST-INFO | started process 25119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyPhVJc/profile http://localhost:42329/getInfo.html) 20:38:55 INFO - PROCESS | 25119 | __metrics Screen width/height:1600/1200 20:38:55 INFO - PROCESS | 25119 | colorDepth:24 20:38:55 INFO - PROCESS | 25119 | Browser inner width/height: 1024/697 20:38:55 INFO - PROCESS | 25119 | __metrics 20:38:56 INFO - PROCESS | 25119 | 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" 20:38:56 INFO - PROCESS | 25119 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:38:57 INFO - PROCESS | 25119 | console.error: PushService: 20:38:57 INFO - PROCESS | 25119 | stateChangeProcessEnqueue: Error transitioning state 20:38:57 INFO - PROCESS | 25119 | UnknownError 20:38:57 INFO - TEST-INFO | 25119: exit 0 20:38:57 INFO - Browser initialized. 20:38:57 INFO - Running cycle 1/1 for kraken test... 20:38:57 INFO - TEST-INFO | started process 25203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyPhVJc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:39:10 INFO - PROCESS | 25203 | RSS: Main: 174555136 20:39:10 INFO - PROCESS | 25203 | 20:39:12 INFO - PROCESS | 25203 | Cycle 1(1): loaded http://localhost:42329/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42329/tests/kraken/driver.html?testName=audio-beat-detection) 20:39:13 INFO - PROCESS | 25203 | RSS: Main: 239476736 20:39:13 INFO - PROCESS | 25203 | 20:39:16 INFO - PROCESS | 25203 | Cycle 1(1): loaded http://localhost:42329/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42329/tests/kraken/driver.html?testName=audio-dft) 20:39:17 INFO - PROCESS | 25203 | RSS: Main: 218435584 20:39:17 INFO - PROCESS | 25203 | 20:39:20 INFO - PROCESS | 25203 | Cycle 1(1): loaded http://localhost:42329/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42329/tests/kraken/driver.html?testName=audio-fft) 20:39:21 INFO - PROCESS | 25203 | RSS: Main: 300806144 20:39:21 INFO - PROCESS | 25203 | 20:39:23 INFO - PROCESS | 25203 | Cycle 1(1): loaded http://localhost:42329/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42329/tests/kraken/driver.html?testName=audio-oscillator) 20:39:23 INFO - PROCESS | 25203 | RSS: Main: 210432000 20:39:23 INFO - PROCESS | 25203 | 20:39:26 INFO - PROCESS | 25203 | Cycle 1(1): loaded http://localhost:42329/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42329/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:39:26 INFO - PROCESS | 25203 | RSS: Main: 214622208 20:39:26 INFO - PROCESS | 25203 | 20:39:29 INFO - PROCESS | 25203 | Cycle 1(1): loaded http://localhost:42329/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42329/tests/kraken/driver.html?testName=imaging-darkroom) 20:39:30 INFO - PROCESS | 25203 | RSS: Main: 253341696 20:39:30 INFO - PROCESS | 25203 | 20:39:34 INFO - PROCESS | 25203 | Cycle 1(1): loaded http://localhost:42329/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42329/tests/kraken/driver.html?testName=imaging-desaturate) 20:39:34 INFO - PROCESS | 25203 | RSS: Main: 247713792 20:39:34 INFO - PROCESS | 25203 | 20:39:37 INFO - PROCESS | 25203 | Cycle 1(1): loaded http://localhost:42329/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42329/tests/kraken/driver.html?testName=json-parse-financial) 20:39:38 INFO - PROCESS | 25203 | RSS: Main: 249778176 20:39:38 INFO - PROCESS | 25203 | 20:39:39 INFO - PROCESS | 25203 | Cycle 1(1): loaded http://localhost:42329/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42329/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:39:40 INFO - PROCESS | 25203 | RSS: Main: 213245952 20:39:40 INFO - PROCESS | 25203 | 20:39:42 INFO - PROCESS | 25203 | Cycle 1(1): loaded http://localhost:42329/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42329/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:39:43 INFO - PROCESS | 25203 | RSS: Main: 220049408 20:39:43 INFO - PROCESS | 25203 | 20:39:45 INFO - PROCESS | 25203 | Cycle 1(1): loaded http://localhost:42329/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42329/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:39:45 INFO - PROCESS | 25203 | RSS: Main: 229253120 20:39:45 INFO - PROCESS | 25203 | 20:39:48 INFO - PROCESS | 25203 | Cycle 1(1): loaded http://localhost:42329/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42329/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:39:49 INFO - PROCESS | 25203 | RSS: Main: 237940736 20:39:49 INFO - PROCESS | 25203 | 20:39:52 INFO - PROCESS | 25203 | Cycle 1(1): loaded http://localhost:42329/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42329/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:39:53 INFO - PROCESS | 25203 | RSS: Main: 233652224 20:39:53 INFO - PROCESS | 25203 | 20:39:54 INFO - PROCESS | 25203 | Cycle 1(1): loaded http://localhost:42329/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42329/tests/kraken/driver.html?testName=ai-astar) 20:39:55 INFO - PROCESS | 25203 | RSS: Main: 285876224 20:39:55 INFO - PROCESS | 25203 | 20:39:55 INFO - PROCESS | 25203 | __start_tp_report 20:39:55 INFO - PROCESS | 25203 | _x_x_mozilla_page_load 20:39:55 INFO - PROCESS | 25203 | _x_x_mozilla_page_load_details 20:39:55 INFO - PROCESS | 25203 | |i|pagename|runs| 20:39:55 INFO - PROCESS | 25203 | |0;ai-astar;110;119;116;117;118;115;115;117;114;114 20:39:55 INFO - PROCESS | 25203 | |1;audio-beat-detection;159;132;136;169;133;131;131;141;161;130 20:39:55 INFO - PROCESS | 25203 | |2;audio-dft;160;162;161;162;163;163;163;162;165;162 20:39:55 INFO - PROCESS | 25203 | |3;audio-fft;76;77;77;110;77;77;77;76;89;75 20:39:55 INFO - PROCESS | 25203 | |4;audio-oscillator;86;85;116;83;83;83;99;83;82;119 20:39:55 INFO - PROCESS | 25203 | |5;imaging-gaussian-blur;118;117;118;117;117;117;116;117;116;116 20:39:55 INFO - PROCESS | 25203 | |6;imaging-darkroom;149;148;148;148;148;148;148;148;147;147 20:39:55 INFO - PROCESS | 25203 | |7;imaging-desaturate;97;95;95;96;96;95;95;95;95;95 20:39:55 INFO - PROCESS | 25203 | |8;json-parse-financial;64;63;63;65;63;65;65;65;64;68 20:39:55 INFO - PROCESS | 25203 | |9;json-stringify-tinderbox;67;67;66;66;66;65;66;66;67;66 20:39:55 INFO - PROCESS | 25203 | |10;stanford-crypto-aes;85;85;89;85;84;91;84;85;85;84 20:39:55 INFO - PROCESS | 25203 | |11;stanford-crypto-ccm;155;148;144;143;153;140;143;151;185;138 20:39:55 INFO - PROCESS | 25203 | |12;stanford-crypto-pbkdf2;182;183;187;183;180;179;179;180;179;179 20:39:55 INFO - PROCESS | 25203 | |13;stanford-crypto-sha256-iterative;71;69;81;70;72;69;70;70;69;69 20:39:55 INFO - PROCESS | 25203 | __end_tp_report 20:39:55 INFO - PROCESS | 25203 | __start_cc_report 20:39:55 INFO - PROCESS | 25203 | _x_x_mozilla_cycle_collect,1954 20:39:55 INFO - PROCESS | 25203 | __end_cc_report 20:39:55 INFO - PROCESS | 25203 | __startTimestamp1479962395227__endTimestamp 20:39:55 INFO - PROCESS | 25203 | 20:39:55 INFO - PROCESS | 25203 | ------- Summary: start ------- 20:39:55 INFO - PROCESS | 25203 | Number of tests: 14 20:39:55 INFO - PROCESS | 25203 | 20:39:55 INFO - PROCESS | 25203 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.50 stddev:2.55 (2.2%) stddev-sans-first:1.76 20:39:55 INFO - PROCESS | 25203 | Values: 110.0 119.0 116.0 117.0 118.0 115.0 115.0 117.0 114.0 114.0 20:39:55 INFO - PROCESS | 25203 | 20:39:55 INFO - PROCESS | 25203 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:138.50 stddev:14.84 (10.7%) stddev-sans-first:14.46 20:39:55 INFO - PROCESS | 25203 | Values: 159.0 132.0 136.0 169.0 133.0 131.0 131.0 141.0 161.0 130.0 20:39:55 INFO - PROCESS | 25203 | 20:39:55 INFO - PROCESS | 25203 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.34 (0.8%) stddev-sans-first:1.13 20:39:55 INFO - PROCESS | 25203 | Values: 160.0 162.0 161.0 162.0 163.0 163.0 163.0 162.0 165.0 162.0 20:39:55 INFO - PROCESS | 25203 | 20:39:55 INFO - PROCESS | 25203 | [#3] audio-fft Cycles:10 Average:81.10 Median:77.00 stddev:10.91 (14.2%) stddev-sans-first:11.41 20:39:55 INFO - PROCESS | 25203 | Values: 76.0 77.0 77.0 110.0 77.0 77.0 77.0 76.0 89.0 75.0 20:39:55 INFO - PROCESS | 25203 | 20:39:55 INFO - PROCESS | 25203 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:83.00 stddev:14.39 (17.3%) stddev-sans-first:15.10 20:39:55 INFO - PROCESS | 25203 | Values: 86.0 85.0 116.0 83.0 83.0 83.0 99.0 83.0 82.0 119.0 20:39:55 INFO - PROCESS | 25203 | 20:39:55 INFO - PROCESS | 25203 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 20:39:55 INFO - PROCESS | 25203 | Values: 118.0 117.0 118.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 20:39:55 INFO - PROCESS | 25203 | 20:39:55 INFO - PROCESS | 25203 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 20:39:55 INFO - PROCESS | 25203 | Values: 149.0 148.0 148.0 148.0 148.0 148.0 148.0 148.0 147.0 147.0 20:39:55 INFO - PROCESS | 25203 | 20:39:55 INFO - PROCESS | 25203 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.44 20:39:55 INFO - PROCESS | 25203 | Values: 97.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 20:39:55 INFO - PROCESS | 25203 | 20:39:55 INFO - PROCESS | 25203 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:1.51 (2.3%) stddev-sans-first:1.59 20:39:55 INFO - PROCESS | 25203 | Values: 64.0 63.0 63.0 65.0 63.0 65.0 65.0 65.0 64.0 68.0 20:39:55 INFO - PROCESS | 25203 | 20:39:55 INFO - PROCESS | 25203 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 20:39:55 INFO - PROCESS | 25203 | Values: 67.0 67.0 66.0 66.0 66.0 65.0 66.0 66.0 67.0 66.0 20:39:55 INFO - PROCESS | 25203 | 20:39:55 INFO - PROCESS | 25203 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:2.36 (2.8%) stddev-sans-first:2.49 20:39:55 INFO - PROCESS | 25203 | Values: 85.0 85.0 89.0 85.0 84.0 91.0 84.0 85.0 85.0 84.0 20:39:55 INFO - PROCESS | 25203 | 20:39:55 INFO - PROCESS | 25203 | [#11] stanford-crypto-ccm Cycles:10 Average:150.00 Median:149.50 stddev:13.51 (9.0%) stddev-sans-first:14.20 20:39:55 INFO - PROCESS | 25203 | Values: 155.0 148.0 144.0 143.0 153.0 140.0 143.0 151.0 185.0 138.0 20:39:55 INFO - PROCESS | 25203 | 20:39:55 INFO - PROCESS | 25203 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.10 Median:181.00 stddev:2.64 (1.5%) stddev-sans-first:2.78 20:39:55 INFO - PROCESS | 25203 | Values: 182.0 183.0 187.0 183.0 180.0 179.0 179.0 180.0 179.0 179.0 20:39:55 INFO - PROCESS | 25203 | 20:39:55 INFO - PROCESS | 25203 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:70.00 stddev:3.65 (5.2%) stddev-sans-first:3.87 20:39:55 INFO - PROCESS | 25203 | Values: 71.0 69.0 81.0 70.0 72.0 69.0 70.0 70.0 69.0 69.0 20:39:55 INFO - PROCESS | 25203 | -------- Summary: end -------- 20:39:55 INFO - PROCESS | 25203 | 20:39:56 INFO - TEST-INFO | 25203: exit 0 20:39:56 INFO - TEST-OK | kraken | took 64920ms 20:39:56 INFO - SUITE-END | took 1187s 20:39:56 INFO - Completed test suite (00:19:48) 20:39:56 INFO - javascript benchmark 20:39:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2559.654446649702, 2594.7016093149296, 2617.22791776426, 2630.644862943503, 2643.6695413073353, 4481.753503557303, 4549.408576885, 4672.813087476501, 4689.0, 4714.787834547445, 4557.179707652621, 4630.930536041962, 4681.39141911551, 4704.411948506437, 4723.149833030053, 4215.40984262202, 4268.0, 4305.397244385788, 4312.094460163369, 4396.472423309207, 4000.2413698668374, 4295.849645262417, 4363.367311739796, 4391.165678521071, 4437.4009508716235, 4252.87241382759, 4298.31227003681, 4398.626116780078, 4430.933535996963, 4476.082403107372, 4275.080857615628, 4312.892177695551, 4314.115606300732, 4328.04782947751, 4407.118576284756, 4305.095929854734, 4309.418228539138, 4314.805833737458, 4321.24378233811, 4363.781810909441, 4642.280446530759, 4685.812567497296, 4687.343771871941, 4688.413948256468, 4691.038337140878, 4882.487338829407, 4887.853364399074, 4932.654714170009, 4943.233798761198, 5039.924401133986, 4937.753112344369, 4956.207006878882, 4958.107540642683, 4974.52741989514, 4989.426215985136, 4608.97695511527, 4609.239475486507, 4609.654275929319, 4615.815367385334, 4653.069386122721, 5024.824131155392, 5032.094223039815, 5048.646594738407, 5064.721440320818, 5076.035553244872, 4794.712317260975, 4852.587530059914, 4859.684120532154, 4866.197077482247, 4924.482929292444, 5038.874028149252, 5040.7731652075745, 5043.2435134730085, 5074.67014644047, 5096.949030509648, 5005.124103281911, 5018.172001619692, 5021.347224860745, 5021.824236151717, 5029.84910452687, 4831.903361932742, 4889.413270407503, 4898.681585696918, 5046.7476626168545, 5054.09026375256, 3985.740926839746, 4004.2992476316526, 4021.738586991836, 4022.517297924268, 4062.045419326456, 3553.6446355364774, 3557.021818999744, 3557.0395993081725, 3579.570451545779, 3590.1383667920036, 4187.413762073312, 4326.848560300375, 4328.718633288826, 4330.17726631939, 4365.061511774984, 4873.80504779812, 4956.430010548761, 4959.132151873408, 4987.825426110141, 4993.425756038029, 4330.935035974463, 4348.021695118573, 4367.650587952956, 4376.081022985209, 4378.036831896978, 4567.086582683411, 4568.383268258809, 4568.88577785558, 4614.0, 4618.861434156981, 4528.252838281778, 4556.749378784199, 4668.626509879269, 4668.85993420198, 4675.13510000651, 4941.827036053721, 4951.232558953368, 4981.6014718823135, 5011.223260394645, 5056.949430505795, 4659.953400465952, 4662.603678687349, 4670.229412146958, 4671.416072990876, 4709.152352576569, 4810.182269014206, 4944.505549445027, 4945.554900059012, 4951.851444456672, 4956.925646115384, 4916.3362946001835, 4965.652404331662, 4975.776090075883, 4977.875553111056, 4984.028114517634, 4820.39745031871, 4851.369321988119, 4851.611871050378, 4853.344798452164, 4855.150348689036, 4847.394075740533, 4848.030393921159, 4856.223004319292, 4857.222844344888, 4857.635677324144, 4755.83354582588, 4799.0, 4809.062232864558, 4827.493113223061, 4893.632977526629, 4904.288878112725, 4914.729689867092, 4937.950620493749, 4958.7024778513405, 4993.0, 4604.58558729716, 4645.279981602857, 4818.469968303554, 4843.418789745253, 4856.1987272099705], "value": 4568.872294260736, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.905341565226, 553.1509133480107, 564.9322081350236, 565.9094544872821, 567.5147748674881, 28166.155015349523, 41705.79147104268, 42908.78545607268, 42972.57027429732, 43112.13775724483, 39746.40380394289, 40107.59892401075, 40114.39828402576, 40157.59842401575, 40172.59827401725, 7255.8911616325795, 7391.260873912593, 7391.482596218267, 7393.03890494235, 7397.075365579302, 7360.337569618733, 7581.886271705929, 9563.80872382552, 9841.409515429097, 9849.950750246238, 9925.0, 9964.103230709236, 9987.201023918069, 9989.200863930904, 10009.599616015386, 9757.902420975806, 9775.31572789905, 9795.461249631267, 9812.362196457207, 9822.754431139207, 9586.808263834753, 9648.807023859554, 9656.082672146205, 9657.275704322134, 9659.420434773865, 36255.0, 36486.27027459462, 36528.26943461142, 36594.0, 36600.81699591485, 2871.6984716604875, 3034.878604855803, 3044.9543256850943, 3069.8311592862383, 3130.827804470753, 27842.860785696146, 28323.433531329465, 28440.28899277514, 28898.27754306138, 29001.274968125756, 3403.40440422925, 3425.657434256579, 3485.860565577374, 3493.074335301147, 3531.1525233943926, 167048.16475917664, 167461.0, 167477.16261418737, 167741.0, 170114.0, 50947.0, 51268.48731512712, 51307.74346128246, 51332.0, 51380.74309628428, 53398.0, 53689.0, 53695.46304536983, 53764.0, 53792.73103634535, 11978.041756659446, 12266.877331226751, 12461.314627695383, 12466.314352710506, 12467.88302924269, 7962.08436029864, 8453.66185352579, 8498.830023399498, 8500.48997060166, 8523.445976011539, 13624.386902589407, 15510.457134000257, 16004.359825607078, 16112.113833739257, 16474.588135296475, 5332.200169974535, 5458.918116228259, 5460.754266058037, 5466.289382380344, 5478.945210547923, 772.4862966127462, 811.9106898241189, 852.7058164933088, 917.4266083697689, 919.2416256588341, 24905.750942490704, 26498.205053848415, 26942.461150776875, 27029.594556081676, 27156.592651110248, 931.2968708624945, 936.6066252174103, 940.5156344482597, 945.7351941456403, 994.8857279846474, 13417.262050587116, 14000.159990400609, 14436.566902992927, 14594.489192878198, 14690.63273418173, 115525.4223728876, 115761.0, 115763.0, 116291.0, 116753.41623291829, 40826.79586602107, 41497.377539336936, 45492.772536137105, 46073.53926460692, 46091.30863037057, 1079.3955384984433, 1091.4324551233315, 1107.5182295701395, 1109.0129784491808, 1118.2340097033557, 26296.21111366662, 27554.862225688743, 27614.0, 27924.0, 28298.0, 44103.0, 45470.31794523151, 49585.0, 49667.75166124146, 49980.250296244856, 337732.0, 339416.0, 339851.0, 340561.0, 341890.0, 23924.12910450757, 24057.75942240555, 24501.632475512524, 24521.0, 24556.50886982286, 39452.605473944895, 39468.60531394649, 39788.0, 39999.20001599893, 41026.17947640971, 34238.657613423544, 34278.14304642404, 34756.82621586876, 34796.65203347934, 34990.65009349976, 34169.31661366808, 34196.0, 34630.30739385248, 34653.82673086618, 34981.30037399289, 33187.66812331846, 33996.32007359889, 34078.48882266817, 34117.0, 34385.312293753486, 29629.0, 31151.84424077865, 31212.219694507818, 31367.21581960469, 31475.84262078675, 23824.40438989039, 24124.51750965006, 24323.75676243215, 24588.87705561461, 24709.382265443506], "value": 16408.421841699907, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.4230492772145, 358.61628057977975, 369.5270054330457, 369.92786406650697, 381.64316364199476, 12528.749425011494, 15539.844601553981, 15701.528954131365, 16731.83268167318, 16930.49208523743, 16275.430359937405, 16309.755353669674, 16512.917435412837, 16639.33442662292, 16668.33326666932, 3897.941530877039, 4917.090338287419, 5135.691858488484, 5164.612654050961, 5203.427622961472, 3663.358912190369, 3872.9225415491674, 5699.344575373823, 5977.850553736148, 5979.282486101674, 5833.649981001132, 6023.066424704178, 6026.8493287667725, 6032.125341825433, 6040.637561746309, 6018.097285407181, 6024.0662697282, 6051.273847138327, 6059.818205453844, 6074.362191969846, 4682.508336624639, 4961.975190124026, 5371.75827087782, 5374.113271310229, 5374.91937620936, 11915.344656043913, 12131.575394861138, 12138.15032947694, 12145.514179432812, 13137.934310328386, 1674.3972170018783, 1756.0780590190252, 1763.7266223735342, 1816.300724221171, 1968.980310196894, 8850.468971861708, 8878.156575125353, 9008.369414141012, 9021.684241051531, 9415.199708024826, 1701.2514493622891, 1743.1425289985154, 1745.8341457561512, 1763.206557049333, 1805.6749785038687, 64775.0, 64886.351136488505, 66185.66907165434, 66421.335786642, 67821.32178678199, 9846.212303015742, 9858.112769850748, 10111.59553617847, 10125.797484050277, 10156.4921753912, 13877.375518101508, 13878.306084695927, 13881.652958676113, 13888.722225555432, 13909.860901390857, 6415.101885736, 6561.40947314744, 6601.429247279738, 6731.394174524218, 6748.358905903931, 5792.739326730223, 5820.76716931318, 5967.1347654589845, 6075.0, 6088.786892458743, 4315.741055536615, 4320.157569273962, 4325.545817689161, 4428.867133985986, 4470.351798989193, 1608.5254849819098, 1685.7808484896884, 1739.4086010756403, 1758.7625670534314, 1821.0013512907155, 791.2404092071561, 803.1807556292665, 803.369355056278, 804.8430556041633, 826.7643721539332, 16131.919340403458, 16203.351865925466, 16253.59366015859, 16742.83257167437, 17016.744748828776, 819.8524265632243, 847.4957400346784, 848.3425345357274, 868.2055918834196, 912.7307444303814, 8596.570171491401, 9407.106324899261, 9430.669926552675, 9431.151196392357, 9506.144446999802, 335736.0, 336652.0, 338805.0, 344552.0, 345951.0, 73657.10557378978, 74033.0, 75242.24757752461, 76155.19594462868, 78018.0, 838.3209600223838, 875.4703404440222, 882.1122797214095, 884.0408157149436, 886.1050339157497, 14083.155010699391, 14498.637534061732, 14919.328630211883, 14925.46267134568, 14954.626134346729, 24192.153274635304, 24918.750812491642, 33070.83464582662, 35373.82313088418, 35604.82197588996, 46748.29877551908, 47406.28890566575, 47476.7626161867, 48136.27795582999, 49763.75118124386, 7132.251113632994, 7339.8532029360185, 7399.371053460516, 7465.44009199323, 7577.204393538599, 8144.5520496373265, 10624.787504250025, 10736.194785390971, 11013.118950483782, 11350.262232954832, 9283.72148835536, 9777.9022209777, 9812.411255324418, 9880.85178722334, 9928.354656947275, 9188.0, 9293.953530232306, 9479.47862867549, 9840.409575425498, 9883.406995580288, 7077.752278670222, 7583.0, 7814.101378341564, 9060.592273347584, 10515.05364517197, 10311.175105991353, 10363.378197308186, 10517.15862730995, 10823.458827058774, 11105.0, 9884.30809843304, 10505.264631475724, 10521.78956420852, 10663.520141593803, 10694.62568810088], "value": 7812.514003156604, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.3179762422353, 1341.4231880291475, 1410.9576712698615, 1607.0759313394801, 1650.1171873047922, 7066.858662826747, 7590.8861367079535, 7591.658375373115, 7592.12690540588, 7592.354649854762, 6279.403456671609, 6613.305602911697, 7054.118235220598, 7348.669309881055, 7359.264073592638, 2080.9479763005893, 2119.07820098257, 2121.416610432128, 2125.3836387447623, 2125.7555381131215, 2076.3044380132674, 2102.915883364671, 2172.022589834573, 2176.6517357222847, 2181.214762685432, 1795.9102044897768, 1856.9814301857011, 2037.2360364863177, 2111.7254756881584, 2112.2501511963264, 2076.09689784944, 2114.2177394364107, 2118.6821976703463, 2119.618468675638, 2120.257909731597, 2095.9790402095937, 2112.039022244875, 2118.3433135727973, 2126.128287402173, 2134.0503475953205, 7240.493165478419, 7316.122065352191, 7350.558966462029, 7380.704771809121, 7397.556146631219, 4422.579854913778, 4548.56788605082, 4561.452625684906, 4565.269556870918, 4568.132054909556, 2705.2019654201863, 2774.209350335165, 2886.4660037892845, 2909.345397285615, 2928.765698744117, 819.2749416766145, 865.7835541114721, 883.3198437203317, 895.5835536475505, 901.2069378946551, 9828.508574571242, 9905.504724763732, 9908.355956862853, 9944.353617014944, 9981.401115933068, 3856.2865869814173, 4030.9922519370157, 4132.049628585442, 4149.543550209474, 4194.2869712148395, 8683.0, 8713.695020674246, 8717.041125476193, 8718.17177368149, 8738.38831281817, 4533.705309154961, 4541.84103556374, 4542.31865220213, 4543.204939135638, 4545.0909818036525, 4053.5946405359227, 4057.350823868167, 4064.5935406459116, 4068.6541643960595, 4071.42999980003, 3153.1801731549963, 3183.697548732867, 3240.7569432292203, 3245.464498357792, 3263.5267886156375, 901.2474583722534, 906.7869050773063, 914.7713071732067, 918.7978644698155, 946.8201041802173, 644.3556443556444, 738.2322384719938, 827.3463963468793, 839.1147339556826, 861.814709837388, 5013.147764879979, 5115.667481613683, 5185.377754669388, 5212.592599997979, 5236.711980841014, 784.4626430894855, 792.8424500229614, 793.1196372027046, 835.1648351648352, 837.535167981776, 3306.669333066722, 3325.600927888669, 3387.2548039431285, 3415.624281329052, 3439.071450708295, 8649.135086491426, 8787.604557794915, 8904.154105359981, 8920.464772113693, 8923.598438070172, 8698.434601750865, 8847.203751662253, 8872.556372181365, 8909.10908909117, 8926.330525210635, 6737.124173857367, 6879.759208427681, 6884.105066341343, 6888.207856096513, 6914.861702765917, 5019.874503137451, 5077.882865769525, 5092.872678182927, 5119.436861945258, 5366.597505187048, 8219.506829590004, 8296.875546866922, 8312.0, 8429.0, 8492.363072769444, 8409.62156702962, 8555.743327700178, 8601.39790214679, 8619.396642234984, 8643.394962352575, 6042.607230530178, 6174.938250617616, 6176.4441200292185, 6263.96868015657, 6526.314736952551, 7233.0597022386755, 7349.448791340564, 7358.632068396666, 7361.8159546011775, 7366.226546212571, 6258.311585725475, 6275.811725648238, 6370.872582548416, 6447.645994341241, 6562.146920900444, 6135.539834512519, 6160.414760597736, 6166.414190651881, 6287.402696743802, 6357.205349331333, 5933.732982015906, 6036.33600303975, 6036.9094463582205, 6047.0627052806885, 6051.515878729603, 4350.260455722471, 4509.954900450954, 4520.34455004016, 4561.840335588238, 4565.817367305271, 4397.164538737629, 4453.242948698664, 4554.749488778149, 4567.680262381734, 4682.0869930364615], "value": 3922.844793453536, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.1701066905973, 288.99711002889967, 292.8082106220424, 294.1352423873811, 295.7028186672395, 4780.8804779880475, 4828.6721151683305, 4829.275608658699, 4913.413208357901, 4914.311996320518, 4554.94818471624, 4791.466730646194, 4798.328234047236, 4806.711597304165, 4854.8833768233235, 3651.827162838107, 3668.63313668633, 3743.0829446785574, 3792.2794669012937, 3813.1229817142075, 3779.225258821935, 3787.1668232988836, 3797.5632802227683, 3805.2009078093633, 3813.9976512330973, 3565.7682250653756, 3737.177820879402, 3775.528058992626, 3777.7544459610035, 3780.8676696315633, 3658.9268214635827, 3699.5190625218684, 3742.9625703742886, 3771.3211621908044, 3772.9056773580605, 3292.42382583047, 3302.2734998300334, 3308.2225676965895, 3321.78408403453, 3322.318924620447, 4672.556107169813, 4675.007994883277, 4677.228257337535, 4681.789319480597, 4685.5314468553215, 4094.754314741125, 4209.810558524843, 4217.177650358181, 4225.577442255781, 4244.151169766059, 4953.182724850395, 4978.05855716271, 4994.800207991676, 5001.949980500185, 5007.949920500785, 3613.168971136627, 3617.0, 3618.5657721073376, 3625.583057948343, 3632.146445585285, 5109.872253193663, 5166.9224961625605, 5281.894362112736, 5290.989424018887, 5299.54953828925, 3656.2321912398693, 3659.249853779969, 3663.157473781045, 3663.7435379523176, 3669.7247706422127, 3726.5341832270965, 3745.7752534847996, 3751.1934933989323, 3771.4908487353855, 3778.0, 4240.791374458265, 4244.617984381359, 4245.448091748053, 4272.829086836492, 4303.4190384298345, 4784.258439941815, 5006.749662516932, 5028.622853285945, 5040.218766091261, 5045.293658887758, 1225.5526732742485, 1234.919730217533, 1239.7520495900856, 1244.807054906491, 1246.8030690537005, 778.8247644279992, 788.6254029336134, 836.272442974616, 843.7848348671049, 847.7117779954845, 4206.221848957953, 4207.76857272853, 4211.820690206747, 4217.0, 4244.405783190356, 5057.064443078042, 5187.377514698261, 5199.29809475716, 5204.219367094966, 5238.711870847063, 4347.891302717458, 4452.710573812692, 4455.821767129343, 4462.464504259445, 4464.441944756905, 2636.1959602321094, 2645.232882464064, 2649.244965184913, 2650.893964241409, 2663.347479867406, 4633.976830115827, 4646.070785842845, 4660.673752837337, 4668.136394766979, 4687.695299805502, 5006.974965125151, 5146.794128234904, 5148.253503242009, 5149.6910185389, 5155.6391052626705, 4640.211164102111, 4654.208784506642, 4656.953430465652, 4661.184292748755, 4661.836835710734, 4936.8765780855765, 4951.331570237971, 4955.900881982412, 4988.900221995613, 5002.17464118431, 4858.441279252931, 4860.24666176729, 4864.464908860094, 4871.707697538159, 4903.485134060872, 4850.83022094225, 4871.0, 4882.365292512093, 4884.9511504884495, 4885.853424397274, 3572.4284114541547, 3590.8025058622025, 3598.784072955631, 3605.152789094508, 3614.7831130132276, 5097.490250974873, 5270.8155214567305, 5284.339457567804, 5289.57683385336, 5293.497117773805, 5031.949680503149, 5062.848114556569, 5072.416672082758, 5078.847634570969, 5092.159793634009, 5049.141645920129, 5054.4187418447345, 5072.0, 5074.644774865724, 5076.593872490266, 4816.590589799906, 4992.675476094042, 4996.7001979881325, 5024.0956627807345, 5027.4218464877, 4872.317875497504, 4985.775640096277, 4987.202047672355, 5056.963322518948, 5129.153689641167, 4944.145945270524, 4978.4523702393435, 4989.0, 4994.500549944976, 4994.9750251248515], "value": 3755.7747286011777, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.6047980491998, 662.2549631664381, 672.4754691340754, 678.3420082519954, 732.3482100930173, 11536.884631153685, 11791.115666325028, 11799.587014454495, 11813.822792658106, 11821.0, 11590.710232244199, 11653.184277100607, 11680.591179308705, 11693.0, 11770.705732356695, 608.595284136049, 624.9281332646735, 727.8435136445677, 739.9223081576438, 757.2427572427572, 753.638253638254, 754.2645920227761, 756.7427074794568, 758.8254701418649, 759.2407592407592, 806.0206848678854, 806.2542148512632, 807.229096213118, 807.6809660184224, 807.7536351412816, 648.5233353485185, 666.453508123339, 768.2317682317682, 792.3700657976922, 803.317180396664, 590.9290885093774, 591.1280860730432, 591.3967752892069, 591.7632946821263, 591.8224532640234, 12299.508019679202, 12320.199187052902, 12329.075319350995, 12332.81500777489, 12353.876461235363, 11223.607173748962, 11296.54813807455, 11342.432878356049, 11557.0, 11786.469608867621, 9283.25733941283, 9398.201152902011, 9626.566804493814, 9723.708288751279, 10847.728806779814, 3912.471816304791, 3923.941140882889, 3941.881743547698, 3981.880543583697, 4006.959930400688, 40928.59071409307, 45787.77106114481, 48338.5166148341, 49684.0, 49873.75063124698, 9229.215516681023, 9260.120288572574, 9294.44233345988, 9397.859032114524, 9441.103095205945, 15349.15579643108, 15731.68536629261, 15873.603159920864, 15930.840691593168, 15944.760828587581, 6180.81457556265, 6191.504679625619, 6225.28409232944, 6264.37356264379, 6354.682265886687, 3411.164264755101, 3535.4343305071066, 3538.2569660371096, 3581.552305961755, 3594.101474631342, 2704.986475067612, 2806.789490788158, 2807.6350074490188, 2814.183886672842, 2961.925951851221, 544.1375419959329, 547.8110052032042, 549.851540084175, 552.5110277404445, 570.1618620627671, 571.674145736926, 578.7511370110808, 583.4515555377931, 588.399832171183, 594.4145017158182, 6455.644939528277, 7583.544987300779, 7586.0, 7856.135825059239, 7944.9205507945335, 489.904468628614, 566.1168577019862, 570.3697414357158, 580.5674772294583, 585.8623223542464, 3696.5564132303757, 3762.2287431076566, 3794.753341032824, 3820.388737801994, 3993.820278087493, 68134.63730725358, 69094.3090569098, 69142.04866440424, 72938.63530682419, 73014.26985730181, 63550.36449635537, 63779.681101595124, 63789.681051594445, 63852.68073659695, 64078.6796066026, 44531.10937781226, 47054.0, 51557.74221128871, 51782.74108629433, 55842.0, 8273.958630206811, 8563.657453701782, 8612.698555550525, 8628.439151455135, 8663.95668021656, 33808.0, 33902.491462627586, 34328.313433730684, 34775.304493909476, 35353.292934140656, 42520.36219456772, 48191.5180848187, 49025.5097449021, 49202.0, 49262.75368623134, 10293.948530257301, 10489.160867130764, 10607.0, 10752.51613677402, 10779.568817247222, 11853.466594003117, 11940.402979851146, 11964.547267809903, 12157.513699451923, 12326.630201093982, 10527.578896844041, 10782.838257426301, 11152.0, 11243.494042767932, 11501.0, 11218.0, 11520.700477780314, 11651.592194273499, 11752.76494470123, 12036.097292703258, 11349.432528373713, 11420.771584568096, 11577.479013444246, 11884.702882428008, 11943.701407464883, 9396.906030939877, 9645.855312170463, 9705.369151005161, 9853.704388868346, 9946.24856687653, 8880.644774208959, 9127.58925848325, 9165.633374664938, 9172.587233574639, 9227.35408521424], "value": 6011.925546074036, "unit": "score"}], "name": "dromaeo_css", "value": 6107.146196129806, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 119.0, 116.0, 117.0, 118.0, 115.0, 115.0, 117.0, 114.0, 114.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 132.0, 136.0, 169.0, 133.0, 131.0, 131.0, 141.0, 161.0, 130.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 162.0, 163.0, 163.0, 163.0, 162.0, 165.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 110.0, 77.0, 77.0, 77.0, 76.0, 89.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 116.0, 83.0, 83.0, 83.0, 99.0, 83.0, 82.0, 119.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 65.0, 63.0, 65.0, 65.0, 65.0, 64.0, 68.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 67.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 89.0, 85.0, 84.0, 91.0, 84.0, 85.0, 85.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 148.0, 144.0, 143.0, 153.0, 140.0, 143.0, 151.0, 185.0, 138.0], "value": 150.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 187.0, 183.0, 180.0, 179.0, 179.0, 180.0, 179.0, 179.0], "value": 181.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 81.0, 70.0, 72.0, 69.0, 70.0, 70.0, 69.0, 69.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1571.8, "alertThreshold": 2.0}]} 20:39:56 INFO - Return code: 0 20:39:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:39:57 INFO - # TBPL SUCCESS # 20:39:57 INFO - Running post-action listener: _resource_record_post_action 20:39:57 INFO - [mozharness: 2016-11-24 04:39:57.047755Z] Finished run-tests step (success) 20:39:57 INFO - Running post-run listener: _resource_record_post_run 20:39:57 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391065600; Read time: 8; Write time: 221768 20:39:57 INFO - TinderboxPrint: CPU usage
13.1% 20:39:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 20:39:57 INFO - TinderboxPrint: I/O write bytes / time
391,065,600 / 221,768 20:39:57 INFO - TinderboxPrint: CPU idle
8,350.5 (86.9%) 20:39:57 INFO - TinderboxPrint: CPU user
1,207.0 (12.6%) 20:39:57 INFO - TinderboxPrint: Swap in / out
0 / 0 20:39:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99790848; Read time: 0; Write time: 76128 20:39:57 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291274752; Read time: 0; Write time: 145640 20:39:57 INFO - Running post-run listener: _upload_blobber_files 20:39:57 INFO - Blob upload gear active. 20:39:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:39:57 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 20:39:57 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:39:57 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:39:58 INFO - (blobuploader) - INFO - Open directory for files ... 20:39:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:39:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:39:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:39:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:39:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:39:58 INFO - (blobuploader) - INFO - Done attempting. 20:39:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:39:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:39:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:39:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:39:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:39:59 INFO - (blobuploader) - INFO - Done attempting. 20:39:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:39:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:39:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:40:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:40:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:40:02 INFO - (blobuploader) - INFO - Done attempting. 20:40:02 INFO - (blobuploader) - INFO - Iteration through files over. 20:40:02 INFO - Return code: 0 20:40:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:40:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:40:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/351ac6bd1068c47d34b587420b2a728a5ee69355a3cea55359f5097c91dadcdd7ef57add2b45c9820ee8d01cf6923bddacf3cf1427dbc2b19883f3f9d18ee52c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0398aabfc9244a1e5be58a3828bbd6ccd8b63feff76fcede0ed57508a53bb5326ee65368642bfebfa01c5f8cbaa8af68e87bfa022afb86fe0489ca5577a5bb72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f69c2cccfb95ae5d8e7d77bdc3ff82abedc0d84a7de6915152d72c820dd69e1b0f68750a864f722cdca0d4795d8508e447c01a4520596303139e771fc9198688"} 20:40:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:40:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:40:02 INFO - Contents: 20:40:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/351ac6bd1068c47d34b587420b2a728a5ee69355a3cea55359f5097c91dadcdd7ef57add2b45c9820ee8d01cf6923bddacf3cf1427dbc2b19883f3f9d18ee52c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0398aabfc9244a1e5be58a3828bbd6ccd8b63feff76fcede0ed57508a53bb5326ee65368642bfebfa01c5f8cbaa8af68e87bfa022afb86fe0489ca5577a5bb72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f69c2cccfb95ae5d8e7d77bdc3ff82abedc0d84a7de6915152d72c820dd69e1b0f68750a864f722cdca0d4795d8508e447c01a4520596303139e771fc9198688"} 20:40:02 INFO - Running post-run listener: copy_logs_to_upload_dir 20:40:02 INFO - Copying logs to upload dir... 20:40:02 INFO - mkdir: /builds/slave/test/build/upload/logs 20:40:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.176021 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-11-23 20:40:02.945119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 20:40:02.948690) ========= 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=0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/351ac6bd1068c47d34b587420b2a728a5ee69355a3cea55359f5097c91dadcdd7ef57add2b45c9820ee8d01cf6923bddacf3cf1427dbc2b19883f3f9d18ee52c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0398aabfc9244a1e5be58a3828bbd6ccd8b63feff76fcede0ed57508a53bb5326ee65368642bfebfa01c5f8cbaa8af68e87bfa022afb86fe0489ca5577a5bb72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f69c2cccfb95ae5d8e7d77bdc3ff82abedc0d84a7de6915152d72c820dd69e1b0f68750a864f722cdca0d4795d8508e447c01a4520596303139e771fc9198688"} build_url:https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/C2TjI7IdSpWlUgNxuZuh-g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/351ac6bd1068c47d34b587420b2a728a5ee69355a3cea55359f5097c91dadcdd7ef57add2b45c9820ee8d01cf6923bddacf3cf1427dbc2b19883f3f9d18ee52c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0398aabfc9244a1e5be58a3828bbd6ccd8b63feff76fcede0ed57508a53bb5326ee65368642bfebfa01c5f8cbaa8af68e87bfa022afb86fe0489ca5577a5bb72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f69c2cccfb95ae5d8e7d77bdc3ff82abedc0d84a7de6915152d72c820dd69e1b0f68750a864f722cdca0d4795d8508e447c01a4520596303139e771fc9198688"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 20:40:02.974087) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 20:40:02.974423) ========= 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=0e2a256762fed810e2f0f810000001b3-1479960889.784793-1027948188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 20:40:03.059048) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 20:40:03.059374) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 20:40:03.059644) ========= ========= Total master_lag: 0.16 =========