builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1480573335.99 results: success (0) buildid: 20161130203744 builduid: 6cb5d4e77cf7496da644ce4eee6d3e14 revision: 7c6afff0c35db7e480743d77da938e530bf4b4a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 22:22:15.987396) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 22:22:15.987851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 22:22:15.988127) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 22:22:16.004917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 22:22:16.005190) ========= 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=af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-30 22:22:16-- 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% 36.6M=0s 2016-11-30 22:22:16 (36.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136812 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 22:22:16.155836) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 22:22:16.156177) ========= 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=af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014001 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 22:22:16.206950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 22:22:16.207309) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 7c6afff0c35db7e480743d77da938e530bf4b4a5 --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 7c6afff0c35db7e480743d77da938e530bf4b4a5 --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=af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-30 22:22:16,540 truncating revision to first 12 chars 2016-11-30 22:22:16,540 Setting DEBUG logging. 2016-11-30 22:22:16,540 attempt 1/10 2016-11-30 22:22:16,540 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/7c6afff0c35d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-30 22:22:16,857 unpacking tar archive at: graphics-7c6afff0c35d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657039 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 22:22:16.876969) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 22:22:16.877334) ========= script_repo_revision: 7c6afff0c35db7e480743d77da938e530bf4b4a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 22:22:16.877807) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 22:22:16.878084) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 22:22:16.886205) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-11-30 22:22:16.886499) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:22:17 INFO - MultiFileLogger online at 20161130 22:22:17 in /builds/slave/test 22:22:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 22:22:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:22:17 INFO - {'append_to_log': False, 22:22:17 INFO - 'base_work_dir': '/builds/slave/test', 22:22:17 INFO - 'blob_upload_branch': 'Graphics', 22:22:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:22:17 INFO - 'branch': 'Graphics', 22:22:17 INFO - 'buildbot_json_path': 'buildprops.json', 22:22:17 INFO - 'config_files': ('talos/linux_config.py',), 22:22:17 INFO - 'default_actions': ('clobber', 22:22:17 INFO - 'read-buildbot-config', 22:22:17 INFO - 'download-and-extract', 22:22:17 INFO - 'populate-webroot', 22:22:17 INFO - 'create-virtualenv', 22:22:17 INFO - 'install', 22:22:17 INFO - 'run-tests'), 22:22:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:22:17 INFO - 'download_minidump_stackwalk': True, 22:22:17 INFO - 'download_symbols': 'ondemand', 22:22:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:22:17 INFO - 'tooltool.py': '/tools/tooltool.py', 22:22:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:22:17 INFO - '/tools/misc-python/virtualenv.py')}, 22:22:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:22:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:22:17 INFO - 'installer_path': 'installer.exe', 22:22:17 INFO - 'log_level': 'info', 22:22:17 INFO - 'log_name': 'talos', 22:22:17 INFO - 'log_to_console': True, 22:22:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:22:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:22:17 INFO - 'opt_config_files': (), 22:22:17 INFO - 'pip_index': False, 22:22:17 INFO - 'sps_profile': False, 22:22:17 INFO - 'sps_profile_interval': 0, 22:22:17 INFO - 'suite': 'dromaeojs-e10s', 22:22:17 INFO - 'system_bits': '32', 22:22:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:22:17 INFO - 'title': 'talos-linux64-ix-020', 22:22:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:22:17 INFO - 'use_talos_json': True, 22:22:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:22:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:22:17 INFO - 'work_dir': 'build'} 22:22:17 INFO - [mozharness: 2016-12-01 06:22:17.313959Z] Running clobber step. 22:22:17 INFO - Running pre-action listener: _resource_record_pre_action 22:22:17 INFO - Running main action method: clobber 22:22:17 INFO - rmtree: /builds/slave/test/build 22:22:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:22:17 INFO - Running post-action listener: _resource_record_post_action 22:22:17 INFO - [mozharness: 2016-12-01 06:22:17.778595Z] Finished clobber step (success) 22:22:17 INFO - [mozharness: 2016-12-01 06:22:17.778693Z] Running read-buildbot-config step. 22:22:17 INFO - Running pre-action listener: _resource_record_pre_action 22:22:17 INFO - Running main action method: read_buildbot_config 22:22:17 INFO - Using buildbot properties: 22:22:17 INFO - { 22:22:17 INFO - "project": "", 22:22:17 INFO - "product": "firefox", 22:22:17 INFO - "script_repo_revision": "default", 22:22:17 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 22:22:17 INFO - "repository": "", 22:22:17 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 22:22:17 INFO - "buildid": "20161130203744", 22:22:17 INFO - "pgo_build": "False", 22:22:17 INFO - "basedir": "/builds/slave/test", 22:22:17 INFO - "buildnumber": 25, 22:22:17 INFO - "slavename": "talos-linux64-ix-020", 22:22:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:22:17 INFO - "platform": "ubuntu64_hw", 22:22:17 INFO - "scheduler": "tests-graphics-linux64-talos-8-3600", 22:22:17 INFO - "branch": "graphics", 22:22:17 INFO - "repo_path": "projects/graphics", 22:22:17 INFO - "revision": "7c6afff0c35db7e480743d77da938e530bf4b4a5", 22:22:17 INFO - "stage_platform": "linux64", 22:22:17 INFO - "builduid": "6cb5d4e77cf7496da644ce4eee6d3e14", 22:22:17 INFO - "slavebuilddir": "test" 22:22:17 INFO - } 22:22:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 22:22:17 INFO - Running post-action listener: _resource_record_post_action 22:22:17 INFO - [mozharness: 2016-12-01 06:22:17.781093Z] Finished read-buildbot-config step (success) 22:22:17 INFO - [mozharness: 2016-12-01 06:22:17.781179Z] Running download-and-extract step. 22:22:17 INFO - Running pre-action listener: _resource_record_pre_action 22:22:17 INFO - Running main action method: download_and_extract 22:22:17 INFO - mkdir: /builds/slave/test/build/tests 22:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:17 INFO - trying https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:22:17 INFO - Downloading https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/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 22:22:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/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 22:22:18 INFO - Downloaded 1361 bytes. 22:22:18 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:22:18 INFO - Using the following test package requirements: 22:22:18 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 22:22:18 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:22:18 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:22:18 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:18 INFO - u'jsshell-linux-x86_64.zip'], 22:22:18 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:22:18 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 22:22:18 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:22:18 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:22:18 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:22:18 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:22:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:22:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 22:22:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:22:18 INFO - Fetch https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:22:18 INFO - Http code: 200 22:22:18 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 22:22:18 INFO - x-amz-cf-id: R4sVNNKfu2JjxHEoaK2Ce_-74eyUIhUEGxzYp5bV0iSxnGXrgGMvrQ== 22:22:18 INFO - x-amz-version-id: 7u9zQsFFKacz3q5SyxS16sH0XBipdfQS 22:22:19 INFO - Expected file size: 20218017 22:22:19 INFO - Obtained file size: 20218017 22:22:23 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 22:22:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 22:22:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:22:23 INFO - Fetch https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:22:23 INFO - Http code: 200 22:22:23 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 22:22:23 INFO - x-amz-cf-id: fBlVmwzar50p1nWbyRv-CrchqJffCtQqXeJu9KhsILwGuqPDdmXkoQ== 22:22:23 INFO - x-amz-version-id: 7u9zQsFFKacz3q5SyxS16sH0XBipdfQS 22:22:23 INFO - Expected file size: 20218017 22:22:23 INFO - Obtained file size: 20218017 22:22:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 22:22:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:22:28 INFO - Fetch https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:22:28 INFO - Http code: 200 22:22:28 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 22:22:28 INFO - x-amz-cf-id: K5oi643ko-WmfZvGaFaF7HJCQ8Z-PkAZNLpR9WFmssdxNstFjN5_Og== 22:22:28 INFO - x-amz-version-id: sUuCXnj4wZoMAnUQwgKw530rTTKW0HIM 22:22:28 INFO - Expected file size: 14409702 22:22:28 INFO - Obtained file size: 14409702 22:22:29 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')]} 22:22:29 INFO - trying https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:22:29 INFO - Downloading https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/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 22:22:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/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 22:22:30 INFO - Downloaded 55687664 bytes. 22:22:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:22:30 INFO - mkdir: /builds/slave/test/properties 22:22:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:22:30 INFO - Writing to file /builds/slave/test/properties/build_url 22:22:30 INFO - Contents: 22:22:30 INFO - build_url:https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:22:30 INFO - Running post-action listener: _resource_record_post_action 22:22:30 INFO - Running post-action listener: set_extra_try_arguments 22:22:30 INFO - [mozharness: 2016-12-01 06:22:30.960151Z] Finished download-and-extract step (success) 22:22:30 INFO - [mozharness: 2016-12-01 06:22:30.960376Z] Running populate-webroot step. 22:22:30 INFO - Running pre-action listener: _resource_record_pre_action 22:22:30 INFO - Running main action method: populate_webroot 22:22:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:22:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:22:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:22:30 INFO - '--tppagecycles', 22:22:30 INFO - '7'], 22:22:30 INFO - 'tests': ['tsvgm']}}, 22:22:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:22:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:22:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:22:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:22:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:22:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:22:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:22:30 INFO - 'talos_options': ['--disable-e10s'], 22:22:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:22:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:22:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:22:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:22:30 INFO - 'talos_options': ['--disable-e10s'], 22:22:30 INFO - 'tests': ['damp', 'tps']}, 22:22:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:22:30 INFO - 'tests': ['damp', 'tps']}, 22:22:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:22:30 INFO - 'tests': ['dromaeo_dom']}, 22:22:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:22:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:22:30 INFO - 'tests': ['basic_compositor_video']}, 22:22:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:22:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:22:30 INFO - 'tests': ['a11yr', 22:22:30 INFO - 'ts_paint', 22:22:30 INFO - 'tpaint', 22:22:30 INFO - 'sessionrestore', 22:22:30 INFO - 'sessionrestore_no_auto_restore', 22:22:30 INFO - 'tabpaint']}, 22:22:30 INFO - 'other-e10s': {'tests': ['a11yr', 22:22:30 INFO - 'ts_paint', 22:22:30 INFO - 'tpaint', 22:22:30 INFO - 'sessionrestore', 22:22:30 INFO - 'sessionrestore_no_auto_restore', 22:22:30 INFO - 'tabpaint']}, 22:22:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:22:30 INFO - 'ts_paint', 22:22:30 INFO - 'tpaint', 22:22:30 INFO - 'sessionrestore', 22:22:30 INFO - 'sessionrestore_no_auto_restore', 22:22:30 INFO - 'tabpaint']}, 22:22:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:22:30 INFO - 'ts_paint', 22:22:30 INFO - 'tpaint', 22:22:30 INFO - 'sessionrestore', 22:22:30 INFO - 'sessionrestore_no_auto_restore', 22:22:30 INFO - 'tabpaint']}, 22:22:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:22:30 INFO - 'tests': ['a11yr', 22:22:30 INFO - 'ts_paint', 22:22:30 INFO - 'tpaint', 22:22:30 INFO - 'sessionrestore', 22:22:30 INFO - 'sessionrestore_no_auto_restore', 22:22:30 INFO - 'tabpaint']}, 22:22:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:22:30 INFO - 'tests': ['a11yr', 22:22:30 INFO - 'ts_paint', 22:22:30 INFO - 'tpaint', 22:22:30 INFO - 'sessionrestore', 22:22:30 INFO - 'sessionrestore_no_auto_restore', 22:22:30 INFO - 'tabpaint']}, 22:22:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:22:30 INFO - 'tests': ['tsvgx', 22:22:30 INFO - 'tsvgr_opacity', 22:22:30 INFO - 'tart', 22:22:30 INFO - 'tscrollx', 22:22:30 INFO - 'cart', 22:22:30 INFO - 'tsvg_static']}, 22:22:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:22:30 INFO - 'tsvgr_opacity', 22:22:30 INFO - 'tart', 22:22:30 INFO - 'tscrollx', 22:22:30 INFO - 'cart', 22:22:30 INFO - 'tsvg_static']}, 22:22:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:22:30 INFO - 'talos_options': ['--disable-e10s'], 22:22:30 INFO - 'tests': ['tp5o']}, 22:22:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:22:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:22:30 INFO - 'talos_options': ['--disable-e10s', 22:22:30 INFO - '--xperf_path', 22:22:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:22:30 INFO - 'tests': ['tp5n']}, 22:22:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:22:30 INFO - 'talos_options': ['--xperf_path', 22:22:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:22:30 INFO - 'tests': ['tp5n']}}, 22:22:30 INFO - 'talos.zip': {'path': '', 22:22:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:22:30 INFO - Running post-action listener: _resource_record_post_action 22:22:30 INFO - [mozharness: 2016-12-01 06:22:30.976702Z] Finished populate-webroot step (success) 22:22:30 INFO - [mozharness: 2016-12-01 06:22:30.976789Z] Running create-virtualenv step. 22:22:30 INFO - Running pre-action listener: _resource_record_pre_action 22:22:30 INFO - Running main action method: create_virtualenv 22:22:30 INFO - Creating virtualenv /builds/slave/test/build/venv 22:22:30 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 22:22:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:22:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:22:31 INFO - Using real prefix '/usr' 22:22:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:22:31 INFO - Installing distribute.............................................................................................................................................................................................done. 22:22:33 INFO - Installing pip.................done. 22:22:33 INFO - Return code: 0 22:22:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:22:33 INFO - Reading from file tmpfile_stdout 22:22:33 INFO - Output received: 22:22:33 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) 22:22:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:22:33 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')]} 22:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:33 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')]} 22:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:33 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 0x7fad9453de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a93130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b21fc0>, '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 0x2b22ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b23350>, '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': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', '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 22:22:33 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 22:22:33 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 22:22:33 INFO - Using env: {'DISPLAY': ':0', 22:22:33 INFO - 'HOME': '/home/cltbld', 22:22:33 INFO - 'LANG': 'en_US.UTF-8', 22:22:33 INFO - 'LANGUAGE': 'en_US:en', 22:22:33 INFO - 'LOGNAME': 'cltbld', 22:22:33 INFO - 'MAIL': '/var/mail/cltbld', 22:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:33 INFO - 'MOZ_NO_REMOTE': '1', 22:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:33 INFO - 'NO_EM_RESTART': '1', 22:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:33 INFO - 'PWD': '/builds/slave/test', 22:22:33 INFO - 'SHELL': '/bin/bash', 22:22:33 INFO - 'SHLVL': '1', 22:22:33 INFO - 'TERM': 'linux', 22:22:33 INFO - 'TMOUT': '86400', 22:22:33 INFO - 'USER': 'cltbld', 22:22:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', 22:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:33 INFO - '_': '/tools/buildbot/bin/python'} 22:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:33 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 22:22:33 INFO - Cleaning up... 22:22:33 INFO - Return code: 0 22:22:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:22:33 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')]} 22:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:33 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')]} 22:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:33 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 0x7fad9453de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a93130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b21fc0>, '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 0x2b22ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b23350>, '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': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', '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 22:22:33 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 22:22:33 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 22:22:33 INFO - Using env: {'DISPLAY': ':0', 22:22:33 INFO - 'HOME': '/home/cltbld', 22:22:33 INFO - 'LANG': 'en_US.UTF-8', 22:22:33 INFO - 'LANGUAGE': 'en_US:en', 22:22:33 INFO - 'LOGNAME': 'cltbld', 22:22:33 INFO - 'MAIL': '/var/mail/cltbld', 22:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:33 INFO - 'MOZ_NO_REMOTE': '1', 22:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:33 INFO - 'NO_EM_RESTART': '1', 22:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:33 INFO - 'PWD': '/builds/slave/test', 22:22:33 INFO - 'SHELL': '/bin/bash', 22:22:33 INFO - 'SHLVL': '1', 22:22:33 INFO - 'TERM': 'linux', 22:22:33 INFO - 'TMOUT': '86400', 22:22:33 INFO - 'USER': 'cltbld', 22:22:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', 22:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:33 INFO - '_': '/tools/buildbot/bin/python'} 22:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:34 INFO - Downloading/unpacking psutil>=3.1.1 22:22:34 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 22:22:34 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 22:22:34 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 22:22:34 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 22:22:34 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 22:22:34 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 22:22:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:22:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:22:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:22:36 INFO - Installing collected packages: psutil 22:22:36 INFO - Running setup.py install for psutil 22:22:36 INFO - building 'psutil._psutil_linux' extension 22:22:36 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 22:22:36 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 22:22:36 INFO - building 'psutil._psutil_posix' extension 22:22:36 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 22:22:36 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 22:22:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:22:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:22:36 INFO - Successfully installed psutil 22:22:36 INFO - Cleaning up... 22:22:36 INFO - Return code: 0 22:22:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:22:36 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')]} 22:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:36 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')]} 22:22:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:36 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 0x7fad9453de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a93130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b21fc0>, '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 0x2b22ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b23350>, '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': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', '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 22:22:36 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 22:22:36 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 22:22:36 INFO - Using env: {'DISPLAY': ':0', 22:22:36 INFO - 'HOME': '/home/cltbld', 22:22:36 INFO - 'LANG': 'en_US.UTF-8', 22:22:36 INFO - 'LANGUAGE': 'en_US:en', 22:22:36 INFO - 'LOGNAME': 'cltbld', 22:22:36 INFO - 'MAIL': '/var/mail/cltbld', 22:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:36 INFO - 'MOZ_NO_REMOTE': '1', 22:22:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:36 INFO - 'NO_EM_RESTART': '1', 22:22:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:36 INFO - 'PWD': '/builds/slave/test', 22:22:36 INFO - 'SHELL': '/bin/bash', 22:22:36 INFO - 'SHLVL': '1', 22:22:36 INFO - 'TERM': 'linux', 22:22:36 INFO - 'TMOUT': '86400', 22:22:36 INFO - 'USER': 'cltbld', 22:22:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', 22:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:36 INFO - '_': '/tools/buildbot/bin/python'} 22:22:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:22:37 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 22:22:37 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 22:22:37 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 22:22:37 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 22:22:37 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 22:22:37 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 22:22:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:22:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:22:39 INFO - Installing collected packages: mozsystemmonitor 22:22:39 INFO - Running setup.py install for mozsystemmonitor 22:22:39 INFO - Successfully installed mozsystemmonitor 22:22:39 INFO - Cleaning up... 22:22:39 INFO - Return code: 0 22:22:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:22:39 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')]} 22:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:39 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')]} 22:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:39 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 0x7fad9453de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a93130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b21fc0>, '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 0x2b22ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b23350>, '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': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', '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 22:22:39 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 22:22:39 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 22:22:39 INFO - Using env: {'DISPLAY': ':0', 22:22:39 INFO - 'HOME': '/home/cltbld', 22:22:39 INFO - 'LANG': 'en_US.UTF-8', 22:22:39 INFO - 'LANGUAGE': 'en_US:en', 22:22:39 INFO - 'LOGNAME': 'cltbld', 22:22:39 INFO - 'MAIL': '/var/mail/cltbld', 22:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:39 INFO - 'MOZ_NO_REMOTE': '1', 22:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:39 INFO - 'NO_EM_RESTART': '1', 22:22:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:39 INFO - 'PWD': '/builds/slave/test', 22:22:39 INFO - 'SHELL': '/bin/bash', 22:22:39 INFO - 'SHLVL': '1', 22:22:39 INFO - 'TERM': 'linux', 22:22:39 INFO - 'TMOUT': '86400', 22:22:39 INFO - 'USER': 'cltbld', 22:22:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', 22:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:39 INFO - '_': '/tools/buildbot/bin/python'} 22:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:39 INFO - Downloading/unpacking jsonschema==2.5.1 22:22:39 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 22:22:39 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 22:22:39 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 22:22:39 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 22:22:39 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 22:22:39 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 22:22:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:22:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:22: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 22:22: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 22:22: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 22:22: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 22:22: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 22:22: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 22:22:41 INFO - Downloading functools32-3.2.3-2.tar.gz 22:22:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:22:41 INFO - warning: no files found matching '*.txt' 22:22:41 INFO - no previously-included directories found matching 'build' 22:22:41 INFO - no previously-included directories found matching 'dist' 22:22:41 INFO - no previously-included directories found matching '.git*' 22:22:41 INFO - Installing collected packages: jsonschema, functools32 22:22:41 INFO - Running setup.py install for functools32 22:22:41 INFO - warning: no files found matching '*.txt' 22:22:41 INFO - no previously-included directories found matching 'build' 22:22:41 INFO - no previously-included directories found matching 'dist' 22:22:41 INFO - no previously-included directories found matching '.git*' 22:22:41 INFO - Successfully installed jsonschema functools32 22:22:41 INFO - Cleaning up... 22:22:41 INFO - Return code: 0 22:22:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:22: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')]} 22:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22: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')]} 22:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22: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', '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 0x7fad9453de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a93130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b21fc0>, '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 0x2b22ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b23350>, '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': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', '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 22:22: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:22: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 functools32==3.2.3-2 22:22:41 INFO - Using env: {'DISPLAY': ':0', 22:22:41 INFO - 'HOME': '/home/cltbld', 22:22:41 INFO - 'LANG': 'en_US.UTF-8', 22:22:41 INFO - 'LANGUAGE': 'en_US:en', 22:22:41 INFO - 'LOGNAME': 'cltbld', 22:22:41 INFO - 'MAIL': '/var/mail/cltbld', 22:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:41 INFO - 'MOZ_NO_REMOTE': '1', 22:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:41 INFO - 'NO_EM_RESTART': '1', 22:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:41 INFO - 'PWD': '/builds/slave/test', 22:22:41 INFO - 'SHELL': '/bin/bash', 22:22:41 INFO - 'SHLVL': '1', 22:22:41 INFO - 'TERM': 'linux', 22:22:41 INFO - 'TMOUT': '86400', 22:22:41 INFO - 'USER': 'cltbld', 22:22:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', 22:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:41 INFO - '_': '/tools/buildbot/bin/python'} 22:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:22:42 INFO - Cleaning up... 22:22:42 INFO - Return code: 0 22:22:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:42 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 0x7fad9453de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a93130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b21fc0>, '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 0x2b22ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b23350>, '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': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', '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 22:22:42 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 22:22:42 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 22:22:42 INFO - Using env: {'DISPLAY': ':0', 22:22:42 INFO - 'HOME': '/home/cltbld', 22:22:42 INFO - 'LANG': 'en_US.UTF-8', 22:22:42 INFO - 'LANGUAGE': 'en_US:en', 22:22:42 INFO - 'LOGNAME': 'cltbld', 22:22:42 INFO - 'MAIL': '/var/mail/cltbld', 22:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:42 INFO - 'MOZ_NO_REMOTE': '1', 22:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:42 INFO - 'NO_EM_RESTART': '1', 22:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:42 INFO - 'PWD': '/builds/slave/test', 22:22:42 INFO - 'SHELL': '/bin/bash', 22:22:42 INFO - 'SHLVL': '1', 22:22:42 INFO - 'TERM': 'linux', 22:22:42 INFO - 'TMOUT': '86400', 22:22:42 INFO - 'USER': 'cltbld', 22:22:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', 22:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:42 INFO - '_': '/tools/buildbot/bin/python'} 22:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:42 INFO - Downloading/unpacking blobuploader==1.2.4 22:22:42 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 22:22:42 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 22:22:42 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 22:22:42 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 22:22:42 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 22:22:42 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 22:22:44 INFO - Downloading blobuploader-1.2.4.tar.gz 22:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:22:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:22:44 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 22:22:44 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 22:22:44 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 22:22:44 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 22:22:44 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 22:22:44 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 22:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:22:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:22:44 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 22:22:44 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 22:22:44 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 22:22:44 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 22:22:44 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 22:22:44 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 22:22:45 INFO - Downloading docopt-0.6.1.tar.gz 22:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:22:45 INFO - Installing collected packages: blobuploader, requests, docopt 22:22:45 INFO - Running setup.py install for blobuploader 22:22:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:22:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:22:45 INFO - Running setup.py install for requests 22:22:45 INFO - Running setup.py install for docopt 22:22:45 INFO - Successfully installed blobuploader requests docopt 22:22:45 INFO - Cleaning up... 22:22:45 INFO - Return code: 0 22:22:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:22:45 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')]} 22:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:45 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')]} 22:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:45 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 0x7fad9453de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a93130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b21fc0>, '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 0x2b22ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b23350>, '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': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', '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 22:22:45 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 22:22:45 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 22:22:45 INFO - Using env: {'DISPLAY': ':0', 22:22:45 INFO - 'HOME': '/home/cltbld', 22:22:45 INFO - 'LANG': 'en_US.UTF-8', 22:22:45 INFO - 'LANGUAGE': 'en_US:en', 22:22:45 INFO - 'LOGNAME': 'cltbld', 22:22:45 INFO - 'MAIL': '/var/mail/cltbld', 22:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:45 INFO - 'MOZ_NO_REMOTE': '1', 22:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:45 INFO - 'NO_EM_RESTART': '1', 22:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:45 INFO - 'PWD': '/builds/slave/test', 22:22:45 INFO - 'SHELL': '/bin/bash', 22:22:45 INFO - 'SHLVL': '1', 22:22:45 INFO - 'TERM': 'linux', 22:22:45 INFO - 'TMOUT': '86400', 22:22:45 INFO - 'USER': 'cltbld', 22:22:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', 22:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:45 INFO - '_': '/tools/buildbot/bin/python'} 22:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:22:45 INFO - Running setup.py (path:/tmp/pip-60hzkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:22:45 INFO - Running setup.py (path:/tmp/pip-T1M_OS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:22:46 INFO - Running setup.py (path:/tmp/pip-xcJsQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:22:46 INFO - Running setup.py (path:/tmp/pip-oszbTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:22:46 INFO - Running setup.py (path:/tmp/pip-RZkbil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:22:46 INFO - Running setup.py (path:/tmp/pip-gTJwOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:22:46 INFO - Running setup.py (path:/tmp/pip-0tv9LT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:22:46 INFO - Running setup.py (path:/tmp/pip-kv7x3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:22:46 INFO - Running setup.py (path:/tmp/pip-INHDJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:22:46 INFO - Running setup.py (path:/tmp/pip-lwmdMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:22:46 INFO - Running setup.py (path:/tmp/pip-RnRt7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:22:46 INFO - Running setup.py (path:/tmp/pip-oLxuTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:22:46 INFO - Running setup.py (path:/tmp/pip-JQR_tD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:22:46 INFO - Running setup.py (path:/tmp/pip-88CyI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:46 INFO - Running setup.py (path:/tmp/pip-VyhuLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:22:47 INFO - Running setup.py (path:/tmp/pip-e1Qz18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:22:47 INFO - Running setup.py (path:/tmp/pip-w6zufT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:22:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:22:47 INFO - Running setup.py install for manifestparser 22:22:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:22:47 INFO - Running setup.py install for mozcrash 22:22:47 INFO - Running setup.py install for mozdebug 22:22:47 INFO - Running setup.py install for mozdevice 22:22:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:22:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:22:47 INFO - Running setup.py install for mozfile 22:22:47 INFO - Running setup.py install for mozhttpd 22:22:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:22:47 INFO - Running setup.py install for mozinfo 22:22:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:22:47 INFO - Running setup.py install for mozInstall 22:22:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:22:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:22:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:22:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:22:47 INFO - Running setup.py install for mozleak 22:22:48 INFO - Running setup.py install for mozlog 22:22:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:22:48 INFO - Running setup.py install for moznetwork 22:22:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:22:48 INFO - Running setup.py install for mozprocess 22:22:48 INFO - Running setup.py install for mozprofile 22:22:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:22:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:22:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:22:48 INFO - Running setup.py install for mozrunner 22:22:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:22:48 INFO - Running setup.py install for mozscreenshot 22:22:48 INFO - Running setup.py install for moztest 22:22:48 INFO - Running setup.py install for mozversion 22:22:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:22:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:22:48 INFO - Cleaning up... 22:22:48 INFO - Return code: 0 22:22:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:48 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 0x7fad9453de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a93130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b21fc0>, '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 0x2b22ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b23350>, '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': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', '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 22:22:48 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 22:22:48 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 22:22:48 INFO - Using env: {'DISPLAY': ':0', 22:22:48 INFO - 'HOME': '/home/cltbld', 22:22:48 INFO - 'LANG': 'en_US.UTF-8', 22:22:48 INFO - 'LANGUAGE': 'en_US:en', 22:22:48 INFO - 'LOGNAME': 'cltbld', 22:22:48 INFO - 'MAIL': '/var/mail/cltbld', 22:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:48 INFO - 'MOZ_NO_REMOTE': '1', 22:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:48 INFO - 'NO_EM_RESTART': '1', 22:22:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:48 INFO - 'PWD': '/builds/slave/test', 22:22:48 INFO - 'SHELL': '/bin/bash', 22:22:48 INFO - 'SHLVL': '1', 22:22:48 INFO - 'TERM': 'linux', 22:22:48 INFO - 'TMOUT': '86400', 22:22:48 INFO - 'USER': 'cltbld', 22:22:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', 22:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:48 INFO - '_': '/tools/buildbot/bin/python'} 22:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:22:49 INFO - Running setup.py (path:/tmp/pip-N5p2g3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:22:49 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)) 22:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:22:49 INFO - Running setup.py (path:/tmp/pip-WLMvkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:22:49 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)) 22:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:22:49 INFO - Running setup.py (path:/tmp/pip-dx6mya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:22:49 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)) 22:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:22:49 INFO - Running setup.py (path:/tmp/pip-RYOOK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:22:49 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)) 22:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:22:49 INFO - Running setup.py (path:/tmp/pip-vAisgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:22:49 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)) 22:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:22:49 INFO - Running setup.py (path:/tmp/pip-W2wVgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:22:49 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)) 22:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:22:49 INFO - Running setup.py (path:/tmp/pip-X7ecr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:22:49 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)) 22:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:22:49 INFO - Running setup.py (path:/tmp/pip-aEvS4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:22:49 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)) 22:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:22:49 INFO - Running setup.py (path:/tmp/pip-bEUp5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:22:49 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)) 22:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:22:49 INFO - Running setup.py (path:/tmp/pip-A5ATrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:22:49 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)) 22:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:22:49 INFO - Running setup.py (path:/tmp/pip-H6J_5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:22:49 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)) 22:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:22:49 INFO - Running setup.py (path:/tmp/pip-riRgJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:22:50 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)) 22:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:22:50 INFO - Running setup.py (path:/tmp/pip-SQM87Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:22:50 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)) 22:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:22:50 INFO - Running setup.py (path:/tmp/pip-ffjUHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:22:50 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)) 22:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:50 INFO - Running setup.py (path:/tmp/pip-jqd3FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:50 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)) 22:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:22:50 INFO - Running setup.py (path:/tmp/pip-bICf2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:22:50 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)) 22:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:22:50 INFO - Running setup.py (path:/tmp/pip-rWxPr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:22:50 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)) 22:22:50 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)) 22:22:50 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)) 22:22:50 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)) 22:22:50 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)) 22:22:50 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)) 22:22:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:22:50 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 22:22:50 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 22:22:50 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 22:22:50 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 22:22:50 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 22:22:50 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 22:22:52 INFO - Downloading blessings-1.6.tar.gz 22:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:22:52 INFO - Installing collected packages: blessings 22:22:52 INFO - Running setup.py install for blessings 22:22:52 INFO - Successfully installed blessings 22:22:52 INFO - Cleaning up... 22:22:52 INFO - Return code: 0 22:22:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:22:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:22:52 INFO - Reading from file tmpfile_stdout 22:22:52 INFO - Current package versions: 22:22:52 INFO - argparse == 1.2.1 22:22:52 INFO - blessings == 1.6 22:22:52 INFO - blobuploader == 1.2.4 22:22:52 INFO - docopt == 0.6.1 22:22:52 INFO - functools32 == 3.2.3-2 22:22:52 INFO - jsonschema == 2.5.1 22:22:52 INFO - manifestparser == 1.1 22:22:52 INFO - mozInstall == 1.12 22:22:52 INFO - mozcrash == 1.0 22:22:52 INFO - mozdebug == 0.1 22:22:52 INFO - mozdevice == 0.49 22:22:52 INFO - mozfile == 1.2 22:22:52 INFO - mozhttpd == 0.7 22:22:52 INFO - mozinfo == 0.9 22:22:52 INFO - mozleak == 0.1 22:22:52 INFO - mozlog == 3.4 22:22:52 INFO - moznetwork == 0.27 22:22:52 INFO - mozprocess == 0.23 22:22:52 INFO - mozprofile == 0.28 22:22:52 INFO - mozrunner == 6.13 22:22:52 INFO - mozscreenshot == 0.1 22:22:52 INFO - mozsystemmonitor == 0.3 22:22:52 INFO - moztest == 0.7 22:22:52 INFO - mozversion == 1.4 22:22:52 INFO - psutil == 3.1.1 22:22:52 INFO - requests == 1.2.3 22:22:52 INFO - wsgiref == 0.1.2 22:22:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:52 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 0x7fad9453de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a93130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b21fc0>, '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 0x2b22ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b23350>, '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': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', '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 22:22:52 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 22:22:52 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 22:22:52 INFO - Using env: {'DISPLAY': ':0', 22:22:52 INFO - 'HOME': '/home/cltbld', 22:22:52 INFO - 'LANG': 'en_US.UTF-8', 22:22:52 INFO - 'LANGUAGE': 'en_US:en', 22:22:52 INFO - 'LOGNAME': 'cltbld', 22:22:52 INFO - 'MAIL': '/var/mail/cltbld', 22:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:52 INFO - 'MOZ_NO_REMOTE': '1', 22:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:52 INFO - 'NO_EM_RESTART': '1', 22:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:52 INFO - 'PWD': '/builds/slave/test', 22:22:52 INFO - 'SHELL': '/bin/bash', 22:22:52 INFO - 'SHLVL': '1', 22:22:52 INFO - 'TERM': 'linux', 22:22:52 INFO - 'TMOUT': '86400', 22:22:52 INFO - 'USER': 'cltbld', 22:22:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', 22:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:52 INFO - '_': '/tools/buildbot/bin/python'} 22:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:53 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)) 22:22:53 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)) 22:22:53 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)) 22:22:53 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)) 22:22:53 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)) 22:22:53 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)) 22:22:53 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)) 22:22:53 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)) 22:22:53 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)) 22:22:53 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)) 22:22:53 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)) 22:22:53 INFO - Cleaning up... 22:22:53 INFO - Return code: 0 22:22:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:22:53 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')]} 22:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:53 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')]} 22:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:53 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 0x7fad9453de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a93130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b21fc0>, '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 0x2b22ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b23350>, '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': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', '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 22:22:53 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 22:22:53 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 22:22:53 INFO - Using env: {'DISPLAY': ':0', 22:22:53 INFO - 'HOME': '/home/cltbld', 22:22:53 INFO - 'LANG': 'en_US.UTF-8', 22:22:53 INFO - 'LANGUAGE': 'en_US:en', 22:22:53 INFO - 'LOGNAME': 'cltbld', 22:22:53 INFO - 'MAIL': '/var/mail/cltbld', 22:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:53 INFO - 'MOZ_NO_REMOTE': '1', 22:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:53 INFO - 'NO_EM_RESTART': '1', 22:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:53 INFO - 'PWD': '/builds/slave/test', 22:22:53 INFO - 'SHELL': '/bin/bash', 22:22:53 INFO - 'SHLVL': '1', 22:22:53 INFO - 'TERM': 'linux', 22:22:53 INFO - 'TMOUT': '86400', 22:22:53 INFO - 'USER': 'cltbld', 22:22:53 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', 22:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:53 INFO - '_': '/tools/buildbot/bin/python'} 22:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:22:53 INFO - Cleaning up... 22:22:53 INFO - Return code: 0 22:22:53 INFO - Running post-action listener: _resource_record_post_action 22:22:53 INFO - Running post-action listener: _start_resource_monitoring 22:22:53 INFO - Starting resource monitoring. 22:22:53 INFO - [mozharness: 2016-12-01 06:22:53.394946Z] Finished create-virtualenv step (success) 22:22:53 INFO - [mozharness: 2016-12-01 06:22:53.395429Z] Running install step. 22:22:53 INFO - Running pre-action listener: _resource_record_pre_action 22:22:53 INFO - Running main action method: install 22:22:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:22:53 INFO - Reading from file tmpfile_stdout 22:22:53 INFO - Detecting whether we're running mozinstall >=1.0... 22:22:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:22:53 INFO - Reading from file tmpfile_stdout 22:22:53 INFO - Output received: 22:22:53 INFO - Usage: mozinstall [options] installer 22:22:53 INFO - Options: 22:22:53 INFO - -h, --help show this help message and exit 22:22:53 INFO - -d DEST, --destination=DEST 22:22:53 INFO - Directory to install application into. [default: 22:22:53 INFO - "/builds/slave/test"] 22:22:53 INFO - --app=APP Application being installed. [default: firefox] 22:22:53 INFO - mkdir: /builds/slave/test/build/application 22:22:53 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'] 22:22:53 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 22:23:09 INFO - Reading from file tmpfile_stdout 22:23:09 INFO - Output received: 22:23:09 INFO - /builds/slave/test/build/application/firefox/firefox 22:23:09 INFO - Running post-action listener: _resource_record_post_action 22:23:09 INFO - [mozharness: 2016-12-01 06:23:09.750483Z] Finished install step (success) 22:23:09 INFO - [mozharness: 2016-12-01 06:23:09.750723Z] Running run-tests step. 22:23:09 INFO - Running pre-action listener: _resource_record_pre_action 22:23:09 INFO - Running main action method: run_tests 22:23:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:23:09 INFO - Python 2.7.3 22:23:09 INFO - Return code: 0 22:23:09 INFO - grabbing minidump binary from tooltool 22:23:09 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')]} 22:23:09 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 0x2b21fc0>, '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 0x2b22ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b23350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:23:09 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 22:23:09 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 22:23:09 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 22:23:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:23:09 INFO - Return code: 0 22:23:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:23:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:23:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:23:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:23:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:23:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:23:09 INFO - Using env: {'DISPLAY': ':0', 22:23:09 INFO - 'HOME': '/home/cltbld', 22:23:09 INFO - 'LANG': 'en_US.UTF-8', 22:23:09 INFO - 'LANGUAGE': 'en_US:en', 22:23:09 INFO - 'LOGNAME': 'cltbld', 22:23:09 INFO - 'MAIL': '/var/mail/cltbld', 22:23:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:23:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:09 INFO - 'MOZ_NO_REMOTE': '1', 22:23:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:09 INFO - 'NO_EM_RESTART': '1', 22:23:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:09 INFO - 'PWD': '/builds/slave/test', 22:23:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:23:09 INFO - 'SHELL': '/bin/bash', 22:23:09 INFO - 'SHLVL': '1', 22:23:09 INFO - 'TERM': 'linux', 22:23:09 INFO - 'TMOUT': '86400', 22:23:09 INFO - 'USER': 'cltbld', 22:23:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856', 22:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:09 INFO - '_': '/tools/buildbot/bin/python'} 22:23:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:23:10 INFO - mozversion application_buildid: 20161130203744 22:23:10 INFO - mozversion application_changeset: 7c6afff0c35db7e480743d77da938e530bf4b4a5 22:23:10 INFO - mozversion application_display_name: Nightly 22:23:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:23:10 INFO - mozversion application_name: Firefox 22:23:10 INFO - mozversion application_remotingname: firefox 22:23:10 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 22:23:10 INFO - mozversion application_vendor: Mozilla 22:23:10 INFO - mozversion application_version: 53.0a1 22:23:10 INFO - mozversion platform_buildid: 20161130203744 22:23:10 INFO - mozversion platform_changeset: 7c6afff0c35db7e480743d77da938e530bf4b4a5 22:23:10 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 22:23:10 INFO - mozversion platform_version: 53.0a1 22:23:10 INFO - using testdate: 1480573390 22:23:10 INFO - actual date: 1480573390 22:23:10 INFO - starting webserver on 'localhost:41288' 22:23:10 INFO - SUITE-START | Running 2 tests 22:23:10 INFO - TEST-START | dromaeo_css 22:23:10 INFO - operating with platform_type : linux_ 22:23:10 INFO - Initialising browser for dromaeo_css test... 22:23:10 INFO - TEST-INFO | started process 28224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkWmqOt/profile http://localhost:41288/getInfo.html) 22:23:14 INFO - PROCESS | 28224 | __metrics Screen width/height:1600/1200 22:23:14 INFO - PROCESS | 28224 | colorDepth:24 22:23:14 INFO - PROCESS | 28224 | Browser inner width/height: 1024/697 22:23:14 INFO - PROCESS | 28224 | __metrics 22:23:15 ERROR - PROCESS | 28224 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 22:23:16 INFO - TEST-INFO | 28224: exit 0 22:23:16 INFO - Browser initialized. 22:23:16 INFO - Running cycle 1/1 for dromaeo_css test... 22:23:16 INFO - TEST-INFO | started process 28349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkWmqOt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:23:28 INFO - PROCESS | 28349 | RSS: Main: 187662336 22:23:28 INFO - PROCESS | 28349 | 22:24:18 INFO - PROCESS | 28349 | 1480573458560 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] 22:26:32 INFO - PROCESS | 28349 | Cycle 1(1): loaded http://localhost:41288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41288/tests/dromaeo/cssquery-ext.html) 22:26:33 INFO - PROCESS | 28349 | RSS: Main: 197767168 22:26:33 INFO - PROCESS | 28349 | 22:29:36 INFO - PROCESS | 28349 | Cycle 1(1): loaded http://localhost:41288/tests/dromaeo/cssquery-ext.html (next: http://localhost:41288/tests/dromaeo/cssquery-jquery.html) 22:29:36 INFO - PROCESS | 28349 | RSS: Main: 197439488 22:29:36 INFO - PROCESS | 28349 | 22:32:38 INFO - PROCESS | 28349 | Cycle 1(1): loaded http://localhost:41288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41288/tests/dromaeo/cssquery-mootools.html) 22:32:39 INFO - PROCESS | 28349 | RSS: Main: 199520256 22:32:39 INFO - PROCESS | 28349 | 22:35:41 INFO - PROCESS | 28349 | Cycle 1(1): loaded http://localhost:41288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41288/tests/dromaeo/cssquery-prototype.html) 22:35:42 INFO - PROCESS | 28349 | RSS: Main: 196620288 22:35:42 INFO - PROCESS | 28349 | 22:38:45 INFO - PROCESS | 28349 | Cycle 1(1): loaded http://localhost:41288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41288/tests/dromaeo/cssquery-yui.html) 22:38:45 INFO - PROCESS | 28349 | RSS: Main: 200581120 22:38:45 INFO - PROCESS | 28349 | 22:41:48 INFO - PROCESS | 28349 | Cycle 1(1): loaded http://localhost:41288/tests/dromaeo/cssquery-yui.html (next: http://localhost:41288/tests/dromaeo/cssquery-dojo.html) 22:41:48 INFO - PROCESS | 28349 | RSS: Main: 200355840 22:41:48 INFO - PROCESS | 28349 | 22:41:48 INFO - PROCESS | 28349 | __start_tp_report 22:41:48 INFO - PROCESS | 28349 | _x_x_mozilla_page_load 22:41:48 INFO - PROCESS | 28349 | _x_x_mozilla_page_load_details 22:41:48 INFO - PROCESS | 28349 | |i|pagename|runs| 22:41:48 INFO - PROCESS | 28349 | |0;dojo.html;2604.0885690008495;2622;2625.330540712118;2627.697814751302;2648.1393547097186;4643.280291554806;4716.976415117928;4760.904781904364;4809.158397280479;4851.272309153629;4700.412448443944;4711.740854253015;4730.19586670266;4730.4559975602815;4809.230523116302;4310.094880075172;4370.73775573465;4390.758508282043;4401.0977749561425;4438.312061630452;4381.3208952612395;4422.137683151786;4463.509014008457;4504.234280172379;4517.819287228507;4439;4499.797509112065;4504.1892459357305;4510;4542.977285113569;4243.257429949746;4272.230998420283;4283.357496375537;4320.611144996966;4334.024844410014;4280.208161490134;4301.204277208695;4315.5900189481945;4316.611504964537;4316.870493885189;4610.147122782262;4637.072585482883;4666.510016448258;4678.976605116953;4762.78567464465;5023.8492845214705;5028.748562571856;5043.62172837035;5045.132572283992;5102.081625307444;4945.480724523945;5102.438731739506;5121.795128194868;5136.64043516954;5176.50823171798;4627.699199552018;4674.766261686902;4717.575418212377;4732.574068333866;4734.905301893943;5146.0479811235045;5172.172452407597;5196.428392876781;5245.213218017328;5297.496737809902;5012.04771093491;5015.3229314042865;5022.347094877642;5027.069992051483;5034.34553508049;4889.804407823718;4902.313676085351;5058.241263810458;5061.190209566452;5073.441921388644;4936.851894443173;4939.160342741742;4939.5554400104165;4964.304997300381;4976.62675299354;5017.347744793154;5056.393232812086;5077.771500282496;5078.542931136216;5083.87290317745;4277.572242775697;4289.82840686369;4299.484061912591;4318.52496225415;4346.521882592912;3667.7799332040163;3736.0473079364588;3771.5097037385513;3775.6979441644603;3777.206786574795;4210.642095421924;4319.956800432018;4341;4343.891402714894;4345.695801293942;5122.820701275437;5167.379914410295;5167.68993860362;5172.301739265151;5216.347956505437;4427.446569178853;4429.80065897029;4430.357598148251;4440.045390241114;4473.038296766211;4384.364267181241;4422.734635921791;4629.745364005012;4646.4888862225125;4663.883402914887;4511.548845115528;4577.450705915311;4579.977100114478;4582.862514124582;4588.17412865674;4965.652404331662;4967.652264341461;4970.701757894538;4972.8756781080765;4975.0547395994645;4634.582887540138;4698.976505117453;4712.151812673752;4754.286856971482;4825.758712064313;5054.090263752413;5055.064813009605;5061.8734531637;5067.113255180255;5077.136886729339;4984.825531106394;5115.25828754821;5118.3857937046305;5125.256837758429;5131.025105229995;4885.1450996076255;4928.482509336468;4942.4316203637045;4979.701217926936;5051.722155281494;4986.750662466935;4989.12690279207;4997.475265097112;4998.425181104074;5044.041632089891;4896.902061958812;4901.534354236342;4927.704337739747;4946.826861059845;4979.751012449291;4805.327254184487;4829.27560865873;4860.684055536379;4943.555080042814;4945.6043516517875;4854.393200849894;4875.512448755097;4893.290472881341;4895.094407534618;4909.214525675875 22:41:48 INFO - PROCESS | 28349 | |1;ext.html;529.2352550564436;542.4087744358653;543.9836804895853;558.9547546088812;559.8852235291765;36972.81513592435;38873.02817429562;38937.61062389375;42353.7882310588;42575.361369579405;37932.81033594835;38443.0024096867;38507.42238866419;38606.22787544254;38622.80688596553;7498.662560184791;7636.885446718304;7639.961800190991;7643.197464266227;9466.19537339327;9440.055994400574;9741.074597913223;9761.609535618567;9769.755756106084;9793.608255669764;9904.801903961916;9925.057119573665;9926.702198934043;9941.95609461007;9950.601975920954;9699.563519641633;9774.853377199312;9820.950895245478;9829.410235385863;9839.704808855675;9651.565679544437;9729.367591106555;9729.756756081084;9748.853767193426;9752.853707194397;37463.625363746556;37838.054048649006;37895.431568526496;37924;37993;2863.1267463423646;3092.8762849485993;3174.6031746031745;3278.50822376643;3290.555774970372;28010.859945700344;28236.294092647644;28428;28857.711422885714;29134.562981555293;3354.480055591387;3442.4147894857933;3443.139215196201;3451.447768357051;3514.736394770377;255223;255840;256063;256434;257036;52783.736081319345;53470;53621;53744;53870.730646346514;55655.443445565834;55861.72069139628;55965;56093.71953140208;56146.71926640422;13989.3704783285;14122.929385353007;14145.43418263258;14245.715085698228;14252.786208206886;8896.777580560538;9137.451752894714;10016.949915250523;10321;10666.78666426667;17333.47999560015;17647.470575882744;17717.202725877367;17813.376531821585;17855.28578856831;6466.741330346734;6670.7665231716655;6690.632015239111;6814.114165158498;6870.244273129952;758.2682711183734;881.0880738435688;904.968326108583;906.5557876640398;938.9952750556838;26490.86754566215;27890.302742431602;28063.298417539318;28380;28398;914.8902131744234;917.060013486182;930.3812964378748;934.9111834375724;1030.1346868630387;14279.143251404948;14638.414463421344;14713.705725885422;14966.326515306837;14967.77548336754;347996;350376;353361;353784;354684;48628.7568562162;49319.84862195033;49561.25658115131;49570.50429495731;49878.75060624674;1130.1862658885589;1168.7954607943575;1172.7771723372532;1174.6769638349522;1181.7163880668577;25630.102946396786;26597.468050639265;27244.72755272422;27606;27641.72358276472;42894.14211715811;43590.12819743524;43598.56401435945;43609.56390436182;43610.781946090065;307529;308690;309052;311591;311602;21441.961139131978;24183.39541511406;24549.50900982006;24618.630720539564;24627;35569.46645800367;39835.60164398435;40009.19866619266;43493.56506434895;43710;34981.47527787034;35183.82408087943;35550.46674299836;35647.28705425929;35709.46435803517;35298.29403411969;35350.646493535765;35361.82319088491;35448.113797155274;35617.1095722609;34587.654123458444;34597.827010864785;34603;34785.82607086949;35487.467687984186;29875;32451.837740811145;32622.021339359857;32681.836590816893;33006.17484562809;24461;24860.37849053788;24877.253682389557;25157.24528264155;25294.58523099358 22:41:48 INFO - PROCESS | 28349 | |2;jquery.html;327.59214777601875;343.8177765784132;357.7889045463176;359.20436233742265;383.1035377217311;15774.921125394372;16062.83937160628;17097.23062462189;17131;17201.82798172018;15612.60968475786;16128.193590320467;16225.756613650805;16638.50084497464;16886.662266754658;4350.717203381778;4594.839180628679;4645;4649.279361698942;4650.348951146842;4588.128255631436;4612.146752850734;4613.976930115345;4619.907601847961;4626.05165940983;4604.953950460503;4618.515055919113;5057.165567681328;5307.946920530784;5359.464053594648;5408.296921400212;5440.564754819625;5444.8366549003595;5446.700431476287;5448.91826622597;4514.277715565494;4794.7842347094465;4809.278608208761;4885.487023862514;5270.288511051036;19373.031348432523;19739;19753.20987160512;19977.80022199774;20147.697784533244;1714.953878134337;1746.720524716052;1809.1496996411797;2001.7798042215345;2354.4702441950426;8975.28197744179;8988.325875559294;9273.536323183882;9446.197073248783;10468.371897686164;1641.8850680452374;1661.8753593480417;1684.8146703862687;1702.4637239269591;1784.295203394652;62983.6850815743;63848;64140.679296603215;66582;69861.3013869865;9261.351705380694;9374.484403357881;9532.142107210384;9728.75678108053;10048.949755251177;13062.869371306355;13063.738725225443;13066.477340906447;13100.803487947689;13136.40886160125;6691.966540167268;6851.143607049119;6905.309469053054;6976.500052488638;7045.436365090781;6417.518686098561;6592.76925307612;6752.257251702309;6769.695363708546;6781.152355955505;3898.571157172709;4085.4484644573195;4088.5911408858874;4130.277201489727;4179.623833854967;1617.126751554171;1678.135760083558;1715.1852869886955;1723.629419674776;1760.978632393209;773.6286582440348;802.2178376083272;835.2983493865182;848.1264297773304;904.9683360968501;16485.516253816084;16605.252763625667;16988.150592470327;17023.574410639834;17555.912220438815;812.4800127918137;817.5258350156895;824.1099612418574;860.0367588301143;909.2089881802874;9049.502277374808;9128.132827381389;9566.56950437232;9616.326857119935;9639.18066964302;345938;348722;351294;353682;353868;72509.91235131478;74559;75513.62243188749;75973;78810.21189788144;825.9545724985063;830.3647709502236;835.3943391041568;835.6532039203784;837.535167981776;14563.781543276647;14832.332545035284;14855.628609284422;14861.182634954748;15410.537683869501;35912.281754365285;36054.45918311175;36619.267614647026;37382.439263411616;37587.436188456646;47489.76255118702;48432.5156748428;49937.25094123519;50495.74752126216;51654.225186622985;7228.674709638184;7581.82481715335;7607.733729319447;7625.809354766176;7693.1922148173635;9023.601341792033;10569;11369.943150284196;11568.710782230512;11790.292582445081;10551.894481055091;10575.735606609896;10598.682039538826;10700;10988.725281868017;4742.857714268577;9271.629134834531;10286.794264114526;10350.22373322019;10377.066064054272;10228.181745460493;10542.841857371992;10585.153187744809;10776.67669969902;11057.612983545538;7484.139323977813;7487.176410594939;7489.66296516669;7637.389008879388;7853.685852566062;7682.116556596063;9820.65627703027;10621.203409744454;10632.25574209798;10994.945025275143 22:41:48 INFO - PROCESS | 28349 | |3;mootools.html;1339.2165583133867;1375.635456604;1430.1490613085218;1601.3914712409282;1632.7469242267446;6043.18417013703;6182.474489668372;6309.116723658686;6663.366980136885;6703;6724.293949135344;6906.861862762742;6915.723371065152;7012.368886800187;7023.7541686040995;2060.4127823570284;2101.548167144064;2102.348272035666;2105.4210092224607;2105.9473513162216;2053.7330147080856;2057.5781964697276;2060.5672808710187;2085.228465467779;2093.1627349060423;2012.859099863003;2015.5263513074415;2024.615323088616;2029.81731644152;2046.5906818636258;1999.3701983875105;2020.595880823841;2021.7674967378794;2026.0275067967311;2026.868253563521;2054.969175462369;2058.217877206667;2073.668213085899;2076.0553947953795;2079.054030416157;6830.45356371494;6954.23503414624;6962.895556566656;6964.860702785916;6966.686499107553;4144.48193975753;4276.23027854986;4281;4281.657467402601;4286.592773686495;2646.907358242452;2804.4110736745306;2875.4967880620807;2942.558616207586;2966.9109926702235;834.2616784146014;888.1606881496988;904.6200595749801;939.2908354192609;948.9572969216333;8919.509426981513;8934.4192627479;8951.73144805657;8967.955160224223;9068.183863452256;3637.3452778499595;3806.2197249563774;3875.302445559826;3905.7851818150275;3959.7624142550962;7867.72462963805;7934.603269836485;7943.801404964922;7947.5231486111015;7963.800904977422;4275.46556680415;4278.7004909656025;4280.058387154821;4281.529031806499;4290.82836686529;3314.0057982605604;3419.880304189391;3586.7847929124337;3920.4903362562686;3923.509561304837;3216.1798741320813;3302.4716045432615;3406.9488957665653;3410.5225268462436;3411.4200585900458;1073.1254027967182;1082.6156714366443;1085.3542142425244;1109.1237922041657;1112.5160555158532;687.6458623808743;825.6903661127077;828.1676914700687;838.2204549768774;844.8817165596821;4743.430788305425;4772.093302272557;4837.540433658797;4869.464358920587;4959.553640172402;370.9554853417607;376.5725901102269;381.74232393134525;382.11159055196777;383.9443280724335;3415.624281329052;3516.771409858402;3518.1908161123083;3521.9471707924404;3593.1915319053005;8046.557439340775;8354.707585234488;8380.748577542561;8386.077531471534;8422.410431269753;8233.259006689426;8255.669773209005;8296.419250652518;8334.958325208336;8388.203120703523;6523.967380163069;6556.082148499214;6609.339066093448;6612;6642.269350371455;4761.976190119166;4764.690295130806;4795.712257264575;4922.4339200992345;4994.625403094709;7557.659905304385;7572.356349710336;7588.696452141852;7655.846883062419;7663.348615367756;7649.464537482323;7652.579108149105;7721.343685786771;7743.922560774546;7779.72770953014;5264.78940842362;5996.8800623988145;6044.24446944132;6066;6073.423024812636;5910.586258961831;6316.11574379578;6476.287608363171;6529.216494020748;6581.440577550962;5850.268716410449;5962.761489540369;5979.850503737442;6027.156198132353;6139.938600613937;5923.141144533933;5946;5957.136215248851;5962.850928726816;5971.223740913827;5527.088030475087;5661.66030038199;5670.064439367458;5776.9133462998925;5777.306723193244;4154.937675934803;4179.916401671889;4284.335927931175;4286.2284788738325;4296;4186.225548273579;4215.13589714114;4293.699441039097;4314.741115533078;4371.846985355497 22:41:48 INFO - PROCESS | 28349 | |4;prototype.html;289.54107739233314;294.6714413429026;296.52555910543134;298.40468265809704;300.9458297506448;4901.534354236351;5018.2472629105605;5023.296738456615;5057.696538207711;5092.275632536594;4899.314096026559;4938.08652894792;4950.282209079682;4951.29180432751;4955.3310303109065;3742.5134732484876;3907.628775266345;3919.627635374635;3928.5874983126787;3936.8622098226638;3908;3908.355121404979;3910.1397692507603;3915.804209789499;3922.705797065217;3862.7102967277424;3872.2255548890193;3881.243157584272;3883.0874744435177;3894.805259737016;3873.2253549290112;3906.5507466641134;3909.648131668135;3910.608939106081;3912.921741565181;3300.455424854896;3440.397930362177;3452.499387588811;3473.218525831693;3479.5128681984543;4823;4838.314735321895;4842.975785121087;4854.567902468781;4868.537488938545;4415.690901636886;4419.801108950072;4423.225935461282;4459.777011149429;4477.888052798674;4985.975070124662;5175.974120129413;5181.538769084655;5232.2674825524455;5243.823813117551;3759.2105657811894;3760.285545746327;3760.4547340635727;3768.4724138620613;3771.773693578394;5417.864553386157;5419.512243898029;5438.211459338413;5453.664336852252;5461.808836690697;3641.9453708194396;3745.6816170625802;3749.812509374575;3776.3580191367532;3779.848806047782;3802.783109404964;3813.932099012281;3820.675242604354;3840.558335791364;3847.826847791856;4340.696151269444;4352.086061927031;4352.412424322739;4369.584889435499;4374.278244089754;5176.430592634807;5186.429492755794;5195.766190521435;5199.428062913076;5224.8171314004585;1256.0203041627544;1326.3500884566492;1331.0616015708902;1332.7134666046848;1340.2025794652166;836.6109758962111;855.8587833007484;859.5014891362995;867.8004059066324;874.4534665833854;4369.366441865912;4369.531214863656;4399.890002749893;4495.415595972503;4591.44902611682;5346.358436987586;5385.6230063895155;5403.216533602685;5411.56707463402;5417.702026388508;4583.770811459413;4599.609033232213;4601.953980460153;4603.217453032926;4627.72737497191;2716.9539727204774;2737.8220415672918;2769.3492029373083;2784.220418282884;2818;4797.488791030814;4834.347363106006;4837.177679794443;4841.661083724176;4883.536064073907;5323;5343;5361.35663720356;5368.892622147535;5369.670804101404;4723.45680246776;4864.562189402971;4874.586369952674;4877.365942427604;4911.238757992517;5240.737963101906;5253.579713622978;5257.974694934451;5260.39610392858;5275.709835959059;5165.328507294028;5180.896382072413;5183.50756678115;5193.636445448782;5211.4527974562125;4745.71878551065;4750.904981900412;4804.663673542958;4846.297286893451;4909.779059942382;3579.35128005269;3591.6947059500235;3592.820358982093;3615.794365437029;3619.4570814377003;5263.815766448156;5268.736563171903;5273.235380869675;5275.709835959059;5286.577073834161;4917.893473968472;5034.421041580265;5068.721220332917;5103.974480127576;5133.050385678662;5005.623453550157;5036.722980235975;5045.318881951036;5135.589152867837;5166.948330516797;5038.186252949009;5075;5091.7087310709585;5098.898022039464;5116.437191908962;4998.550710152072;5067.391912970467;5139;5188.403333616682;5196.116660167705;4986.850394488171;5057.128862320965;5101.872453188552;5139.871503212449;5148.716820574904 22:41:48 INFO - PROCESS | 28349 | |5;yui.html;602.5119653081008;638.2277444292406;639.1907566246348;727.5525551785651;742.2392048150645;11697.532098716052;12710.618681439548;12763.872361276384;13921.930390348034;14652.853471465281;14431.206283654396;14450.494232701858;14699.779503307433;14793.482228122019;14843.628909277273;722.8843385058378;748.8352562436282;753.0962844586518;754.0574282147315;755.2975732568709;740.655595148256;770.4298818874049;772.3473664753302;777.4247057177704;778.3734094054284;815.6859609050499;815.8572249856281;816.9346452283803;818.7666515043214;820.6266148902265;807.5154907055778;814.3566582399897;814.6374863185885;814.8044469327349;814.9755507334789;591.2343515147894;592.5674257791793;594.1325664529749;598.4015984015984;598.5331441475656;13600.591982240549;13890.58328250154;13922.860771392257;13964.860351396457;13987.65030874226;12667.619971400873;12991.155574887602;13000.219986800823;13184.340782960813;13273.800892986614;10371.429571373572;10572.894271057345;10639.148868090535;10693.037626613643;10828.187885908588;3159.8420078996187;3243.5783348164823;3248.7076163145193;3249.4800831866787;3288.145082278601;65157.3484265156;65599;66007.66996165036;66653;66843;10056.59773609062;10061.39631622105;10155;10285.2800303978;10312.48437578133;18774.718379224323;19060.52348691266;19077.141528631244;19106.140223689967;19426.5143371414;6323;6545.232787147444;6620.073189753439;6701.229358623723;6728.240747671024;3598.47822065799;3644.1436262478296;3680.0983758979223;3696.4085746280466;3707.6663100321102;2696.339396847746;2808.761255293282;2824.5904343870434;2824.901128460494;2831.4337132573155;453.4105662638557;454.1983399300238;456.56170076726715;459.0955817040425;465.2439785348808;540.6296686769575;557.946995035471;561.2759540193105;563.492856429217;570.7003822992879;7955.920440795634;7986.241307075818;8071.636776345079;8121.269085782308;8209.630566624517;511.71088335090553;566.7591273708657;574.7930744931821;580.8576898659855;605.6910975402576;3762.7177961652988;3763.360228761117;3809.3524100902914;3850.5956874528333;4038;56126.719366402904;56424.79327273997;70243.64878175576;73769;73821.6308918452;64640.67679661571;64963.35036649668;65026.67486662536;65053.67473162698;65217.999999999054;42726.35910461345;55886.72056639691;56272.99999999918;57510.71244643834;58388.41611583915;7284;7513.887291690519;7595.962020189863;7704.460687751804;7760.767176984699;39377.60622393739;40585.59414405818;40647.59352406438;40849;41321.380179296735;49248.50751492583;51067.744661276454;54055.72972135114;54518;56120;8692.521911294687;8732.956335218283;8955.910440895768;9048.547572621474;9108.316876234441;10757.892421075689;10771.246012779344;10847.728806779895;10880.347179169275;10971.265968878239;10000.199984001118;10061.195104391778;10332.328398654063;10335.638252661422;10376.221783366429;9299.442033478013;9422.434653920787;9515.762105947406;9590.232781377334;9858.30991830565;9770.804583908424;9811.55847986828;9945.403275803475;10159.847602285823;10347.482625868526;8132.552709600792;8503.319734421108;8566.614502347285;8659.870101948602;8861.202491775772;8523.701670441753;8582.184692454206;8600.569971501525;8620.655173792979;8710.91289087101 22:41:48 INFO - PROCESS | 28349 | __end_tp_report 22:41:48 INFO - PROCESS | 28349 | __start_cc_report 22:41:48 INFO - PROCESS | 28349 | _x_x_mozilla_cycle_collect,345 22:41:48 INFO - PROCESS | 28349 | __end_cc_report 22:41:48 INFO - PROCESS | 28349 | __startTimestamp1480574508732__endTimestamp 22:41:48 INFO - PROCESS | 28349 | 22:41:48 INFO - PROCESS | 28349 | ------- Summary: start ------- 22:41:48 INFO - PROCESS | 28349 | Number of tests: 6 22:41:48 INFO - PROCESS | 28349 | 22:41:48 INFO - PROCESS | 28349 | [#0] dojo.html Cycles:165 Average:4679.12 Median:4809.16 stddev:493.86 (10.3%) stddev-sans-first:467.78 22:41:48 INFO - PROCESS | 28349 | Values: 2604.1 2622.0 2625.3 2627.7 2648.1 4643.3 4717.0 4760.9 4809.2 4851.3 4700.4 4711.7 4730.2 4730.5 4809.2 4310.1 4370.7 4390.8 4401.1 4438.3 4381.3 4422.1 4463.5 4504.2 4517.8 4439.0 4499.8 4504.2 4510.0 4543.0 4243.3 4272.2 4283.4 4320.6 4334.0 4280.2 4301.2 4315.6 4316.6 4316.9 4610.1 4637.1 4666.5 4679.0 4762.8 5023.8 5028.7 5043.6 5045.1 5102.1 4945.5 5102.4 5121.8 5136.6 5176.5 4627.7 4674.8 4717.6 4732.6 4734.9 5146.0 5172.2 5196.4 5245.2 5297.5 5012.0 5015.3 5022.3 5027.1 5034.3 4889.8 4902.3 5058.2 5061.2 5073.4 4936.9 4939.2 4939.6 4964.3 4976.6 5017.3 5056.4 5077.8 5078.5 5083.9 4277.6 4289.8 4299.5 4318.5 4346.5 3667.8 3736.0 3771.5 3775.7 3777.2 4210.6 4320.0 4341.0 4343.9 4345.7 5122.8 5167.4 5167.7 5172.3 5216.3 4427.4 4429.8 4430.4 4440.0 4473.0 4384.4 4422.7 4629.7 4646.5 4663.9 4511.5 4577.5 4580.0 4582.9 4588.2 4965.7 4967.7 4970.7 4972.9 4975.1 4634.6 4699.0 4712.2 4754.3 4825.8 5054.1 5055.1 5061.9 5067.1 5077.1 4984.8 5115.3 5118.4 5125.3 5131.0 4885.1 4928.5 4942.4 4979.7 5051.7 4986.8 4989.1 4997.5 4998.4 5044.0 4896.9 4901.5 4927.7 4946.8 4979.8 4805.3 4829.3 4860.7 4943.6 4945.6 4854.4 4875.5 4893.3 4895.1 4909.2 22:41:48 INFO - PROCESS | 28349 | 22:41:48 INFO - PROCESS | 28349 | [#1] ext.html Cycles:180 Average:46307.02 Median:35559.97 stddev:80905.86 (227.5%) stddev-sans-first:81059.81 22:41:48 INFO - PROCESS | 28349 | Values: 529.2 542.4 544.0 559.0 559.9 36972.8 38873.0 38937.6 42353.8 42575.4 37932.8 38443.0 38507.4 38606.2 38622.8 7498.7 7636.9 7640.0 7643.2 9466.2 9440.1 9741.1 9761.6 9769.8 9793.6 9904.8 9925.1 9926.7 9942.0 9950.6 9699.6 9774.9 9821.0 9829.4 9839.7 9651.6 9729.4 9729.8 9748.9 9752.9 37463.6 37838.1 37895.4 37924.0 37993.0 2863.1 3092.9 3174.6 3278.5 3290.6 28010.9 28236.3 28428.0 28857.7 29134.6 3354.5 3442.4 3443.1 3451.4 3514.7 255223.0 255840.0 256063.0 256434.0 257036.0 52783.7 53470.0 53621.0 53744.0 53870.7 55655.4 55861.7 55965.0 56093.7 56146.7 13989.4 14122.9 14145.4 14245.7 14252.8 8896.8 9137.5 10016.9 10321.0 10666.8 17333.5 17647.5 17717.2 17813.4 17855.3 6466.7 6670.8 6690.6 6814.1 6870.2 758.3 881.1 905.0 906.6 939.0 26490.9 27890.3 28063.3 28380.0 28398.0 914.9 917.1 930.4 934.9 1030.1 14279.1 14638.4 14713.7 14966.3 14967.8 347996.0 350376.0 353361.0 353784.0 354684.0 48628.8 49319.8 49561.3 49570.5 49878.8 1130.2 1168.8 1172.8 1174.7 1181.7 25630.1 26597.5 27244.7 27606.0 27641.7 42894.1 43590.1 43598.6 43609.6 43610.8 307529.0 308690.0 309052.0 311591.0 311602.0 21442.0 24183.4 24549.5 24618.6 24627.0 35569.5 39835.6 40009.2 43493.6 43710.0 34981.5 35183.8 35550.5 35647.3 35709.5 35298.3 35350.6 35361.8 35448.1 35617.1 34587.7 34597.8 34603.0 34785.8 35487.5 29875.0 32451.8 32622.0 32681.8 33006.2 24461.0 24860.4 24877.3 25157.2 25294.6 22:41:48 INFO - PROCESS | 28349 | 22:41:48 INFO - PROCESS | 28349 | [#2] jquery.html Cycles:180 Average:22795.31 Median:4599.90 stddev:58106.22 (1263.2%) stddev-sans-first:58244.74 22:41:48 INFO - PROCESS | 28349 | Values: 327.6 343.8 357.8 359.2 383.1 15774.9 16062.8 17097.2 17131.0 17201.8 15612.6 16128.2 16225.8 16638.5 16886.7 4350.7 4594.8 4645.0 4649.3 4650.3 4588.1 4612.1 4614.0 4619.9 4626.1 4605.0 4618.5 5057.2 5307.9 5359.5 5408.3 5440.6 5444.8 5446.7 5448.9 4514.3 4794.8 4809.3 4885.5 5270.3 19373.0 19739.0 19753.2 19977.8 20147.7 1715.0 1746.7 1809.1 2001.8 2354.5 8975.3 8988.3 9273.5 9446.2 10468.4 1641.9 1661.9 1684.8 1702.5 1784.3 62983.7 63848.0 64140.7 66582.0 69861.3 9261.4 9374.5 9532.1 9728.8 10048.9 13062.9 13063.7 13066.5 13100.8 13136.4 6692.0 6851.1 6905.3 6976.5 7045.4 6417.5 6592.8 6752.3 6769.7 6781.2 3898.6 4085.4 4088.6 4130.3 4179.6 1617.1 1678.1 1715.2 1723.6 1761.0 773.6 802.2 835.3 848.1 905.0 16485.5 16605.3 16988.2 17023.6 17555.9 812.5 817.5 824.1 860.0 909.2 9049.5 9128.1 9566.6 9616.3 9639.2 345938.0 348722.0 351294.0 353682.0 353868.0 72509.9 74559.0 75513.6 75973.0 78810.2 826.0 830.4 835.4 835.7 837.5 14563.8 14832.3 14855.6 14861.2 15410.5 35912.3 36054.5 36619.3 37382.4 37587.4 47489.8 48432.5 49937.3 50495.7 51654.2 7228.7 7581.8 7607.7 7625.8 7693.2 9023.6 10569.0 11369.9 11568.7 11790.3 10551.9 10575.7 10598.7 10700.0 10988.7 4742.9 9271.6 10286.8 10350.2 10377.1 10228.2 10542.8 10585.2 10776.7 11057.6 7484.1 7487.2 7489.7 7637.4 7853.7 7682.1 9820.7 10621.2 10632.3 10994.9 22:41:48 INFO - PROCESS | 28349 | 22:41:48 INFO - PROCESS | 28349 | [#3] mootools.html Cycles:180 Average:4566.29 Median:4853.50 stddev:2437.47 (50.2%) stddev-sans-first:2432.25 22:41:48 INFO - PROCESS | 28349 | Values: 1339.2 1375.6 1430.1 1601.4 1632.7 6043.2 6182.5 6309.1 6663.4 6703.0 6724.3 6906.9 6915.7 7012.4 7023.8 2060.4 2101.5 2102.3 2105.4 2105.9 2053.7 2057.6 2060.6 2085.2 2093.2 2012.9 2015.5 2024.6 2029.8 2046.6 1999.4 2020.6 2021.8 2026.0 2026.9 2055.0 2058.2 2073.7 2076.1 2079.1 6830.5 6954.2 6962.9 6964.9 6966.7 4144.5 4276.2 4281.0 4281.7 4286.6 2646.9 2804.4 2875.5 2942.6 2966.9 834.3 888.2 904.6 939.3 949.0 8919.5 8934.4 8951.7 8968.0 9068.2 3637.3 3806.2 3875.3 3905.8 3959.8 7867.7 7934.6 7943.8 7947.5 7963.8 4275.5 4278.7 4280.1 4281.5 4290.8 3314.0 3419.9 3586.8 3920.5 3923.5 3216.2 3302.5 3406.9 3410.5 3411.4 1073.1 1082.6 1085.4 1109.1 1112.5 687.6 825.7 828.2 838.2 844.9 4743.4 4772.1 4837.5 4869.5 4959.6 371.0 376.6 381.7 382.1 383.9 3415.6 3516.8 3518.2 3521.9 3593.2 8046.6 8354.7 8380.7 8386.1 8422.4 8233.3 8255.7 8296.4 8335.0 8388.2 6524.0 6556.1 6609.3 6612.0 6642.3 4762.0 4764.7 4795.7 4922.4 4994.6 7557.7 7572.4 7588.7 7655.8 7663.3 7649.5 7652.6 7721.3 7743.9 7779.7 5264.8 5996.9 6044.2 6066.0 6073.4 5910.6 6316.1 6476.3 6529.2 6581.4 5850.3 5962.8 5979.9 6027.2 6139.9 5923.1 5946.0 5957.1 5962.9 5971.2 5527.1 5661.7 5670.1 5776.9 5777.3 4154.9 4179.9 4284.3 4286.2 4296.0 4186.2 4215.1 4293.7 4314.7 4371.8 22:41:48 INFO - PROCESS | 28349 | 22:41:48 INFO - PROCESS | 28349 | [#4] prototype.html Cycles:180 Average:4277.95 Median:4844.64 stddev:1239.42 (25.6%) stddev-sans-first:1206.20 22:41:48 INFO - PROCESS | 28349 | Values: 289.5 294.7 296.5 298.4 300.9 4901.5 5018.2 5023.3 5057.7 5092.3 4899.3 4938.1 4950.3 4951.3 4955.3 3742.5 3907.6 3919.6 3928.6 3936.9 3908.0 3908.4 3910.1 3915.8 3922.7 3862.7 3872.2 3881.2 3883.1 3894.8 3873.2 3906.6 3909.6 3910.6 3912.9 3300.5 3440.4 3452.5 3473.2 3479.5 4823.0 4838.3 4843.0 4854.6 4868.5 4415.7 4419.8 4423.2 4459.8 4477.9 4986.0 5176.0 5181.5 5232.3 5243.8 3759.2 3760.3 3760.5 3768.5 3771.8 5417.9 5419.5 5438.2 5453.7 5461.8 3641.9 3745.7 3749.8 3776.4 3779.8 3802.8 3813.9 3820.7 3840.6 3847.8 4340.7 4352.1 4352.4 4369.6 4374.3 5176.4 5186.4 5195.8 5199.4 5224.8 1256.0 1326.4 1331.1 1332.7 1340.2 836.6 855.9 859.5 867.8 874.5 4369.4 4369.5 4399.9 4495.4 4591.4 5346.4 5385.6 5403.2 5411.6 5417.7 4583.8 4599.6 4602.0 4603.2 4627.7 2717.0 2737.8 2769.3 2784.2 2818.0 4797.5 4834.3 4837.2 4841.7 4883.5 5323.0 5343.0 5361.4 5368.9 5369.7 4723.5 4864.6 4874.6 4877.4 4911.2 5240.7 5253.6 5258.0 5260.4 5275.7 5165.3 5180.9 5183.5 5193.6 5211.5 4745.7 4750.9 4804.7 4846.3 4909.8 3579.4 3591.7 3592.8 3615.8 3619.5 5263.8 5268.7 5273.2 5275.7 5286.6 4917.9 5034.4 5068.7 5104.0 5133.1 5005.6 5036.7 5045.3 5135.6 5166.9 5038.2 5075.0 5091.7 5098.9 5116.4 4998.6 5067.4 5139.0 5188.4 5196.1 4986.9 5057.1 5101.9 5139.9 5148.7 22:41:48 INFO - PROCESS | 28349 | 22:41:48 INFO - PROCESS | 28349 | [#5] yui.html Cycles:180 Average:15217.62 Median:28494.14 stddev:19983.06 (70.1%) stddev-sans-first:20008.98 22:41:48 INFO - PROCESS | 28349 | Values: 602.5 638.2 639.2 727.6 742.2 11697.5 12710.6 12763.9 13921.9 14652.9 14431.2 14450.5 14699.8 14793.5 14843.6 722.9 748.8 753.1 754.1 755.3 740.7 770.4 772.3 777.4 778.4 815.7 815.9 816.9 818.8 820.6 807.5 814.4 814.6 814.8 815.0 591.2 592.6 594.1 598.4 598.5 13600.6 13890.6 13922.9 13964.9 13987.7 12667.6 12991.2 13000.2 13184.3 13273.8 10371.4 10572.9 10639.1 10693.0 10828.2 3159.8 3243.6 3248.7 3249.5 3288.1 65157.3 65599.0 66007.7 66653.0 66843.0 10056.6 10061.4 10155.0 10285.3 10312.5 18774.7 19060.5 19077.1 19106.1 19426.5 6323.0 6545.2 6620.1 6701.2 6728.2 3598.5 3644.1 3680.1 3696.4 3707.7 2696.3 2808.8 2824.6 2824.9 2831.4 453.4 454.2 456.6 459.1 465.2 540.6 557.9 561.3 563.5 570.7 7955.9 7986.2 8071.6 8121.3 8209.6 511.7 566.8 574.8 580.9 605.7 3762.7 3763.4 3809.4 3850.6 4038.0 56126.7 56424.8 70243.6 73769.0 73821.6 64640.7 64963.4 65026.7 65053.7 65218.0 42726.4 55886.7 56273.0 57510.7 58388.4 7284.0 7513.9 7596.0 7704.5 7760.8 39377.6 40585.6 40647.6 40849.0 41321.4 49248.5 51067.7 54055.7 54518.0 56120.0 8692.5 8733.0 8955.9 9048.5 9108.3 10757.9 10771.2 10847.7 10880.3 10971.3 10000.2 10061.2 10332.3 10335.6 10376.2 9299.4 9422.4 9515.8 9590.2 9858.3 9770.8 9811.6 9945.4 10159.8 10347.5 8132.6 8503.3 8566.6 8659.9 8861.2 8523.7 8582.2 8600.6 8620.7 8710.9 22:41:48 INFO - PROCESS | 28349 | -------- Summary: end -------- 22:41:48 INFO - PROCESS | 28349 | 22:41:49 INFO - TEST-INFO | 28349: exit 0 22:41:49 INFO - TEST-OK | dromaeo_css | took 1119742ms 22:41:49 INFO - TEST-START | kraken 22:41:49 INFO - operating with platform_type : linux_ 22:41:49 INFO - Initialising browser for kraken test... 22:41:49 INFO - TEST-INFO | started process 28701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxET6__/profile http://localhost:41288/getInfo.html) 22:41:54 INFO - PROCESS | 28701 | __metrics Screen width/height:1600/1200 22:41:54 INFO - PROCESS | 28701 | colorDepth:24 22:41:54 INFO - PROCESS | 28701 | Browser inner width/height: 1024/697 22:41:54 INFO - PROCESS | 28701 | __metrics 22:41:55 ERROR - PROCESS | 28701 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 22:41:56 INFO - TEST-INFO | 28701: exit 0 22:41:56 INFO - Browser initialized. 22:41:56 INFO - Running cycle 1/1 for kraken test... 22:41:56 INFO - TEST-INFO | started process 28822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxET6__/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:42:08 INFO - PROCESS | 28822 | RSS: Main: 187785216 22:42:08 INFO - PROCESS | 28822 | 22:42:11 INFO - PROCESS | 28822 | Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41288/tests/kraken/driver.html?testName=audio-beat-detection) 22:42:12 INFO - PROCESS | 28822 | RSS: Main: 199987200 22:42:12 INFO - PROCESS | 28822 | 22:42:15 INFO - PROCESS | 28822 | Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41288/tests/kraken/driver.html?testName=audio-dft) 22:42:15 INFO - PROCESS | 28822 | RSS: Main: 198103040 22:42:15 INFO - PROCESS | 28822 | 22:42:18 INFO - PROCESS | 28822 | Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41288/tests/kraken/driver.html?testName=audio-fft) 22:42:19 INFO - PROCESS | 28822 | RSS: Main: 194760704 22:42:19 INFO - PROCESS | 28822 | 22:42:21 INFO - PROCESS | 28822 | Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41288/tests/kraken/driver.html?testName=audio-oscillator) 22:42:22 INFO - PROCESS | 28822 | RSS: Main: 195059712 22:42:22 INFO - PROCESS | 28822 | 22:42:24 INFO - PROCESS | 28822 | Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:42:25 INFO - PROCESS | 28822 | RSS: Main: 195387392 22:42:25 INFO - PROCESS | 28822 | 22:42:28 INFO - PROCESS | 28822 | Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41288/tests/kraken/driver.html?testName=imaging-darkroom) 22:42:28 INFO - PROCESS | 28822 | RSS: Main: 200101888 22:42:28 INFO - PROCESS | 28822 | 22:42:32 INFO - PROCESS | 28822 | Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41288/tests/kraken/driver.html?testName=imaging-desaturate) 22:42:33 INFO - PROCESS | 28822 | RSS: Main: 197390336 22:42:33 INFO - PROCESS | 28822 | 22:42:36 INFO - PROCESS | 28822 | Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41288/tests/kraken/driver.html?testName=json-parse-financial) 22:42:36 INFO - PROCESS | 28822 | RSS: Main: 198856704 22:42:36 INFO - PROCESS | 28822 | 22:42:38 INFO - PROCESS | 28822 | Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:42:39 INFO - PROCESS | 28822 | RSS: Main: 198180864 22:42:39 INFO - PROCESS | 28822 | 22:42:40 INFO - PROCESS | 28822 | Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41288/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:42:41 INFO - PROCESS | 28822 | RSS: Main: 198250496 22:42:41 INFO - PROCESS | 28822 | 22:42:43 INFO - PROCESS | 28822 | Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:42:44 INFO - PROCESS | 28822 | RSS: Main: 198549504 22:42:44 INFO - PROCESS | 28822 | 22:42:47 INFO - PROCESS | 28822 | Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:42:48 INFO - PROCESS | 28822 | RSS: Main: 198680576 22:42:48 INFO - PROCESS | 28822 | 22:42:51 INFO - PROCESS | 28822 | Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:42:51 INFO - PROCESS | 28822 | RSS: Main: 198234112 22:42:51 INFO - PROCESS | 28822 | 22:42:53 INFO - PROCESS | 28822 | Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41288/tests/kraken/driver.html?testName=ai-astar) 22:42:54 INFO - PROCESS | 28822 | RSS: Main: 201330688 22:42:54 INFO - PROCESS | 28822 | 22:42:54 INFO - PROCESS | 28822 | __start_tp_report 22:42:54 INFO - PROCESS | 28822 | _x_x_mozilla_page_load 22:42:54 INFO - PROCESS | 28822 | _x_x_mozilla_page_load_details 22:42:54 INFO - PROCESS | 28822 | |i|pagename|runs| 22:42:54 INFO - PROCESS | 28822 | |0;ai-astar;112;119;120;119;118;120;121;120;118;119 22:42:54 INFO - PROCESS | 28822 | |1;audio-beat-detection;162;132;133;182;135;132;133;137;158;130 22:42:54 INFO - PROCESS | 28822 | |2;audio-dft;165;179;165;165;164;162;166;163;164;164 22:42:54 INFO - PROCESS | 28822 | |3;audio-fft;77;76;76;111;77;77;78;78;95;77 22:42:54 INFO - PROCESS | 28822 | |4;audio-oscillator;85;85;109;84;85;84;99;84;89;108 22:42:54 INFO - PROCESS | 28822 | |5;imaging-gaussian-blur;118;118;119;123;118;119;117;119;119;119 22:42:54 INFO - PROCESS | 28822 | |6;imaging-darkroom;148;148;149;148;149;154;149;153;149;149 22:42:54 INFO - PROCESS | 28822 | |7;imaging-desaturate;97;98;97;96;96;96;96;96;96;96 22:42:54 INFO - PROCESS | 28822 | |8;json-parse-financial;65;70;66;67;68;69;67;67;68;69 22:42:54 INFO - PROCESS | 28822 | |9;json-stringify-tinderbox;66;66;66;67;66;66;65;67;66;67 22:42:54 INFO - PROCESS | 28822 | |10;stanford-crypto-aes;89;88;87;88;88;86;85;86;87;91 22:42:54 INFO - PROCESS | 28822 | |11;stanford-crypto-ccm;166;170;154;142;158;148;150;145;212;151 22:42:54 INFO - PROCESS | 28822 | |12;stanford-crypto-pbkdf2;188;188;188;188;179;182;180;180;184;182 22:42:54 INFO - PROCESS | 28822 | |13;stanford-crypto-sha256-iterative;79;76;73;73;73;73;73;76;71;77 22:42:54 INFO - PROCESS | 28822 | __end_tp_report 22:42:54 INFO - PROCESS | 28822 | __start_cc_report 22:42:54 INFO - PROCESS | 28822 | _x_x_mozilla_cycle_collect,878 22:42:54 INFO - PROCESS | 28822 | __end_cc_report 22:42:54 INFO - PROCESS | 28822 | __startTimestamp1480574574007__endTimestamp 22:42:54 INFO - PROCESS | 28822 | 22:42:54 INFO - PROCESS | 28822 | ------- Summary: start ------- 22:42:54 INFO - PROCESS | 28822 | Number of tests: 14 22:42:54 INFO - PROCESS | 28822 | 22:42:54 INFO - PROCESS | 28822 | [#0] ai-astar Cycles:10 Average:118.60 Median:119.50 stddev:2.50 (2.1%) stddev-sans-first:1.00 22:42:54 INFO - PROCESS | 28822 | Values: 112.0 119.0 120.0 119.0 118.0 120.0 121.0 120.0 118.0 119.0 22:42:54 INFO - PROCESS | 28822 | 22:42:54 INFO - PROCESS | 28822 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:136.00 stddev:17.69 (13.0%) stddev-sans-first:17.44 22:42:54 INFO - PROCESS | 28822 | Values: 162.0 132.0 133.0 182.0 135.0 132.0 133.0 137.0 158.0 130.0 22:42:54 INFO - PROCESS | 28822 | 22:42:54 INFO - PROCESS | 28822 | [#2] audio-dft Cycles:10 Average:165.70 Median:165.00 stddev:4.81 (2.9%) stddev-sans-first:5.09 22:42:54 INFO - PROCESS | 28822 | Values: 165.0 179.0 165.0 165.0 164.0 162.0 166.0 163.0 164.0 164.0 22:42:54 INFO - PROCESS | 28822 | 22:42:54 INFO - PROCESS | 28822 | [#3] audio-fft Cycles:10 Average:82.20 Median:77.00 stddev:11.61 (15.1%) stddev-sans-first:12.16 22:42:54 INFO - PROCESS | 28822 | Values: 77.0 76.0 76.0 111.0 77.0 77.0 78.0 78.0 95.0 77.0 22:42:54 INFO - PROCESS | 28822 | 22:42:54 INFO - PROCESS | 28822 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:85.00 stddev:10.20 (12.0%) stddev-sans-first:10.56 22:42:54 INFO - PROCESS | 28822 | Values: 85.0 85.0 109.0 84.0 85.0 84.0 99.0 84.0 89.0 108.0 22:42:54 INFO - PROCESS | 28822 | 22:42:54 INFO - PROCESS | 28822 | [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:119.00 stddev:1.60 (1.3%) stddev-sans-first:1.66 22:42:54 INFO - PROCESS | 28822 | Values: 118.0 118.0 119.0 123.0 118.0 119.0 117.0 119.0 119.0 119.0 22:42:54 INFO - PROCESS | 28822 | 22:42:54 INFO - PROCESS | 28822 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:149.00 stddev:2.12 (1.4%) stddev-sans-first:2.17 22:42:54 INFO - PROCESS | 28822 | Values: 148.0 148.0 149.0 148.0 149.0 154.0 149.0 153.0 149.0 149.0 22:42:54 INFO - PROCESS | 28822 | 22:42:54 INFO - PROCESS | 28822 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 22:42:54 INFO - PROCESS | 28822 | Values: 97.0 98.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 22:42:54 INFO - PROCESS | 28822 | 22:42:54 INFO - PROCESS | 28822 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:68.00 stddev:1.51 (2.2%) stddev-sans-first:1.27 22:42:54 INFO - PROCESS | 28822 | Values: 65.0 70.0 66.0 67.0 68.0 69.0 67.0 67.0 68.0 69.0 22:42:54 INFO - PROCESS | 28822 | 22:42:54 INFO - PROCESS | 28822 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 22:42:54 INFO - PROCESS | 28822 | Values: 66.0 66.0 66.0 67.0 66.0 66.0 65.0 67.0 66.0 67.0 22:42:54 INFO - PROCESS | 28822 | 22:42:54 INFO - PROCESS | 28822 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:88.00 stddev:1.72 (1.9%) stddev-sans-first:1.73 22:42:54 INFO - PROCESS | 28822 | Values: 89.0 88.0 87.0 88.0 88.0 86.0 85.0 86.0 87.0 91.0 22:42:54 INFO - PROCESS | 28822 | 22:42:54 INFO - PROCESS | 28822 | [#11] stanford-crypto-ccm Cycles:10 Average:159.60 Median:156.00 stddev:20.42 (13.1%) stddev-sans-first:21.53 22:42:54 INFO - PROCESS | 28822 | Values: 166.0 170.0 154.0 142.0 158.0 148.0 150.0 145.0 212.0 151.0 22:42:54 INFO - PROCESS | 28822 | 22:42:54 INFO - PROCESS | 28822 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.90 Median:186.00 stddev:3.78 (2.0%) stddev-sans-first:3.71 22:42:54 INFO - PROCESS | 28822 | Values: 188.0 188.0 188.0 188.0 179.0 182.0 180.0 180.0 184.0 182.0 22:42:54 INFO - PROCESS | 28822 | 22:42:54 INFO - PROCESS | 28822 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:74.50 stddev:2.46 (3.3%) stddev-sans-first:1.96 22:42:54 INFO - PROCESS | 28822 | Values: 79.0 76.0 73.0 73.0 73.0 73.0 73.0 76.0 71.0 77.0 22:42:54 INFO - PROCESS | 28822 | -------- Summary: end -------- 22:42:54 INFO - PROCESS | 28822 | 22:42:55 INFO - TEST-INFO | 28822: exit 0 22:42:55 INFO - TEST-OK | kraken | took 65576ms 22:42:55 INFO - SUITE-END | took 1185s 22:42:55 INFO - Completed test suite (00:19:45) 22:42:55 INFO - javascript benchmark 22:42:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6193.223812894122, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2604.0885690008495, 2622.0, 2625.330540712118, 2627.697814751302, 2648.1393547097186, 4643.280291554806, 4716.976415117928, 4760.904781904364, 4809.158397280479, 4851.272309153629, 4700.412448443944, 4711.740854253015, 4730.19586670266, 4730.4559975602815, 4809.230523116302, 4310.094880075172, 4370.73775573465, 4390.758508282043, 4401.0977749561425, 4438.312061630452, 4381.3208952612395, 4422.137683151786, 4463.509014008457, 4504.234280172379, 4517.819287228507, 4439.0, 4499.797509112065, 4504.1892459357305, 4510.0, 4542.977285113569, 4243.257429949746, 4272.230998420283, 4283.357496375537, 4320.611144996966, 4334.024844410014, 4280.208161490134, 4301.204277208695, 4315.5900189481945, 4316.611504964537, 4316.870493885189, 4610.147122782262, 4637.072585482883, 4666.510016448258, 4678.976605116953, 4762.78567464465, 5023.8492845214705, 5028.748562571856, 5043.62172837035, 5045.132572283992, 5102.081625307444, 4945.480724523945, 5102.438731739506, 5121.795128194868, 5136.64043516954, 5176.50823171798, 4627.699199552018, 4674.766261686902, 4717.575418212377, 4732.574068333866, 4734.905301893943, 5146.0479811235045, 5172.172452407597, 5196.428392876781, 5245.213218017328, 5297.496737809902, 5012.04771093491, 5015.3229314042865, 5022.347094877642, 5027.069992051483, 5034.34553508049, 4889.804407823718, 4902.313676085351, 5058.241263810458, 5061.190209566452, 5073.441921388644, 4936.851894443173, 4939.160342741742, 4939.5554400104165, 4964.304997300381, 4976.62675299354, 5017.347744793154, 5056.393232812086, 5077.771500282496, 5078.542931136216, 5083.87290317745, 4277.572242775697, 4289.82840686369, 4299.484061912591, 4318.52496225415, 4346.521882592912, 3667.7799332040163, 3736.0473079364588, 3771.5097037385513, 3775.6979441644603, 3777.206786574795, 4210.642095421924, 4319.956800432018, 4341.0, 4343.891402714894, 4345.695801293942, 5122.820701275437, 5167.379914410295, 5167.68993860362, 5172.301739265151, 5216.347956505437, 4427.446569178853, 4429.80065897029, 4430.357598148251, 4440.045390241114, 4473.038296766211, 4384.364267181241, 4422.734635921791, 4629.745364005012, 4646.4888862225125, 4663.883402914887, 4511.548845115528, 4577.450705915311, 4579.977100114478, 4582.862514124582, 4588.17412865674, 4965.652404331662, 4967.652264341461, 4970.701757894538, 4972.8756781080765, 4975.0547395994645, 4634.582887540138, 4698.976505117453, 4712.151812673752, 4754.286856971482, 4825.758712064313, 5054.090263752413, 5055.064813009605, 5061.8734531637, 5067.113255180255, 5077.136886729339, 4984.825531106394, 5115.25828754821, 5118.3857937046305, 5125.256837758429, 5131.025105229995, 4885.1450996076255, 4928.482509336468, 4942.4316203637045, 4979.701217926936, 5051.722155281494, 4986.750662466935, 4989.12690279207, 4997.475265097112, 4998.425181104074, 5044.041632089891, 4896.902061958812, 4901.534354236342, 4927.704337739747, 4946.826861059845, 4979.751012449291, 4805.327254184487, 4829.27560865873, 4860.684055536379, 4943.555080042814, 4945.6043516517875, 4854.393200849894, 4875.512448755097, 4893.290472881341, 4895.094407534618, 4909.214525675875], "value": 4647.291316985572, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.2352550564436, 542.4087744358653, 543.9836804895853, 558.9547546088812, 559.8852235291765, 36972.81513592435, 38873.02817429562, 38937.61062389375, 42353.7882310588, 42575.361369579405, 37932.81033594835, 38443.0024096867, 38507.42238866419, 38606.22787544254, 38622.80688596553, 7498.662560184791, 7636.885446718304, 7639.961800190991, 7643.197464266227, 9466.19537339327, 9440.055994400574, 9741.074597913223, 9761.609535618567, 9769.755756106084, 9793.608255669764, 9904.801903961916, 9925.057119573665, 9926.702198934043, 9941.95609461007, 9950.601975920954, 9699.563519641633, 9774.853377199312, 9820.950895245478, 9829.410235385863, 9839.704808855675, 9651.565679544437, 9729.367591106555, 9729.756756081084, 9748.853767193426, 9752.853707194397, 37463.625363746556, 37838.054048649006, 37895.431568526496, 37924.0, 37993.0, 2863.1267463423646, 3092.8762849485993, 3174.6031746031745, 3278.50822376643, 3290.555774970372, 28010.859945700344, 28236.294092647644, 28428.0, 28857.711422885714, 29134.562981555293, 3354.480055591387, 3442.4147894857933, 3443.139215196201, 3451.447768357051, 3514.736394770377, 255223.0, 255840.0, 256063.0, 256434.0, 257036.0, 52783.736081319345, 53470.0, 53621.0, 53744.0, 53870.730646346514, 55655.443445565834, 55861.72069139628, 55965.0, 56093.71953140208, 56146.71926640422, 13989.3704783285, 14122.929385353007, 14145.43418263258, 14245.715085698228, 14252.786208206886, 8896.777580560538, 9137.451752894714, 10016.949915250523, 10321.0, 10666.78666426667, 17333.47999560015, 17647.470575882744, 17717.202725877367, 17813.376531821585, 17855.28578856831, 6466.741330346734, 6670.7665231716655, 6690.632015239111, 6814.114165158498, 6870.244273129952, 758.2682711183734, 881.0880738435688, 904.968326108583, 906.5557876640398, 938.9952750556838, 26490.86754566215, 27890.302742431602, 28063.298417539318, 28380.0, 28398.0, 914.8902131744234, 917.060013486182, 930.3812964378748, 934.9111834375724, 1030.1346868630387, 14279.143251404948, 14638.414463421344, 14713.705725885422, 14966.326515306837, 14967.77548336754, 347996.0, 350376.0, 353361.0, 353784.0, 354684.0, 48628.7568562162, 49319.84862195033, 49561.25658115131, 49570.50429495731, 49878.75060624674, 1130.1862658885589, 1168.7954607943575, 1172.7771723372532, 1174.6769638349522, 1181.7163880668577, 25630.102946396786, 26597.468050639265, 27244.72755272422, 27606.0, 27641.72358276472, 42894.14211715811, 43590.12819743524, 43598.56401435945, 43609.56390436182, 43610.781946090065, 307529.0, 308690.0, 309052.0, 311591.0, 311602.0, 21441.961139131978, 24183.39541511406, 24549.50900982006, 24618.630720539564, 24627.0, 35569.46645800367, 39835.60164398435, 40009.19866619266, 43493.56506434895, 43710.0, 34981.47527787034, 35183.82408087943, 35550.46674299836, 35647.28705425929, 35709.46435803517, 35298.29403411969, 35350.646493535765, 35361.82319088491, 35448.113797155274, 35617.1095722609, 34587.654123458444, 34597.827010864785, 34603.0, 34785.82607086949, 35487.467687984186, 29875.0, 32451.837740811145, 32622.021339359857, 32681.836590816893, 33006.17484562809, 24461.0, 24860.37849053788, 24877.253682389557, 25157.24528264155, 25294.58523099358], "value": 17652.42111658095, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.59214777601875, 343.8177765784132, 357.7889045463176, 359.20436233742265, 383.1035377217311, 15774.921125394372, 16062.83937160628, 17097.23062462189, 17131.0, 17201.82798172018, 15612.60968475786, 16128.193590320467, 16225.756613650805, 16638.50084497464, 16886.662266754658, 4350.717203381778, 4594.839180628679, 4645.0, 4649.279361698942, 4650.348951146842, 4588.128255631436, 4612.146752850734, 4613.976930115345, 4619.907601847961, 4626.05165940983, 4604.953950460503, 4618.515055919113, 5057.165567681328, 5307.946920530784, 5359.464053594648, 5408.296921400212, 5440.564754819625, 5444.8366549003595, 5446.700431476287, 5448.91826622597, 4514.277715565494, 4794.7842347094465, 4809.278608208761, 4885.487023862514, 5270.288511051036, 19373.031348432523, 19739.0, 19753.20987160512, 19977.80022199774, 20147.697784533244, 1714.953878134337, 1746.720524716052, 1809.1496996411797, 2001.7798042215345, 2354.4702441950426, 8975.28197744179, 8988.325875559294, 9273.536323183882, 9446.197073248783, 10468.371897686164, 1641.8850680452374, 1661.8753593480417, 1684.8146703862687, 1702.4637239269591, 1784.295203394652, 62983.6850815743, 63848.0, 64140.679296603215, 66582.0, 69861.3013869865, 9261.351705380694, 9374.484403357881, 9532.142107210384, 9728.75678108053, 10048.949755251177, 13062.869371306355, 13063.738725225443, 13066.477340906447, 13100.803487947689, 13136.40886160125, 6691.966540167268, 6851.143607049119, 6905.309469053054, 6976.500052488638, 7045.436365090781, 6417.518686098561, 6592.76925307612, 6752.257251702309, 6769.695363708546, 6781.152355955505, 3898.571157172709, 4085.4484644573195, 4088.5911408858874, 4130.277201489727, 4179.623833854967, 1617.126751554171, 1678.135760083558, 1715.1852869886955, 1723.629419674776, 1760.978632393209, 773.6286582440348, 802.2178376083272, 835.2983493865182, 848.1264297773304, 904.9683360968501, 16485.516253816084, 16605.252763625667, 16988.150592470327, 17023.574410639834, 17555.912220438815, 812.4800127918137, 817.5258350156895, 824.1099612418574, 860.0367588301143, 909.2089881802874, 9049.502277374808, 9128.132827381389, 9566.56950437232, 9616.326857119935, 9639.18066964302, 345938.0, 348722.0, 351294.0, 353682.0, 353868.0, 72509.91235131478, 74559.0, 75513.62243188749, 75973.0, 78810.21189788144, 825.9545724985063, 830.3647709502236, 835.3943391041568, 835.6532039203784, 837.535167981776, 14563.781543276647, 14832.332545035284, 14855.628609284422, 14861.182634954748, 15410.537683869501, 35912.281754365285, 36054.45918311175, 36619.267614647026, 37382.439263411616, 37587.436188456646, 47489.76255118702, 48432.5156748428, 49937.25094123519, 50495.74752126216, 51654.225186622985, 7228.674709638184, 7581.82481715335, 7607.733729319447, 7625.809354766176, 7693.1922148173635, 9023.601341792033, 10569.0, 11369.943150284196, 11568.710782230512, 11790.292582445081, 10551.894481055091, 10575.735606609896, 10598.682039538826, 10700.0, 10988.725281868017, 4742.857714268577, 9271.629134834531, 10286.794264114526, 10350.22373322019, 10377.066064054272, 10228.181745460493, 10542.841857371992, 10585.153187744809, 10776.67669969902, 11057.612983545538, 7484.139323977813, 7487.176410594939, 7489.66296516669, 7637.389008879388, 7853.685852566062, 7682.116556596063, 9820.65627703027, 10621.203409744454, 10632.25574209798, 10994.945025275143], "value": 7872.656582524478, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.2165583133867, 1375.635456604, 1430.1490613085218, 1601.3914712409282, 1632.7469242267446, 6043.18417013703, 6182.474489668372, 6309.116723658686, 6663.366980136885, 6703.0, 6724.293949135344, 6906.861862762742, 6915.723371065152, 7012.368886800187, 7023.7541686040995, 2060.4127823570284, 2101.548167144064, 2102.348272035666, 2105.4210092224607, 2105.9473513162216, 2053.7330147080856, 2057.5781964697276, 2060.5672808710187, 2085.228465467779, 2093.1627349060423, 2012.859099863003, 2015.5263513074415, 2024.615323088616, 2029.81731644152, 2046.5906818636258, 1999.3701983875105, 2020.595880823841, 2021.7674967378794, 2026.0275067967311, 2026.868253563521, 2054.969175462369, 2058.217877206667, 2073.668213085899, 2076.0553947953795, 2079.054030416157, 6830.45356371494, 6954.23503414624, 6962.895556566656, 6964.860702785916, 6966.686499107553, 4144.48193975753, 4276.23027854986, 4281.0, 4281.657467402601, 4286.592773686495, 2646.907358242452, 2804.4110736745306, 2875.4967880620807, 2942.558616207586, 2966.9109926702235, 834.2616784146014, 888.1606881496988, 904.6200595749801, 939.2908354192609, 948.9572969216333, 8919.509426981513, 8934.4192627479, 8951.73144805657, 8967.955160224223, 9068.183863452256, 3637.3452778499595, 3806.2197249563774, 3875.302445559826, 3905.7851818150275, 3959.7624142550962, 7867.72462963805, 7934.603269836485, 7943.801404964922, 7947.5231486111015, 7963.800904977422, 4275.46556680415, 4278.7004909656025, 4280.058387154821, 4281.529031806499, 4290.82836686529, 3314.0057982605604, 3419.880304189391, 3586.7847929124337, 3920.4903362562686, 3923.509561304837, 3216.1798741320813, 3302.4716045432615, 3406.9488957665653, 3410.5225268462436, 3411.4200585900458, 1073.1254027967182, 1082.6156714366443, 1085.3542142425244, 1109.1237922041657, 1112.5160555158532, 687.6458623808743, 825.6903661127077, 828.1676914700687, 838.2204549768774, 844.8817165596821, 4743.430788305425, 4772.093302272557, 4837.540433658797, 4869.464358920587, 4959.553640172402, 370.9554853417607, 376.5725901102269, 381.74232393134525, 382.11159055196777, 383.9443280724335, 3415.624281329052, 3516.771409858402, 3518.1908161123083, 3521.9471707924404, 3593.1915319053005, 8046.557439340775, 8354.707585234488, 8380.748577542561, 8386.077531471534, 8422.410431269753, 8233.259006689426, 8255.669773209005, 8296.419250652518, 8334.958325208336, 8388.203120703523, 6523.967380163069, 6556.082148499214, 6609.339066093448, 6612.0, 6642.269350371455, 4761.976190119166, 4764.690295130806, 4795.712257264575, 4922.4339200992345, 4994.625403094709, 7557.659905304385, 7572.356349710336, 7588.696452141852, 7655.846883062419, 7663.348615367756, 7649.464537482323, 7652.579108149105, 7721.343685786771, 7743.922560774546, 7779.72770953014, 5264.78940842362, 5996.8800623988145, 6044.24446944132, 6066.0, 6073.423024812636, 5910.586258961831, 6316.11574379578, 6476.287608363171, 6529.216494020748, 6581.440577550962, 5850.268716410449, 5962.761489540369, 5979.850503737442, 6027.156198132353, 6139.938600613937, 5923.141144533933, 5946.0, 5957.136215248851, 5962.850928726816, 5971.223740913827, 5527.088030475087, 5661.66030038199, 5670.064439367458, 5776.9133462998925, 5777.306723193244, 4154.937675934803, 4179.916401671889, 4284.335927931175, 4286.2284788738325, 4296.0, 4186.225548273579, 4215.13589714114, 4293.699441039097, 4314.741115533078, 4371.846985355497], "value": 3690.9456360010145, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.54107739233314, 294.6714413429026, 296.52555910543134, 298.40468265809704, 300.9458297506448, 4901.534354236351, 5018.2472629105605, 5023.296738456615, 5057.696538207711, 5092.275632536594, 4899.314096026559, 4938.08652894792, 4950.282209079682, 4951.29180432751, 4955.3310303109065, 3742.5134732484876, 3907.628775266345, 3919.627635374635, 3928.5874983126787, 3936.8622098226638, 3908.0, 3908.355121404979, 3910.1397692507603, 3915.804209789499, 3922.705797065217, 3862.7102967277424, 3872.2255548890193, 3881.243157584272, 3883.0874744435177, 3894.805259737016, 3873.2253549290112, 3906.5507466641134, 3909.648131668135, 3910.608939106081, 3912.921741565181, 3300.455424854896, 3440.397930362177, 3452.499387588811, 3473.218525831693, 3479.5128681984543, 4823.0, 4838.314735321895, 4842.975785121087, 4854.567902468781, 4868.537488938545, 4415.690901636886, 4419.801108950072, 4423.225935461282, 4459.777011149429, 4477.888052798674, 4985.975070124662, 5175.974120129413, 5181.538769084655, 5232.2674825524455, 5243.823813117551, 3759.2105657811894, 3760.285545746327, 3760.4547340635727, 3768.4724138620613, 3771.773693578394, 5417.864553386157, 5419.512243898029, 5438.211459338413, 5453.664336852252, 5461.808836690697, 3641.9453708194396, 3745.6816170625802, 3749.812509374575, 3776.3580191367532, 3779.848806047782, 3802.783109404964, 3813.932099012281, 3820.675242604354, 3840.558335791364, 3847.826847791856, 4340.696151269444, 4352.086061927031, 4352.412424322739, 4369.584889435499, 4374.278244089754, 5176.430592634807, 5186.429492755794, 5195.766190521435, 5199.428062913076, 5224.8171314004585, 1256.0203041627544, 1326.3500884566492, 1331.0616015708902, 1332.7134666046848, 1340.2025794652166, 836.6109758962111, 855.8587833007484, 859.5014891362995, 867.8004059066324, 874.4534665833854, 4369.366441865912, 4369.531214863656, 4399.890002749893, 4495.415595972503, 4591.44902611682, 5346.358436987586, 5385.6230063895155, 5403.216533602685, 5411.56707463402, 5417.702026388508, 4583.770811459413, 4599.609033232213, 4601.953980460153, 4603.217453032926, 4627.72737497191, 2716.9539727204774, 2737.8220415672918, 2769.3492029373083, 2784.220418282884, 2818.0, 4797.488791030814, 4834.347363106006, 4837.177679794443, 4841.661083724176, 4883.536064073907, 5323.0, 5343.0, 5361.35663720356, 5368.892622147535, 5369.670804101404, 4723.45680246776, 4864.562189402971, 4874.586369952674, 4877.365942427604, 4911.238757992517, 5240.737963101906, 5253.579713622978, 5257.974694934451, 5260.39610392858, 5275.709835959059, 5165.328507294028, 5180.896382072413, 5183.50756678115, 5193.636445448782, 5211.4527974562125, 4745.71878551065, 4750.904981900412, 4804.663673542958, 4846.297286893451, 4909.779059942382, 3579.35128005269, 3591.6947059500235, 3592.820358982093, 3615.794365437029, 3619.4570814377003, 5263.815766448156, 5268.736563171903, 5273.235380869675, 5275.709835959059, 5286.577073834161, 4917.893473968472, 5034.421041580265, 5068.721220332917, 5103.974480127576, 5133.050385678662, 5005.623453550157, 5036.722980235975, 5045.318881951036, 5135.589152867837, 5166.948330516797, 5038.186252949009, 5075.0, 5091.7087310709585, 5098.898022039464, 5116.437191908962, 4998.550710152072, 5067.391912970467, 5139.0, 5188.403333616682, 5196.116660167705, 4986.850394488171, 5057.128862320965, 5101.872453188552, 5139.871503212449, 5148.716820574904], "value": 3879.5041917543645, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.5119653081008, 638.2277444292406, 639.1907566246348, 727.5525551785651, 742.2392048150645, 11697.532098716052, 12710.618681439548, 12763.872361276384, 13921.930390348034, 14652.853471465281, 14431.206283654396, 14450.494232701858, 14699.779503307433, 14793.482228122019, 14843.628909277273, 722.8843385058378, 748.8352562436282, 753.0962844586518, 754.0574282147315, 755.2975732568709, 740.655595148256, 770.4298818874049, 772.3473664753302, 777.4247057177704, 778.3734094054284, 815.6859609050499, 815.8572249856281, 816.9346452283803, 818.7666515043214, 820.6266148902265, 807.5154907055778, 814.3566582399897, 814.6374863185885, 814.8044469327349, 814.9755507334789, 591.2343515147894, 592.5674257791793, 594.1325664529749, 598.4015984015984, 598.5331441475656, 13600.591982240549, 13890.58328250154, 13922.860771392257, 13964.860351396457, 13987.65030874226, 12667.619971400873, 12991.155574887602, 13000.219986800823, 13184.340782960813, 13273.800892986614, 10371.429571373572, 10572.894271057345, 10639.148868090535, 10693.037626613643, 10828.187885908588, 3159.8420078996187, 3243.5783348164823, 3248.7076163145193, 3249.4800831866787, 3288.145082278601, 65157.3484265156, 65599.0, 66007.66996165036, 66653.0, 66843.0, 10056.59773609062, 10061.39631622105, 10155.0, 10285.2800303978, 10312.48437578133, 18774.718379224323, 19060.52348691266, 19077.141528631244, 19106.140223689967, 19426.5143371414, 6323.0, 6545.232787147444, 6620.073189753439, 6701.229358623723, 6728.240747671024, 3598.47822065799, 3644.1436262478296, 3680.0983758979223, 3696.4085746280466, 3707.6663100321102, 2696.339396847746, 2808.761255293282, 2824.5904343870434, 2824.901128460494, 2831.4337132573155, 453.4105662638557, 454.1983399300238, 456.56170076726715, 459.0955817040425, 465.2439785348808, 540.6296686769575, 557.946995035471, 561.2759540193105, 563.492856429217, 570.7003822992879, 7955.920440795634, 7986.241307075818, 8071.636776345079, 8121.269085782308, 8209.630566624517, 511.71088335090553, 566.7591273708657, 574.7930744931821, 580.8576898659855, 605.6910975402576, 3762.7177961652988, 3763.360228761117, 3809.3524100902914, 3850.5956874528333, 4038.0, 56126.719366402904, 56424.79327273997, 70243.64878175576, 73769.0, 73821.6308918452, 64640.67679661571, 64963.35036649668, 65026.67486662536, 65053.67473162698, 65217.999999999054, 42726.35910461345, 55886.72056639691, 56272.99999999918, 57510.71244643834, 58388.41611583915, 7284.0, 7513.887291690519, 7595.962020189863, 7704.460687751804, 7760.767176984699, 39377.60622393739, 40585.59414405818, 40647.59352406438, 40849.0, 41321.380179296735, 49248.50751492583, 51067.744661276454, 54055.72972135114, 54518.0, 56120.0, 8692.521911294687, 8732.956335218283, 8955.910440895768, 9048.547572621474, 9108.316876234441, 10757.892421075689, 10771.246012779344, 10847.728806779895, 10880.347179169275, 10971.265968878239, 10000.199984001118, 10061.195104391778, 10332.328398654063, 10335.638252661422, 10376.221783366429, 9299.442033478013, 9422.434653920787, 9515.762105947406, 9590.232781377334, 9858.30991830565, 9770.804583908424, 9811.55847986828, 9945.403275803475, 10159.847602285823, 10347.482625868526, 8132.552709600792, 8503.319734421108, 8566.614502347285, 8659.870101948602, 8861.202491775772, 8523.701670441753, 8582.184692454206, 8600.569971501525, 8620.655173792979, 8710.91289087101], "value": 6101.098562734052, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1605.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 119.0, 120.0, 119.0, 118.0, 120.0, 121.0, 120.0, 118.0, 119.0], "value": 118.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 132.0, 133.0, 182.0, 135.0, 132.0, 133.0, 137.0, 158.0, 130.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 179.0, 165.0, 165.0, 164.0, 162.0, 166.0, 163.0, 164.0, 164.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 111.0, 77.0, 77.0, 78.0, 78.0, 95.0, 77.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 109.0, 84.0, 85.0, 84.0, 99.0, 84.0, 89.0, 108.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 123.0, 118.0, 119.0, 117.0, 119.0, 119.0, 119.0], "value": 118.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 149.0, 154.0, 149.0, 153.0, 149.0, 149.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 66.0, 67.0, 68.0, 69.0, 67.0, 67.0, 68.0, 69.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 65.0, 67.0, 66.0, 67.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 87.0, 88.0, 88.0, 86.0, 85.0, 86.0, 87.0, 91.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 154.0, 142.0, 158.0, 148.0, 150.0, 145.0, 212.0, 151.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 188.0, 188.0, 188.0, 179.0, 182.0, 180.0, 180.0, 184.0, 182.0], "value": 183.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 73.0, 73.0, 73.0, 73.0, 73.0, 76.0, 71.0, 77.0], "value": 74.4, "unit": "score"}]}]} 22:42:55 INFO - Return code: 0 22:42:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:42:55 ERROR - # TBPL SUCCESS # 22:42:55 INFO - Running post-action listener: _resource_record_post_action 22:42:55 INFO - [mozharness: 2016-12-01 06:42:55.809954Z] Finished run-tests step (success) 22:42:55 INFO - Running post-run listener: _resource_record_post_run 22:42:55 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400797696; Read time: 8; Write time: 356772 22:42:55 INFO - TinderboxPrint: CPU usage
13.5% 22:42:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 22:42:55 INFO - TinderboxPrint: I/O write bytes / time
400,797,696 / 356,772 22:42:55 INFO - TinderboxPrint: CPU idle
8,290.6 (86.5%) 22:42:55 INFO - TinderboxPrint: CPU user
1,231.0 (12.8%) 22:42:55 INFO - TinderboxPrint: Swap in / out
0 / 0 22:42:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110071808; Read time: 0; Write time: 81228 22:42:55 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 289759232; Read time: 0; Write time: 275520 22:42:56 INFO - Running post-run listener: _upload_blobber_files 22:42:56 INFO - Blob upload gear active. 22:42:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:42:56 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 22:42:56 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'] 22:42:56 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 22:42:56 INFO - (blobuploader) - INFO - Open directory for files ... 22:42:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:42:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:42:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:43:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:43:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:43:00 INFO - (blobuploader) - INFO - Done attempting. 22:43:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:43:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:43:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:43:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:43:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:43:01 INFO - (blobuploader) - INFO - Done attempting. 22:43:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:43:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:43:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:43:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:43:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:43:01 INFO - (blobuploader) - INFO - Done attempting. 22:43:01 INFO - (blobuploader) - INFO - Iteration through files over. 22:43:01 INFO - Return code: 0 22:43:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:43:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:43:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/90ded4e773b544c914f9cb7ecfa7d03dadff7907622264efca782e6bdaf2746424852cdac872efe6da7c038b61623c1456930df1ae91f5875280db52af974eb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f60563ac7aea6c928d61a6b870b13cc97e6195f90612a7d042d1cdcca02bf5a1945384adee302f938b71cadcc3fd6aa16cc349ba294c21cb3b88cf9f0a71510b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d1d1799767df885d903abf02660df0086ab93693e824486871228ee7bd2655c14ab188a720a4f327da449591f65250f4c6ed9ef5abf785f5856d3c14127dd6e7"} 22:43:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:43:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:43:01 INFO - Contents: 22:43:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/90ded4e773b544c914f9cb7ecfa7d03dadff7907622264efca782e6bdaf2746424852cdac872efe6da7c038b61623c1456930df1ae91f5875280db52af974eb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f60563ac7aea6c928d61a6b870b13cc97e6195f90612a7d042d1cdcca02bf5a1945384adee302f938b71cadcc3fd6aa16cc349ba294c21cb3b88cf9f0a71510b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d1d1799767df885d903abf02660df0086ab93693e824486871228ee7bd2655c14ab188a720a4f327da449591f65250f4c6ed9ef5abf785f5856d3c14127dd6e7"} 22:43:01 INFO - Running post-run listener: copy_logs_to_upload_dir 22:43:01 INFO - Copying logs to upload dir... 22:43:01 INFO - mkdir: /builds/slave/test/build/upload/logs 22:43:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.641529 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-11-30 22:43:01.538920) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 22:43:01.542029) ========= 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=af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/90ded4e773b544c914f9cb7ecfa7d03dadff7907622264efca782e6bdaf2746424852cdac872efe6da7c038b61623c1456930df1ae91f5875280db52af974eb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f60563ac7aea6c928d61a6b870b13cc97e6195f90612a7d042d1cdcca02bf5a1945384adee302f938b71cadcc3fd6aa16cc349ba294c21cb3b88cf9f0a71510b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d1d1799767df885d903abf02660df0086ab93693e824486871228ee7bd2655c14ab188a720a4f327da449591f65250f4c6ed9ef5abf785f5856d3c14127dd6e7"} build_url:https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011898 build_url: 'https://queue.taskcluster.net/v1/task/dATPQn1bTh2ijTEzvrnbQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/90ded4e773b544c914f9cb7ecfa7d03dadff7907622264efca782e6bdaf2746424852cdac872efe6da7c038b61623c1456930df1ae91f5875280db52af974eb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f60563ac7aea6c928d61a6b870b13cc97e6195f90612a7d042d1cdcca02bf5a1945384adee302f938b71cadcc3fd6aa16cc349ba294c21cb3b88cf9f0a71510b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d1d1799767df885d903abf02660df0086ab93693e824486871228ee7bd2655c14ab188a720a4f327da449591f65250f4c6ed9ef5abf785f5856d3c14127dd6e7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 22:43:01.569076) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 22:43:01.569396) ========= 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=af724c981e2a0f424dbabf99000001e7-1480573335.609274-1693302856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 22:43:01.653417) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 22:43:01.653743) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 22:43:01.654034) ========= ========= Total master_lag: 0.17 =========