builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-034 starttime: 1478808854.92 results: success (0) buildid: 20161110105820 builduid: b61a8979b5424f7f8ff8b6255e7ef817 revision: d38d06f85ef59c5dbb5d4a1a8d895957a78714de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 12:14:14.923572) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 12:14:14.924275) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 12:14:14.924555) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 12:14:14.942143) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 12:14:14.942413) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-10 12:14:15-- 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% 46.5M=0s 2016-11-10 12:14:15 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107062 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 12:14:15.062824) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 12:14:15.063137) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021788 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 12:14:15.112640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 12:14:15.112953) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev d38d06f85ef59c5dbb5d4a1a8d895957a78714de --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 d38d06f85ef59c5dbb5d4a1a8d895957a78714de --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=d6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-10 12:14:16,088 truncating revision to first 12 chars 2016-11-10 12:14:16,088 Setting DEBUG logging. 2016-11-10 12:14:16,088 attempt 1/10 2016-11-10 12:14:16,088 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/d38d06f85ef5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-10 12:14:16,404 unpacking tar archive at: graphics-d38d06f85ef5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618157 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 12:14:15.744894) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 12:14:15.745216) ========= script_repo_revision: d38d06f85ef59c5dbb5d4a1a8d895957a78714de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 12:14:15.745669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 12:14:15.745943) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 12:14:15.758748) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-11-10 12:14:15.759026) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:14:16 INFO - MultiFileLogger online at 20161110 12:14:16 in /builds/slave/test 12:14:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 12:14:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:14:16 INFO - {'append_to_log': False, 12:14:16 INFO - 'base_work_dir': '/builds/slave/test', 12:14:16 INFO - 'blob_upload_branch': 'Graphics', 12:14:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:14:16 INFO - 'branch': 'Graphics', 12:14:16 INFO - 'buildbot_json_path': 'buildprops.json', 12:14:16 INFO - 'config_files': ('talos/linux_config.py',), 12:14:16 INFO - 'default_actions': ('clobber', 12:14:16 INFO - 'read-buildbot-config', 12:14:16 INFO - 'download-and-extract', 12:14:16 INFO - 'populate-webroot', 12:14:16 INFO - 'create-virtualenv', 12:14:16 INFO - 'install', 12:14:16 INFO - 'run-tests'), 12:14:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:14:16 INFO - 'download_minidump_stackwalk': True, 12:14:16 INFO - 'download_symbols': 'ondemand', 12:14:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:14:16 INFO - 'tooltool.py': '/tools/tooltool.py', 12:14:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:14:16 INFO - '/tools/misc-python/virtualenv.py')}, 12:14:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:14:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:14:16 INFO - 'installer_path': 'installer.exe', 12:14:16 INFO - 'log_level': 'info', 12:14:16 INFO - 'log_name': 'talos', 12:14:16 INFO - 'log_to_console': True, 12:14:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:14:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:14:16 INFO - 'opt_config_files': (), 12:14:16 INFO - 'pip_index': False, 12:14:16 INFO - 'sps_profile': False, 12:14:16 INFO - 'sps_profile_interval': 0, 12:14:16 INFO - 'suite': 'dromaeojs', 12:14:16 INFO - 'system_bits': '32', 12:14:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:14:16 INFO - 'title': 'talos-linux64-ix-034', 12:14:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:14:16 INFO - 'use_talos_json': True, 12:14:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:14:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:14:16 INFO - 'work_dir': 'build'} 12:14:16 INFO - [mozharness: 2016-11-10 20:14:16.835170Z] Running clobber step. 12:14:16 INFO - Running pre-action listener: _resource_record_pre_action 12:14:16 INFO - Running main action method: clobber 12:14:16 INFO - rmtree: /builds/slave/test/build 12:14:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:14:17 INFO - Running post-action listener: _resource_record_post_action 12:14:17 INFO - [mozharness: 2016-11-10 20:14:17.803637Z] Finished clobber step (success) 12:14:17 INFO - [mozharness: 2016-11-10 20:14:17.803736Z] Running read-buildbot-config step. 12:14:17 INFO - Running pre-action listener: _resource_record_pre_action 12:14:17 INFO - Running main action method: read_buildbot_config 12:14:17 INFO - Using buildbot properties: 12:14:17 INFO - { 12:14:17 INFO - "project": "", 12:14:17 INFO - "product": "firefox", 12:14:17 INFO - "script_repo_revision": "default", 12:14:17 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 12:14:17 INFO - "repository": "", 12:14:17 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 12:14:17 INFO - "buildid": "20161110105820", 12:14:17 INFO - "pgo_build": "False", 12:14:17 INFO - "basedir": "/builds/slave/test", 12:14:17 INFO - "buildnumber": 0, 12:14:17 INFO - "slavename": "talos-linux64-ix-034", 12:14:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:14:17 INFO - "platform": "ubuntu64_hw", 12:14:17 INFO - "scheduler": "tests-graphics-linux64-talos", 12:14:17 INFO - "branch": "graphics", 12:14:17 INFO - "repo_path": "projects/graphics", 12:14:17 INFO - "revision": "d38d06f85ef59c5dbb5d4a1a8d895957a78714de", 12:14:17 INFO - "stage_platform": "linux64", 12:14:17 INFO - "builduid": "b61a8979b5424f7f8ff8b6255e7ef817", 12:14:17 INFO - "slavebuilddir": "test" 12:14:17 INFO - } 12:14:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:14:17 INFO - Running post-action listener: _resource_record_post_action 12:14:17 INFO - [mozharness: 2016-11-10 20:14:17.806179Z] Finished read-buildbot-config step (success) 12:14:17 INFO - [mozharness: 2016-11-10 20:14:17.806268Z] Running download-and-extract step. 12:14:17 INFO - Running pre-action listener: _resource_record_pre_action 12:14:17 INFO - Running main action method: download_and_extract 12:14:17 INFO - mkdir: /builds/slave/test/build/tests 12:14: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')]} 12:14:17 INFO - trying https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:14:17 INFO - Downloading https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:14:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:14:18 INFO - Downloaded 1361 bytes. 12:14:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:14:18 INFO - Using the following test package requirements: 12:14:18 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:14:18 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:14:18 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:14:18 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:18 INFO - u'jsshell-linux-x86_64.zip'], 12:14:18 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:14:18 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:14:18 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:14:18 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:14:18 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:14:18 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:14:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:14:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:14:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:14:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:14:18 INFO - Fetch https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:14:18 INFO - Http code: 200 12:14:18 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 12:14:18 INFO - x-amz-cf-id: u2YpJzWys6h9cPwTkffgwnaLv8SnhpMKpBuNBRvm9WK5inSEnSx5Sg== 12:14:18 INFO - x-amz-version-id: qacMonmIGAKBqrN.RxKYoignLxUs352G 12:14:19 INFO - Expected file size: 20414008 12:14:19 INFO - Obtained file size: 20414008 12:14:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:14:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:14:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:14:23 INFO - Fetch https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:14:23 INFO - Http code: 200 12:14:23 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 12:14:23 INFO - x-amz-cf-id: COlBAy76M0gbSrmoBym_0B6yxpAAgFGJX3W33A8Zi4ZGmZ61Q7L6Tg== 12:14:23 INFO - x-amz-version-id: qacMonmIGAKBqrN.RxKYoignLxUs352G 12:14:24 INFO - Expected file size: 20414008 12:14:24 INFO - Obtained file size: 20414008 12:14:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:14:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:14:28 INFO - Fetch https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:14:29 INFO - Http code: 200 12:14:29 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 12:14:29 INFO - x-amz-cf-id: MegWP21rwtNAp4U2tio4YBRw6bsQO-33CB9v_EN-VFN9omUa3krQ5A== 12:14:29 INFO - x-amz-version-id: fHBKzBxcqSkr1oo1ddrY.oNgGsz76O4r 12:14:29 INFO - Expected file size: 14409038 12:14:29 INFO - Obtained file size: 14409038 12:14: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')]} 12:14:29 INFO - trying https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:14:29 INFO - Downloading https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:14:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:14:30 INFO - Downloaded 55698414 bytes. 12:14:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:14:30 INFO - mkdir: /builds/slave/test/properties 12:14:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:14:30 INFO - Writing to file /builds/slave/test/properties/build_url 12:14:30 INFO - Contents: 12:14:30 INFO - build_url:https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:14:31 INFO - Running post-action listener: _resource_record_post_action 12:14:31 INFO - Running post-action listener: set_extra_try_arguments 12:14:31 INFO - [mozharness: 2016-11-10 20:14:31.258789Z] Finished download-and-extract step (success) 12:14:31 INFO - [mozharness: 2016-11-10 20:14:31.259018Z] Running populate-webroot step. 12:14:31 INFO - Running pre-action listener: _resource_record_pre_action 12:14:31 INFO - Running main action method: populate_webroot 12:14:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:14:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:14:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:14:31 INFO - '--tppagecycles', 12:14:31 INFO - '7'], 12:14:31 INFO - 'tests': ['tsvgm']}}, 12:14:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:14:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:14:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:14:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:14:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:14:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:14:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:31 INFO - 'talos_options': ['--disable-e10s'], 12:14:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:31 INFO - 'talos_options': ['--disable-e10s'], 12:14:31 INFO - 'tests': ['damp', 'tps']}, 12:14:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:31 INFO - 'tests': ['damp', 'tps']}, 12:14:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:14:31 INFO - 'tests': ['dromaeo_dom']}, 12:14:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:14:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:14:31 INFO - 'tests': ['basic_compositor_video']}, 12:14:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:14:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:14:31 INFO - 'tests': ['a11yr', 12:14:31 INFO - 'ts_paint', 12:14:31 INFO - 'tpaint', 12:14:31 INFO - 'sessionrestore', 12:14:31 INFO - 'sessionrestore_no_auto_restore', 12:14:31 INFO - 'tabpaint']}, 12:14:31 INFO - 'other-e10s': {'tests': ['a11yr', 12:14:31 INFO - 'ts_paint', 12:14:31 INFO - 'tpaint', 12:14:31 INFO - 'sessionrestore', 12:14:31 INFO - 'sessionrestore_no_auto_restore', 12:14:31 INFO - 'tabpaint']}, 12:14:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:14:31 INFO - 'ts_paint', 12:14:31 INFO - 'tpaint', 12:14:31 INFO - 'sessionrestore', 12:14:31 INFO - 'sessionrestore_no_auto_restore', 12:14:31 INFO - 'tabpaint']}, 12:14:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:14:31 INFO - 'ts_paint', 12:14:31 INFO - 'tpaint', 12:14:31 INFO - 'sessionrestore', 12:14:31 INFO - 'sessionrestore_no_auto_restore', 12:14:31 INFO - 'tabpaint']}, 12:14:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:14:31 INFO - 'tests': ['a11yr', 12:14:31 INFO - 'ts_paint', 12:14:31 INFO - 'tpaint', 12:14:31 INFO - 'sessionrestore', 12:14:31 INFO - 'sessionrestore_no_auto_restore', 12:14:31 INFO - 'tabpaint']}, 12:14:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:14:31 INFO - 'tests': ['a11yr', 12:14:31 INFO - 'ts_paint', 12:14:31 INFO - 'tpaint', 12:14:31 INFO - 'sessionrestore', 12:14:31 INFO - 'sessionrestore_no_auto_restore', 12:14:31 INFO - 'tabpaint']}, 12:14:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:14:31 INFO - 'tests': ['tsvgx', 12:14:31 INFO - 'tsvgr_opacity', 12:14:31 INFO - 'tart', 12:14:31 INFO - 'tscrollx', 12:14:31 INFO - 'cart']}, 12:14:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:14:31 INFO - 'tsvgr_opacity', 12:14:31 INFO - 'tart', 12:14:31 INFO - 'tscrollx', 12:14:31 INFO - 'cart']}, 12:14:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:31 INFO - 'talos_options': ['--disable-e10s'], 12:14:31 INFO - 'tests': ['tp5o']}, 12:14:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:31 INFO - 'tests': ['tp5o']}, 12:14:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:31 INFO - 'talos_options': ['--disable-e10s', 12:14:31 INFO - '--xperf_path', 12:14:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:31 INFO - 'tests': ['tp5n']}, 12:14:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:31 INFO - 'talos_options': ['--xperf_path', 12:14:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:31 INFO - 'tests': ['tp5n']}}, 12:14:31 INFO - 'talos.zip': {'path': '', 12:14:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:14:31 INFO - Running post-action listener: _resource_record_post_action 12:14:31 INFO - [mozharness: 2016-11-10 20:14:31.277728Z] Finished populate-webroot step (success) 12:14:31 INFO - [mozharness: 2016-11-10 20:14:31.277817Z] Running create-virtualenv step. 12:14:31 INFO - Running pre-action listener: _resource_record_pre_action 12:14:31 INFO - Running main action method: create_virtualenv 12:14:31 INFO - Creating virtualenv /builds/slave/test/build/venv 12:14:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:14:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:14:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:14:31 INFO - Using real prefix '/usr' 12:14:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:14:31 INFO - Installing distribute.............................................................................................................................................................................................done. 12:14:33 INFO - Installing pip.................done. 12:14:33 INFO - Return code: 0 12:14:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:14:34 INFO - Reading from file tmpfile_stdout 12:14:34 INFO - Output received: 12:14:34 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:14:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:34 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 0x7f4586226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5790>, '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 0x26a6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6b20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:14:34 INFO - Using env: {'DISPLAY': ':0', 12:14:34 INFO - 'HOME': '/home/cltbld', 12:14:34 INFO - 'LANG': 'en_US.UTF-8', 12:14:34 INFO - 'LANGUAGE': 'en_US:en', 12:14:34 INFO - 'LOGNAME': 'cltbld', 12:14:34 INFO - 'MAIL': '/var/mail/cltbld', 12:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:34 INFO - 'MOZ_NO_REMOTE': '1', 12:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:34 INFO - 'NO_EM_RESTART': '1', 12:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:34 INFO - 'PWD': '/builds/slave/test', 12:14:34 INFO - 'SHELL': '/bin/bash', 12:14:34 INFO - 'SHLVL': '1', 12:14:34 INFO - 'TERM': 'linux', 12:14:34 INFO - 'TMOUT': '86400', 12:14:34 INFO - 'USER': 'cltbld', 12:14:34 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 12:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:34 INFO - '_': '/tools/buildbot/bin/python'} 12:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:14:34 INFO - Cleaning up... 12:14:34 INFO - Return code: 0 12:14:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:34 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 0x7f4586226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5790>, '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 0x26a6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6b20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:14:34 INFO - Using env: {'DISPLAY': ':0', 12:14:34 INFO - 'HOME': '/home/cltbld', 12:14:34 INFO - 'LANG': 'en_US.UTF-8', 12:14:34 INFO - 'LANGUAGE': 'en_US:en', 12:14:34 INFO - 'LOGNAME': 'cltbld', 12:14:34 INFO - 'MAIL': '/var/mail/cltbld', 12:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:34 INFO - 'MOZ_NO_REMOTE': '1', 12:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:34 INFO - 'NO_EM_RESTART': '1', 12:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:34 INFO - 'PWD': '/builds/slave/test', 12:14:34 INFO - 'SHELL': '/bin/bash', 12:14:34 INFO - 'SHLVL': '1', 12:14:34 INFO - 'TERM': 'linux', 12:14:34 INFO - 'TMOUT': '86400', 12:14:34 INFO - 'USER': 'cltbld', 12:14:34 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 12:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:34 INFO - '_': '/tools/buildbot/bin/python'} 12:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:34 INFO - Downloading/unpacking psutil>=3.1.1 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:14:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:36 INFO - Installing collected packages: psutil 12:14:36 INFO - Running setup.py install for psutil 12:14:36 INFO - building 'psutil._psutil_linux' extension 12:14: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 12:14: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 12:14:36 INFO - building 'psutil._psutil_posix' extension 12:14: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 12:14: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 12:14:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:37 INFO - Successfully installed psutil 12:14:37 INFO - Cleaning up... 12:14:37 INFO - Return code: 0 12:14:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:37 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 0x7f4586226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5790>, '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 0x26a6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6b20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:14:37 INFO - Using env: {'DISPLAY': ':0', 12:14:37 INFO - 'HOME': '/home/cltbld', 12:14:37 INFO - 'LANG': 'en_US.UTF-8', 12:14:37 INFO - 'LANGUAGE': 'en_US:en', 12:14:37 INFO - 'LOGNAME': 'cltbld', 12:14:37 INFO - 'MAIL': '/var/mail/cltbld', 12:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:37 INFO - 'MOZ_NO_REMOTE': '1', 12:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:37 INFO - 'NO_EM_RESTART': '1', 12:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:37 INFO - 'PWD': '/builds/slave/test', 12:14:37 INFO - 'SHELL': '/bin/bash', 12:14:37 INFO - 'SHLVL': '1', 12:14:37 INFO - 'TERM': 'linux', 12:14:37 INFO - 'TMOUT': '86400', 12:14:37 INFO - 'USER': 'cltbld', 12:14:37 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 12:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:37 INFO - '_': '/tools/buildbot/bin/python'} 12:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:14:39 INFO - Installing collected packages: mozsystemmonitor 12:14:39 INFO - Running setup.py install for mozsystemmonitor 12:14:39 INFO - Successfully installed mozsystemmonitor 12:14:39 INFO - Cleaning up... 12:14:39 INFO - Return code: 0 12:14:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:14: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')]} 12:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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')]} 12:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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 0x7f4586226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5790>, '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 0x26a6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6b20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14: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 12:14: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 12:14:39 INFO - Using env: {'DISPLAY': ':0', 12:14:39 INFO - 'HOME': '/home/cltbld', 12:14:39 INFO - 'LANG': 'en_US.UTF-8', 12:14:39 INFO - 'LANGUAGE': 'en_US:en', 12:14:39 INFO - 'LOGNAME': 'cltbld', 12:14:39 INFO - 'MAIL': '/var/mail/cltbld', 12:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:39 INFO - 'MOZ_NO_REMOTE': '1', 12:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:39 INFO - 'NO_EM_RESTART': '1', 12:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:39 INFO - 'PWD': '/builds/slave/test', 12:14:39 INFO - 'SHELL': '/bin/bash', 12:14:39 INFO - 'SHLVL': '1', 12:14:39 INFO - 'TERM': 'linux', 12:14:39 INFO - 'TMOUT': '86400', 12:14:39 INFO - 'USER': 'cltbld', 12:14:39 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 12:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:39 INFO - '_': '/tools/buildbot/bin/python'} 12:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:39 INFO - Downloading/unpacking jsonschema==2.5.1 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:14:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14:41 INFO - Downloading functools32-3.2.3-2.tar.gz 12:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:14:41 INFO - warning: no files found matching '*.txt' 12:14:41 INFO - no previously-included directories found matching 'build' 12:14:41 INFO - no previously-included directories found matching 'dist' 12:14:41 INFO - no previously-included directories found matching '.git*' 12:14:41 INFO - Installing collected packages: jsonschema, functools32 12:14:41 INFO - Running setup.py install for functools32 12:14:41 INFO - warning: no files found matching '*.txt' 12:14:41 INFO - no previously-included directories found matching 'build' 12:14:42 INFO - no previously-included directories found matching 'dist' 12:14:42 INFO - no previously-included directories found matching '.git*' 12:14:42 INFO - Successfully installed jsonschema functools32 12:14:42 INFO - Cleaning up... 12:14:42 INFO - Return code: 0 12:14:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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', '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 0x7f4586226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5790>, '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 0x26a6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6b20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:14: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 functools32==3.2.3-2 12:14:42 INFO - Using env: {'DISPLAY': ':0', 12:14:42 INFO - 'HOME': '/home/cltbld', 12:14:42 INFO - 'LANG': 'en_US.UTF-8', 12:14:42 INFO - 'LANGUAGE': 'en_US:en', 12:14:42 INFO - 'LOGNAME': 'cltbld', 12:14:42 INFO - 'MAIL': '/var/mail/cltbld', 12:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:42 INFO - 'MOZ_NO_REMOTE': '1', 12:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:42 INFO - 'NO_EM_RESTART': '1', 12:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:42 INFO - 'PWD': '/builds/slave/test', 12:14:42 INFO - 'SHELL': '/bin/bash', 12:14:42 INFO - 'SHLVL': '1', 12:14:42 INFO - 'TERM': 'linux', 12:14:42 INFO - 'TMOUT': '86400', 12:14:42 INFO - 'USER': 'cltbld', 12:14:42 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 12:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:42 INFO - '_': '/tools/buildbot/bin/python'} 12:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:14:42 INFO - Cleaning up... 12:14:42 INFO - Return code: 0 12:14:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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 0x7f4586226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5790>, '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 0x26a6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6b20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14: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 12:14: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 12:14:42 INFO - Using env: {'DISPLAY': ':0', 12:14:42 INFO - 'HOME': '/home/cltbld', 12:14:42 INFO - 'LANG': 'en_US.UTF-8', 12:14:42 INFO - 'LANGUAGE': 'en_US:en', 12:14:42 INFO - 'LOGNAME': 'cltbld', 12:14:42 INFO - 'MAIL': '/var/mail/cltbld', 12:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:42 INFO - 'MOZ_NO_REMOTE': '1', 12:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:42 INFO - 'NO_EM_RESTART': '1', 12:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:42 INFO - 'PWD': '/builds/slave/test', 12:14:42 INFO - 'SHELL': '/bin/bash', 12:14:42 INFO - 'SHLVL': '1', 12:14:42 INFO - 'TERM': 'linux', 12:14:42 INFO - 'TMOUT': '86400', 12:14:42 INFO - 'USER': 'cltbld', 12:14:42 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 12:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:42 INFO - '_': '/tools/buildbot/bin/python'} 12:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:42 INFO - Downloading/unpacking blobuploader==1.2.4 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14:44 INFO - Downloading blobuploader-1.2.4.tar.gz 12:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:14:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:14:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:45 INFO - Downloading docopt-0.6.1.tar.gz 12:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:14:45 INFO - Installing collected packages: blobuploader, requests, docopt 12:14:45 INFO - Running setup.py install for blobuploader 12:14:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:14:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:14:45 INFO - Running setup.py install for requests 12:14:45 INFO - Running setup.py install for docopt 12:14:45 INFO - Successfully installed blobuploader requests docopt 12:14:45 INFO - Cleaning up... 12:14:46 INFO - Return code: 0 12:14:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:46 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 0x7f4586226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5790>, '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 0x26a6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6b20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:14:46 INFO - Using env: {'DISPLAY': ':0', 12:14:46 INFO - 'HOME': '/home/cltbld', 12:14:46 INFO - 'LANG': 'en_US.UTF-8', 12:14:46 INFO - 'LANGUAGE': 'en_US:en', 12:14:46 INFO - 'LOGNAME': 'cltbld', 12:14:46 INFO - 'MAIL': '/var/mail/cltbld', 12:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:46 INFO - 'MOZ_NO_REMOTE': '1', 12:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:46 INFO - 'NO_EM_RESTART': '1', 12:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:46 INFO - 'PWD': '/builds/slave/test', 12:14:46 INFO - 'SHELL': '/bin/bash', 12:14:46 INFO - 'SHLVL': '1', 12:14:46 INFO - 'TERM': 'linux', 12:14:46 INFO - 'TMOUT': '86400', 12:14:46 INFO - 'USER': 'cltbld', 12:14:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 12:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:46 INFO - '_': '/tools/buildbot/bin/python'} 12:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:46 INFO - Running setup.py (path:/tmp/pip-IIZMV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:46 INFO - Running setup.py (path:/tmp/pip-EyO7BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:46 INFO - Running setup.py (path:/tmp/pip-liup2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:46 INFO - Running setup.py (path:/tmp/pip-1NbSHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:46 INFO - Running setup.py (path:/tmp/pip-M1B10O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:46 INFO - Running setup.py (path:/tmp/pip-mr8ALk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:46 INFO - Running setup.py (path:/tmp/pip-5zoyNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:46 INFO - Running setup.py (path:/tmp/pip-PPLJMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:46 INFO - Running setup.py (path:/tmp/pip-qfpdKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:46 INFO - Running setup.py (path:/tmp/pip-6pKTgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:46 INFO - Running setup.py (path:/tmp/pip-48lO6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:47 INFO - Running setup.py (path:/tmp/pip-njrQtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:47 INFO - Running setup.py (path:/tmp/pip-mWR5Eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:47 INFO - Running setup.py (path:/tmp/pip-oBAosy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:47 INFO - Running setup.py (path:/tmp/pip-7tCXXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:47 INFO - Running setup.py (path:/tmp/pip-mfO0Mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:47 INFO - Running setup.py (path:/tmp/pip-jpekLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:14:47 INFO - Running setup.py install for manifestparser 12:14:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:14:47 INFO - Running setup.py install for mozcrash 12:14:47 INFO - Running setup.py install for mozdebug 12:14:47 INFO - Running setup.py install for mozdevice 12:14:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:14:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:14:47 INFO - Running setup.py install for mozfile 12:14:48 INFO - Running setup.py install for mozhttpd 12:14:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Running setup.py install for mozinfo 12:14:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Running setup.py install for mozInstall 12:14:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Running setup.py install for mozleak 12:14:48 INFO - Running setup.py install for mozlog 12:14:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Running setup.py install for moznetwork 12:14:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Running setup.py install for mozprocess 12:14:48 INFO - Running setup.py install for mozprofile 12:14:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:14:48 INFO - Running setup.py install for mozrunner 12:14:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:14:49 INFO - Running setup.py install for mozscreenshot 12:14:49 INFO - Running setup.py install for moztest 12:14:49 INFO - Running setup.py install for mozversion 12:14:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:14:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:14:49 INFO - Cleaning up... 12:14:49 INFO - Return code: 0 12:14:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:49 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 0x7f4586226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5790>, '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 0x26a6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6b20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:14:49 INFO - Using env: {'DISPLAY': ':0', 12:14:49 INFO - 'HOME': '/home/cltbld', 12:14:49 INFO - 'LANG': 'en_US.UTF-8', 12:14:49 INFO - 'LANGUAGE': 'en_US:en', 12:14:49 INFO - 'LOGNAME': 'cltbld', 12:14:49 INFO - 'MAIL': '/var/mail/cltbld', 12:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:49 INFO - 'MOZ_NO_REMOTE': '1', 12:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:49 INFO - 'NO_EM_RESTART': '1', 12:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:49 INFO - 'PWD': '/builds/slave/test', 12:14:49 INFO - 'SHELL': '/bin/bash', 12:14:49 INFO - 'SHLVL': '1', 12:14:49 INFO - 'TERM': 'linux', 12:14:49 INFO - 'TMOUT': '86400', 12:14:49 INFO - 'USER': 'cltbld', 12:14:49 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 12:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:49 INFO - '_': '/tools/buildbot/bin/python'} 12:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:49 INFO - Running setup.py (path:/tmp/pip-z1YjRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14: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)) 12:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:49 INFO - Running setup.py (path:/tmp/pip-mF3fEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14: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)) 12:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:49 INFO - Running setup.py (path:/tmp/pip-v40x_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14: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)) 12:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:49 INFO - Running setup.py (path:/tmp/pip-uw0iJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:49 INFO - Running setup.py (path:/tmp/pip-SUWosX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14: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)) 12:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:49 INFO - Running setup.py (path:/tmp/pip-Pcx9NX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14: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)) 12:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:49 INFO - Running setup.py (path:/tmp/pip-7vpamS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:50 INFO - Running setup.py (path:/tmp/pip-QL5NjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:50 INFO - Running setup.py (path:/tmp/pip-Vxf_jX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:50 INFO - Running setup.py (path:/tmp/pip-O8EWIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:50 INFO - Running setup.py (path:/tmp/pip-pMqpq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:50 INFO - Running setup.py (path:/tmp/pip-qMABSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14: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)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:50 INFO - Running setup.py (path:/tmp/pip-_UQ2Ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14: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)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:50 INFO - Running setup.py (path:/tmp/pip-o0ZQ5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14: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)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:50 INFO - Running setup.py (path:/tmp/pip-jO2dIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14: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)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:50 INFO - Running setup.py (path:/tmp/pip-GPDTQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14: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)) 12:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:50 INFO - Running setup.py (path:/tmp/pip-pN2u80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14: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)) 12:14: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)) 12:14: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)) 12:14: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)) 12:14: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:14: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:14:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14:52 INFO - Downloading blessings-1.6.tar.gz 12:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:14:52 INFO - Installing collected packages: blessings 12:14:52 INFO - Running setup.py install for blessings 12:14:52 INFO - Successfully installed blessings 12:14:52 INFO - Cleaning up... 12:14:52 INFO - Return code: 0 12:14:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:14:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:53 INFO - Reading from file tmpfile_stdout 12:14:53 INFO - Current package versions: 12:14:53 INFO - argparse == 1.2.1 12:14:53 INFO - blessings == 1.6 12:14:53 INFO - blobuploader == 1.2.4 12:14:53 INFO - docopt == 0.6.1 12:14:53 INFO - functools32 == 3.2.3-2 12:14:53 INFO - jsonschema == 2.5.1 12:14:53 INFO - manifestparser == 1.1 12:14:53 INFO - mozInstall == 1.12 12:14:53 INFO - mozcrash == 1.0 12:14:53 INFO - mozdebug == 0.1 12:14:53 INFO - mozdevice == 0.48 12:14:53 INFO - mozfile == 1.2 12:14:53 INFO - mozhttpd == 0.7 12:14:53 INFO - mozinfo == 0.9 12:14:53 INFO - mozleak == 0.1 12:14:53 INFO - mozlog == 3.4 12:14:53 INFO - moznetwork == 0.27 12:14:53 INFO - mozprocess == 0.23 12:14:53 INFO - mozprofile == 0.28 12:14:53 INFO - mozrunner == 6.13 12:14:53 INFO - mozscreenshot == 0.1 12:14:53 INFO - mozsystemmonitor == 0.3 12:14:53 INFO - moztest == 0.7 12:14:53 INFO - mozversion == 1.4 12:14:53 INFO - psutil == 3.1.1 12:14:53 INFO - requests == 1.2.3 12:14:53 INFO - wsgiref == 0.1.2 12:14:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14: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')]} 12:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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')]} 12:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:53 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 0x7f4586226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5790>, '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 0x26a6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6b20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:14:53 INFO - Using env: {'DISPLAY': ':0', 12:14:53 INFO - 'HOME': '/home/cltbld', 12:14:53 INFO - 'LANG': 'en_US.UTF-8', 12:14:53 INFO - 'LANGUAGE': 'en_US:en', 12:14:53 INFO - 'LOGNAME': 'cltbld', 12:14:53 INFO - 'MAIL': '/var/mail/cltbld', 12:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:53 INFO - 'MOZ_NO_REMOTE': '1', 12:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:53 INFO - 'NO_EM_RESTART': '1', 12:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:53 INFO - 'PWD': '/builds/slave/test', 12:14:53 INFO - 'SHELL': '/bin/bash', 12:14:53 INFO - 'SHLVL': '1', 12:14:53 INFO - 'TERM': 'linux', 12:14:53 INFO - 'TMOUT': '86400', 12:14:53 INFO - 'USER': 'cltbld', 12:14:53 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 12:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:53 INFO - '_': '/tools/buildbot/bin/python'} 12:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14: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)) 12:14: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)) 12:14: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)) 12:14: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)) 12:14: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)) 12:14: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)) 12:14: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)) 12:14: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)) 12:14: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)) 12:14: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)) 12:14: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)) 12:14:53 INFO - Cleaning up... 12:14:53 INFO - Return code: 0 12:14:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:14: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')]} 12:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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')]} 12:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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 0x7f4586226f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26167b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5790>, '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 0x26a6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6b20>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:14: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 12:14: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 12:14:53 INFO - Using env: {'DISPLAY': ':0', 12:14:53 INFO - 'HOME': '/home/cltbld', 12:14:53 INFO - 'LANG': 'en_US.UTF-8', 12:14:53 INFO - 'LANGUAGE': 'en_US:en', 12:14:53 INFO - 'LOGNAME': 'cltbld', 12:14:53 INFO - 'MAIL': '/var/mail/cltbld', 12:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:53 INFO - 'MOZ_NO_REMOTE': '1', 12:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:53 INFO - 'NO_EM_RESTART': '1', 12:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:53 INFO - 'PWD': '/builds/slave/test', 12:14:53 INFO - 'SHELL': '/bin/bash', 12:14:53 INFO - 'SHLVL': '1', 12:14:53 INFO - 'TERM': 'linux', 12:14:53 INFO - 'TMOUT': '86400', 12:14:53 INFO - 'USER': 'cltbld', 12:14:53 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 12:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:53 INFO - '_': '/tools/buildbot/bin/python'} 12:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:14:53 INFO - Cleaning up... 12:14:53 INFO - Return code: 0 12:14:53 INFO - Running post-action listener: _resource_record_post_action 12:14:53 INFO - Running post-action listener: _start_resource_monitoring 12:14:53 INFO - Starting resource monitoring. 12:14:53 INFO - [mozharness: 2016-11-10 20:14:53.674302Z] Finished create-virtualenv step (success) 12:14:53 INFO - [mozharness: 2016-11-10 20:14:53.674803Z] Running install step. 12:14:53 INFO - Running pre-action listener: _resource_record_pre_action 12:14:53 INFO - Running main action method: install 12:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:53 INFO - Reading from file tmpfile_stdout 12:14:53 INFO - Detecting whether we're running mozinstall >=1.0... 12:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:14:53 INFO - Reading from file tmpfile_stdout 12:14:53 INFO - Output received: 12:14:53 INFO - Usage: mozinstall [options] installer 12:14:53 INFO - Options: 12:14:53 INFO - -h, --help show this help message and exit 12:14:53 INFO - -d DEST, --destination=DEST 12:14:53 INFO - Directory to install application into. [default: 12:14:53 INFO - "/builds/slave/test"] 12:14:53 INFO - --app=APP Application being installed. [default: firefox] 12:14:53 INFO - mkdir: /builds/slave/test/build/application 12:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:15:10 INFO - Reading from file tmpfile_stdout 12:15:10 INFO - Output received: 12:15:10 INFO - /builds/slave/test/build/application/firefox/firefox 12:15:10 INFO - Running post-action listener: _resource_record_post_action 12:15:10 INFO - [mozharness: 2016-11-10 20:15:10.033414Z] Finished install step (success) 12:15:10 INFO - [mozharness: 2016-11-10 20:15:10.033658Z] Running run-tests step. 12:15:10 INFO - Running pre-action listener: _resource_record_pre_action 12:15:10 INFO - Running main action method: run_tests 12:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:15:10 INFO - Python 2.7.3 12:15:10 INFO - Return code: 0 12:15:10 INFO - grabbing minidump binary from tooltool 12:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:10 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 0x26a5790>, '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 0x26a6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:15:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:15:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:15:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:15:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:15:10 INFO - Return code: 0 12:15:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:15:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:15:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:15:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:15:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:15:10 INFO - Using env: {'DISPLAY': ':0', 12:15:10 INFO - 'HOME': '/home/cltbld', 12:15:10 INFO - 'LANG': 'en_US.UTF-8', 12:15:10 INFO - 'LANGUAGE': 'en_US:en', 12:15:10 INFO - 'LOGNAME': 'cltbld', 12:15:10 INFO - 'MAIL': '/var/mail/cltbld', 12:15:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:15:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:10 INFO - 'MOZ_NO_REMOTE': '1', 12:15:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:10 INFO - 'NO_EM_RESTART': '1', 12:15:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:10 INFO - 'PWD': '/builds/slave/test', 12:15:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:15:10 INFO - 'SHELL': '/bin/bash', 12:15:10 INFO - 'SHLVL': '1', 12:15:10 INFO - 'TERM': 'linux', 12:15:10 INFO - 'TMOUT': '86400', 12:15:10 INFO - 'USER': 'cltbld', 12:15:10 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391', 12:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:10 INFO - '_': '/tools/buildbot/bin/python'} 12:15:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:15:10 INFO - mozversion application_buildid: 20161110105820 12:15:10 INFO - mozversion application_changeset: d38d06f85ef59c5dbb5d4a1a8d895957a78714de 12:15:10 INFO - mozversion application_display_name: Nightly 12:15:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:15:10 INFO - mozversion application_name: Firefox 12:15:10 INFO - mozversion application_remotingname: firefox 12:15:10 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 12:15:10 INFO - mozversion application_vendor: Mozilla 12:15:10 INFO - mozversion application_version: 52.0a1 12:15:10 INFO - mozversion platform_buildid: 20161110105820 12:15:10 INFO - mozversion platform_changeset: d38d06f85ef59c5dbb5d4a1a8d895957a78714de 12:15:10 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 12:15:10 INFO - mozversion platform_version: 52.0a1 12:15:10 INFO - using testdate: 1478808910 12:15:10 INFO - actual date: 1478808910 12:15:10 INFO - starting webserver on 'localhost:42184' 12:15:10 INFO - SUITE-START | Running 2 tests 12:15:10 INFO - TEST-START | dromaeo_css 12:15:10 INFO - operating with platform_type : linux_ 12:15:10 INFO - Initialising browser for dromaeo_css test... 12:15:10 INFO - TEST-INFO | started process 16670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHXIXQc/profile http://localhost:42184/getInfo.html) 12:15:14 INFO - PROCESS | 16670 | __metrics Screen width/height:1600/1200 12:15:14 INFO - PROCESS | 16670 | colorDepth:24 12:15:14 INFO - PROCESS | 16670 | Browser inner width/height: 1024/697 12:15:14 INFO - PROCESS | 16670 | __metrics 12:15:15 INFO - PROCESS | 16670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:15:15 INFO - PROCESS | 16670 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:15:15 INFO - PROCESS | 16670 | console.error: PushService: 12:15:15 INFO - PROCESS | 16670 | stateChangeProcessEnqueue: Error transitioning state 12:15:15 INFO - PROCESS | 16670 | UnknownError 12:15:16 INFO - TEST-INFO | 16670: exit 0 12:15:16 INFO - Browser initialized. 12:15:16 INFO - Running cycle 1/1 for dromaeo_css test... 12:15:16 INFO - TEST-INFO | started process 16755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHXIXQc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:29 INFO - PROCESS | 16755 | RSS: Main: 174329856 12:15:29 INFO - PROCESS | 16755 | 12:16:20 INFO - PROCESS | 16755 | 1478808980092 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] 12:18:34 INFO - PROCESS | 16755 | Cycle 1(1): loaded http://localhost:42184/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42184/tests/dromaeo/cssquery-ext.html) 12:18:36 INFO - PROCESS | 16755 | RSS: Main: 322228224 12:18:36 INFO - PROCESS | 16755 | 12:21:38 INFO - PROCESS | 16755 | Cycle 1(1): loaded http://localhost:42184/tests/dromaeo/cssquery-ext.html (next: http://localhost:42184/tests/dromaeo/cssquery-jquery.html) 12:21:39 INFO - PROCESS | 16755 | RSS: Main: 282787840 12:21:39 INFO - PROCESS | 16755 | 12:24:41 INFO - PROCESS | 16755 | Cycle 1(1): loaded http://localhost:42184/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42184/tests/dromaeo/cssquery-mootools.html) 12:24:42 INFO - PROCESS | 16755 | RSS: Main: 218222592 12:24:42 INFO - PROCESS | 16755 | 12:27:44 INFO - PROCESS | 16755 | Cycle 1(1): loaded http://localhost:42184/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42184/tests/dromaeo/cssquery-prototype.html) 12:27:45 INFO - PROCESS | 16755 | RSS: Main: 219697152 12:27:45 INFO - PROCESS | 16755 | 12:30:48 INFO - PROCESS | 16755 | Cycle 1(1): loaded http://localhost:42184/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42184/tests/dromaeo/cssquery-yui.html) 12:30:49 INFO - PROCESS | 16755 | RSS: Main: 219439104 12:30:49 INFO - PROCESS | 16755 | 12:33:52 INFO - PROCESS | 16755 | Cycle 1(1): loaded http://localhost:42184/tests/dromaeo/cssquery-yui.html (next: http://localhost:42184/tests/dromaeo/cssquery-dojo.html) 12:33:52 INFO - PROCESS | 16755 | RSS: Main: 315678720 12:33:52 INFO - PROCESS | 16755 | 12:33:52 INFO - PROCESS | 16755 | __start_tp_report 12:33:52 INFO - PROCESS | 16755 | _x_x_mozilla_page_load 12:33:52 INFO - PROCESS | 16755 | _x_x_mozilla_page_load_details 12:33:52 INFO - PROCESS | 16755 | |i|pagename|runs| 12:33:52 INFO - PROCESS | 16755 | |0;dojo.html;2609.8173127881046;2618.934526636835;2642.312998620359;2658.189252278056;2672.078133044099;4537;4620.191466493367;4644.187267228234;4667.323238130469;4675.228587283098;4553.248713962201;4597.954020459794;4631;4654.418197725285;4666.78999445025;4222.59885310895;4284.164587905359;4302.612764851163;4332.956670433303;4353.67347448941;3989.7406668566596;4371.191329604034;4373.497047839507;4394.1870753910625;4430.357598148266;4235.301175306071;4350.303951367798;4357.934630980538;4406.603405693487;4460.643148548108;4288.185244803477;4347.478302603708;4350.630196433307;4358.651307895392;4362.694611377205;4224.302990006645;4250.213710463543;4321.891952701176;4332.0469496710675;4332.870013899588;4590.655700822418;4593.058423023273;4596.632269418438;4648.837290694843;4663.48701642819;4942.382202224722;4948.035133149037;4948.233023881304;4961.5038496150455;4979.925301120486;4830.951690483121;4873.6832105913;4887.266909963499;4968;5033.723145227011;4572.565606267399;4619.69971951822;4630.120277147331;4639.884002899955;4717;5026.824061157842;5071.163258062378;5071.518205770446;5080;5125.282460455539;4816.8795780105775;4866.489018653061;4878.341423907798;4884.145274577006;4916.631252656065;4912.189488734319;4924.852254432372;4943.653944223942;4952.356193694796;5009.44896061433;4897.314375987365;4913.238448040559;4915.975420122948;4926.1379258629595;4979.278004689299;4935.3090567320605;4965.280034394992;4980.8754781130765;4981.850544483671;5028.748562571856;4091.202215567995;4135.028268356994;4136.462259906253;4142.420061191436;4182.686298527623;3665.706743460517;3677.2645470905927;3687.391580389206;3718.5537735471917;3730.421784623388;4378.868633940987;4387.254166791653;4389.648828093745;4410.757408342508;4440.2007638625355;4878.609711223094;4937.456879743226;4942.678725882806;5073.797048118107;5100.923486147711;4281.614654681093;4326.437563116775;4327.891802704958;4341.674374421931;4385.583369579948;4456.264716321835;4466.240739074366;4466.620337271368;4468.55314468557;4515.571020753023;4613.7923793430045;4673.6494762892235;4675.696079754805;4684;4711.26975318833;4985.750712464434;5006.874828129326;5049.394072711299;5067.949320506747;5071.949280507148;4730.763461826964;4733.171694953438;4744.098621261949;4754.619630429488;4773.856784296477;4979.327790748347;4979.825706100269;4984.028114517634;4985.1276026695905;5033.446320904771;4856.562909338035;4900.681455705368;4939.580135688363;4984.925226121539;5028.9245661315845;4906.215005599087;4907.705537667752;4924.630652701134;4935.037667654773;4952.232403977389;4901.975490122527;4911.287863259879;4913.091078150554;4921.237208232729;4921.926171107508;4734.905301893874;4748.715077095385;4798.064377446504;4865.416150062015;4885.193942999507;4892.996935628116;4954.331165292783;4958.281049247911;4998.87502812418;5000.724960127228;4685.835995740133;4721.858344249678;4838.588719958702;4848.10310092634;4897.9510204898925 12:33:52 INFO - PROCESS | 16755 | |1;ext.html;543.6466296907013;545.9754311056003;556.6020295488725;559.2115117684066;578.245389766355;27609.858521221828;37933.43099853501;39374.01564960874;39602.40596391049;42755.35866961998;38698.61301386985;39233.21533569327;39267.60732392675;39267.60732392675;39326.41010384839;7441.069866266716;7590.278923502258;7590.3548198403205;7591.924080759177;7595.848083038363;7346.853062938738;7440.2931721486375;7441.367483763859;7443.292887175709;7443.925560744377;7396.519226250277;7470.813229669275;7474.701011959515;7475.476716629838;7479.252074792505;7349.448791340671;7406.962965185194;7413.036305280333;7453.291937265951;7458.366038886728;7451.590162541058;7526.36025937796;7526.586037767921;7533.54798712079;7533.811654708621;36491.4526282106;36651.816740916394;36847.815760921025;36888.26223475515;37084.25831483382;2896.139476961395;2955.852207389622;2974.866131024109;3009.6087508623737;3053.114596766935;27350.45299094007;28215.57676634852;28338.433231335464;29033.274168145756;29071.854640726662;3466.6706662866986;3468.219650578625;3502.6322236165347;3698.204885949534;3715.1269451678836;232018;232019;232188;232592;232649;48315.75842120767;48375.75812120917;48419;48692.26961595579;48726.26910596344;50850.49149508531;51062.489375105775;51133;51177;51182;13805.930970345084;13904.652383690489;14088.295585220698;14092.577222683336;14412.207328596818;10799.406032668121;10914.508847101899;10922.617708380169;10923.180761442924;10941.56233750657;17239.74140387895;17274.13629318529;17305;17420.47738567845;17441.65116697659;6683.298253683391;6697.229818570927;6891.552049116792;6896.310368963063;6918.751405793138;793.3296364571928;824.6618886256726;885.933554983366;940.374650857186;942.7829961643629;26273.737262627128;26795.33011674724;26908.593289582645;27478.17565473039;27545.724542754317;875.4397185801092;891.5586784541694;939.1125386509683;988.3131223799534;1046.1526163807341;14354.784678229835;14406.783898241325;14440.927795360956;14646.926765366105;14697.485588004369;336559;339780;339786;340004;340306;46499;46963;47097;47115.76442117836;47159.5284047162;1064.669952314785;1093.9507722152523;1103.1615971861604;1166.5158959032076;1187.8633957095044;26130.608040879022;27428;28012.85993570019;28559.42881142407;28577;38234.80882595569;38761;38835.61164388433;38842.223155536165;38888.41667374935;224361;225544;226178;226260;226699;21031.789682102983;21628.67556986615;23065;23956;23990.160344387863;37817;38196.61803382042;38234;38514.614853852225;39451.80274098611;33376.33247334991;33491.330173396884;33537.83231083829;33783.66216337805;34303;33445.498317525744;33832.1541961453;34265.31469370649;34798;35261;33555.66444335623;33709.83145084259;33742.66257337493;33970.490442642884;34797;27295.45409091847;27439.314017149733;31259.218519537193;31271.84364078165;32420.46113544153;23979.400514986566;24087;24264.636030459205;24392.75607243905;24672.629910551714 12:33:52 INFO - PROCESS | 16755 | |2;jquery.html;311.9079871437926;341.57644520794213;343.0839658112839;344.5107946715665;362.24110488526526;12355.629331120059;13355.53255636053;15746.606334841636;16398.508044758677;17283.654326913453;16416.17919104043;16662.333506659717;16775;16780;16928.068956207404;4618.676692631517;4787.473377928425;4891.241857512083;5118.590512758989;5120.103981803189;4895.241237608177;4937.432195297551;4983.401991760994;4990.201567749161;5001.274815151819;4141.62725354718;4966.162519867636;4966.329545511364;4969.602431805465;4972.055309491185;4884.902301953959;5015.39815222172;5021.096202683497;5023.899522009576;5026.095302845486;4452.465704115494;4453.621442177418;4453.688241823073;4456.376107344974;4457.442819647544;12246.203996740272;17245.913770431194;18442.538936526693;19176.232950681955;19263.4220973371;1841.7881943576526;1987.4335814292858;2112.8732276063483;2283.9543209135722;2343.859368437882;8360.790980225482;8663.306935445213;9118.316126290489;9326.533673316308;9334;1556.564162034632;1625.1143126995698;1704.7869016372954;1711.4352263753055;1737.1140718233667;62674.68662656703;66604.66697666481;67323.99014014842;67630;70544.6472767638;9090.590923408463;9490.667826626035;9522.428654280766;9828.164606008426;9942.453165075991;13654.726905461835;13655.726885462234;13676.726465470634;13684.65788355299;13696.109752866032;6976.860462790817;7173.390261827803;7208.71165153388;7324.926750732531;7348.338649521569;6755.695993680296;6819.147606549182;7039.190493093258;7048;7067;4190.129761113647;4244.915101697949;4265.7014009019695;4356.4336636237085;4368.825246990148;1726.9913650431668;1736.7221244601055;1750.536107931399;1862.4226489787939;1869.3550725000125;758.1660173808766;776.1268572855538;798.876174193001;867.2498288979987;926.4163576946615;15929.203539822962;16171.787115966114;16343.26455309514;16715.331386744638;17041.31834726597;815.9224873636995;818.5866137600593;859.1537335724306;867.6052396159732;884.7922585670514;8749.431286966326;9483.430994140235;9502.952485237529;9517.333786634868;9517.381370210915;356331;361215;361934;363549;363573;53726.7313663437;68808.6559567199;69886;70573;76581.61709191419;851.2296371783669;869.8956125264882;898.9235914947172;899.5457294066586;899.6941040046415;10924.399158046384;14136.646583835074;15045.548633541011;15176.848231517544;15414;35581.288374232885;36272.637273626926;36645.63354366422;37316.440253395675;38305.6169438302;45110.77444612756;45685.314720278555;45827.77086114548;45906.31140532828;48186.75906620585;7155.24869888675;7448.851022979402;7565.167831538636;7636.8472630548185;7660.616969151409;10903.34579925207;11080.39057851826;12083.335416552174;12249.693757655774;12259.448324825225;10355.482225888825;10392.37645741258;10615.89384106149;10629.627963021258;11025.062869655849;10445.321054131457;10509.31689440184;10598.31110977784;10708.839367409651;10717.89282107169;10705.250632455653;10854.782904342026;10960.890391095987;11313.660590182308;11368.147388946027;7518.511296765692;7633.351165151024;7707.766757318802;7892.0924093729955;7910.090339611018;10010.349327293703;10699.465026748476;10769.515371808444;10954.123670106213;11213.831792522955 12:33:52 INFO - PROCESS | 16755 | |3;mootools.html;1308.1431662261218;1347.885429738472;1379.655086228443;1629.4785668586042;1660.634660374718;6205.658688772116;6456.128422662939;6686.598804071753;7144.249853765357;7157.176924653666;6770.119884415019;7036.5778053316835;7057.964710176455;7212.675429605667;7214.603196824172;2058.8558800883907;2098.8320934325216;2105.0316854247067;2105.49468127649;2114.8836813975227;1807.6836553603132;1884.971725424113;2084.570880900917;2121.1197353098446;2128.57428514297;1990.4327266728985;2068.162394230339;2072.0572139676487;2085.092984551725;2092.9581408371823;2041.4386043838063;2062.7937206279403;2071.30611245233;2085.655866781987;2085.9687104693444;2107.2519255664324;2124.320217530391;2128.063651993118;2133.5626196629655;2134.7331583552054;7191;7259.0563226780705;7290.234525374813;7291.52605080668;7330.8900366494545;4212.894677633053;4263.680223983182;4343.761093139876;4350.195213885441;4352.194843953878;2653.4162484253625;2818.957715634267;2917.226934862263;2931.721486458783;2938.2213713365977;850.3622283287534;875.8598624220094;881.2817553693719;888.342626456424;898.2140626951417;9651.71044868655;9682.661106861226;9683.951580242125;9690.51547422626;9702.466364349957;3589.587197472272;3811.790351530637;3894.5910679378258;3900.297946369624;3997.320455522568;8402.117777633383;8418.284445822052;8424.157584241526;8424.957875210584;8427;4440.156370289635;4446.444194475691;4453.220686379936;4455.777211139495;4456.331550267486;3879.0690234343556;4062.5734297898293;4062.6952978526137;4070.8371665133063;4073.714839961174;3267.607887053569;3304.545999760098;3390.5422767926507;3408.761386702907;3514.876979305712;989.4113002763344;1037.1184493180888;1058.0953284941418;1105.9668209953713;1111.644273832382;709.6912842913349;723.6779633063342;728.2717282717283;777.5490215674895;862.6635612111281;4854.951450485521;5028.7737051832755;5055.7219352935945;5056.772445239973;5174.172132458863;855.2858363266741;856.8971723393232;888.440282621944;896.7668406214301;903.8192361527721;3365.528825964318;3439.9656003440145;3470.791752494808;3473.6873681368797;3576.088097535112;8191.918080819235;8730.563471826383;8751.956240218886;8752.124787521198;8828.42615230008;8740.388172827968;8744.95627521871;8750;8751.737447876574;8753;6622.867542649216;6816.216135144522;6853.7943861684225;6855.108835851407;6858.828529286708;4761.6904901181315;4778.856634300976;4833.879153021203;4856.490068542752;4889.731064791471;7894.960525197567;7910.802229944067;8079.515229086273;8138.3489320853005;8148.674053037812;8123.4313598047565;8294.917050829414;8359.205875441823;8367.790805229917;8367.874481882898;5773.134029895549;6001.099835024781;6049.879002420015;6078.422549857756;6097.634141951497;6834.384905358542;6895.207051188977;6895.6552172392185;6900.758473453606;6902.171739391305;6155.230596175478;6201.844953876189;6215.160953271431;6220.906686399798;6493.383128602775;6055.72749226277;6108.083787431743;6108.480779133645;6137.539684523589;6205.441510264098;5717.685527296038;5792.797252096157;5804.796832110856;5805.10020946754;5805.767769289181;4259.914801704011;4470.351798989063;4539.954600453953;4545.181867263925;4597.908041839078;4303.419038429772;4371.235033869124;4462.642988560972;4465.799039043316;4558.430196225472 12:33:52 INFO - PROCESS | 16755 | |4;prototype.html;270.1880848051605;273.7208047791253;277.468647539961;281.8435768148677;282.0073341836733;4583.220852455082;4691.624670026398;4731.976340118299;4767.761611919404;4773.618110551156;4543.432070991126;4655.767211639413;4706.599939005188;4715.269133284338;4731.432228132629;3500.1249687578106;3643.6902863256655;3661.2311414602964;3663.7618554793985;3708.1656627258853;3530.2057037166687;3641.3445579795625;3654.835532401035;3665.9083522911874;3674.7060235181257;3628.5827129880004;3629.201575653352;3643.344198044351;3648.452732090181;3648.872289469869;3633.36416127178;3652.7077833773233;3656.926861462756;3673.3204357194004;3673.4673472346494;3010.6452096556636;3135.5453459248283;3175.6665550117136;3222.5649537312397;3235.236795946215;4585.564371384713;4592.0815836832435;4608.1705293047235;4608.308753686941;4613.192691279013;4117.505899292074;4125.608067233608;4134.131832315217;4135.7518548887165;4161.292580261363;4724.795177229818;4885.7312847793355;4890.095332363524;4892.559669629715;4910.919597688503;3360.798352098882;3365.7307415406954;3381.7294616430872;3384;3389.9661003389897;5106.876487172816;5122.334096567422;5134.743262836881;5137.12668846297;5151.381834179885;3310.7915610801883;3469.3755124077907;3491.4762785582366;3523.5947865995226;3545.9290814183573;3506.3688536063755;3509.8069606171393;3519.3665140274998;3529.8235088245483;3531.964680353215;4054.9797251013556;4062.695297852673;4066.186762647423;4067.613576710208;4077.245709543744;4669.906601867943;4839.733814640158;4844.878878028077;4855.940757322935;4890.535399137077;1108.562117963416;1182.7403814937065;1182.751622159339;1183.2663748475827;1193.6061099837034;771.7839005078587;772.3820943245494;786.6381464526382;796.4942261663886;804.6942161978411;4198.916021679611;4219.641330486943;4227.936580951288;4230.661547076226;4234.9576504234565;4837.419509658793;4838.903221935612;4852.675916996868;4877.853664390074;4878.804847806119;4216.10275376082;4222.015652643253;4226.1336426032585;4231.603570821683;4232.560929284058;2497.775200231988;2571.344307201689;2579.471208402273;2580;2582.2253324002722;4479.865604031885;4512.9774351128035;4541.772911354419;4549.5905368517;4558.521355257716;4919.262110683355;4923.75381230937;4926.655134140576;4932.926006109911;4946.629002824802;4361.6074553290355;4429.734215947054;4519.502854685982;4567.743870435656;4571.885702857455;4866.394089950379;4869.467876704023;4885.5358740919555;4888.462269150462;4908.165611846066;4765.046990601824;4766.307036524491;4769.284607308793;4774.498677638798;4796.664233503621;4485.416895803524;4570.303520922539;4769.57073863354;4797.352357431702;4802;3512.736544759204;3524.4537096750046;3535.098549869767;3535.8055306958363;3539.3806083935724;4904.75738486214;5155.118381790545;5164.561012313995;5190.195519694454;5206.687598743936;4848.806047758191;4914.631402644744;4926.4088309403105;4978.569073524638;4990.476000019946;4937.9012419752125;4947.628927830499;4957.231629097496;4958.479359667327;4970.130227210151;4806.807727690853;4898.583620392164;4915.124652078574;4921.50784921505;4931.309616653743;4976.975115124401;5006.749662516932;5014.297998280171;5022.673526220784;5029.346184995927;4898.387701537308;4904.313396124617;4904.460509343898;4906.1659517881335;4942.5304596063315 12:33:52 INFO - PROCESS | 16755 | |5;yui.html;630.7193298981952;679.7043286170516;695.9686814093366;707.0207762249283;715.2739968931534;12186;12746.490140394397;12750.872491275097;12773.744525109492;12810.807837882428;11463.541458341677;11490.36802975836;11495.712607184825;11506.884931150686;11518.366489843056;597.734008366275;622.8256088295262;716.1549371741343;744.9143348514909;757.6287619066673;758.6813538313894;771.0631582627107;773.192014345008;773.2190487607529;773.4701729315409;800.1158719614829;801.9117897031322;802.2699343597328;802.8033131882668;803.5821372886096;628.2900322635438;648.7794149989027;758.6775620361325;794.2256300107377;797.143071198461;589.2781342855011;591.1664552980277;592.2655906675734;593.1103344982527;594.2334388638651;11841.289522628584;11852.229605075643;11880.58417955376;11885.940570297093;11914.821277680841;11100.944495277472;11131.165162612755;11160.05139563138;11641.767164656743;11859.58491452795;11044.447777611167;11207.383593902332;11346.149038822039;11534.480948357344;11973.700657483545;3982.4260927842615;3988.940165897514;3994.2610617035944;4083.5712250213596;4092.6521245694153;49288.75355623235;49518.50481495211;49628.25557616639;50055.49944500545;50480.74759626178;9416.482093484925;9468.715938521855;9514.809703805886;9533.094356036165;9606.327557071078;15929.920350398173;16060.598485037734;16868.746968795476;17546.210420531108;17740.645187096186;5954.3152537458745;6161.507079433634;6196.194494715658;6313.273973493107;6315.526335524854;3544.167120726627;3564.465330200491;3571.7321200910037;3588.4079126944284;3649.434337677664;2699.973000269972;2781.6105745195687;2788.344738986337;2790.9441811163665;2800.271929298397;467.08451435186737;477.24356894322887;482.9299751536078;514.5549100028524;537.4249552978275;604.6583680220662;617.3764497857196;620.8758248350348;637.7162162837585;643.6331291163991;7871.425714857051;8038.477498962666;8150.75547733569;8219.589020548949;8258;570.0508653092554;621.7473175408895;624.5877720704314;635.2599221906427;639.4404895716249;3617.8552857885916;3629.764065335745;3692;3854.5567259765485;3943.4676318697184;66508;68271.65864170747;69786.30213697797;70028.6498567514;70171;60249.397506025256;60886.695566521885;61349.38650613526;61361.693191533755;64147.67926160339;56584.43415565792;57494.99999999916;57617.423825762045;57933.420665793645;58695.70652146712;7112.822179445555;7391.371733402721;7436.479446438698;7518.812029699083;7521.661525231269;37767;38162.61837381591;38400.80799596096;38512.22975540529;39539.209215816096;52135.2179717297;53575;54053.45946540484;54500.45499544954;56545;9479.241660667269;9594.856077158987;9679.70960871175;9857.211423086279;10123.291369604058;10184.23618228621;10429.426381549089;10672.413017284123;10708.785824283626;10747.408892510673;9987.700368988943;10474.162067034771;10944.398058106563;11026.44867756625;11169.944150279196;9857.605695772088;9989.150922171697;10156.39061656303;10302.124319432633;10484.479750435992;9661.71014869555;9953;10118.089371956265;10326.070653641209;10337.793244134924;8290.834183316421;8342.624581893951;8404.831903361775;8614.82770344602;8947.463152210888;7961.6752587618375;8209.507429554245;8248.340132789483;8403.327733781405;8449.324054075536 12:33:52 INFO - PROCESS | 16755 | __end_tp_report 12:33:52 INFO - PROCESS | 16755 | __start_cc_report 12:33:52 INFO - PROCESS | 16755 | _x_x_mozilla_cycle_collect,1652 12:33:52 INFO - PROCESS | 16755 | __end_cc_report 12:33:52 INFO - PROCESS | 16755 | __startTimestamp1478810032751__endTimestamp 12:33:52 INFO - PROCESS | 16755 | 12:33:52 INFO - PROCESS | 16755 | ------- Summary: start ------- 12:33:52 INFO - PROCESS | 16755 | Number of tests: 6 12:33:52 INFO - PROCESS | 16755 | 12:33:52 INFO - PROCESS | 16755 | [#0] dojo.html Cycles:165 Average:4613.64 Median:4730.76 stddev:475.79 (10.1%) stddev-sans-first:450.53 12:33:52 INFO - PROCESS | 16755 | Values: 2609.8 2618.9 2642.3 2658.2 2672.1 4537.0 4620.2 4644.2 4667.3 4675.2 4553.2 4598.0 4631.0 4654.4 4666.8 4222.6 4284.2 4302.6 4333.0 4353.7 3989.7 4371.2 4373.5 4394.2 4430.4 4235.3 4350.3 4357.9 4406.6 4460.6 4288.2 4347.5 4350.6 4358.7 4362.7 4224.3 4250.2 4321.9 4332.0 4332.9 4590.7 4593.1 4596.6 4648.8 4663.5 4942.4 4948.0 4948.2 4961.5 4979.9 4831.0 4873.7 4887.3 4968.0 5033.7 4572.6 4619.7 4630.1 4639.9 4717.0 5026.8 5071.2 5071.5 5080.0 5125.3 4816.9 4866.5 4878.3 4884.1 4916.6 4912.2 4924.9 4943.7 4952.4 5009.4 4897.3 4913.2 4916.0 4926.1 4979.3 4935.3 4965.3 4980.9 4981.9 5028.7 4091.2 4135.0 4136.5 4142.4 4182.7 3665.7 3677.3 3687.4 3718.6 3730.4 4378.9 4387.3 4389.6 4410.8 4440.2 4878.6 4937.5 4942.7 5073.8 5100.9 4281.6 4326.4 4327.9 4341.7 4385.6 4456.3 4466.2 4466.6 4468.6 4515.6 4613.8 4673.6 4675.7 4684.0 4711.3 4985.8 5006.9 5049.4 5067.9 5071.9 4730.8 4733.2 4744.1 4754.6 4773.9 4979.3 4979.8 4984.0 4985.1 5033.4 4856.6 4900.7 4939.6 4984.9 5028.9 4906.2 4907.7 4924.6 4935.0 4952.2 4902.0 4911.3 4913.1 4921.2 4921.9 4734.9 4748.7 4798.1 4865.4 4885.2 4893.0 4954.3 4958.3 4998.9 5000.7 4685.8 4721.9 4838.6 4848.1 4898.0 12:33:52 INFO - PROCESS | 16755 | 12:33:52 INFO - PROCESS | 16755 | [#1] ext.html Cycles:180 Average:41878.48 Median:19132.61 stddev:70977.52 (371.0%) stddev-sans-first:71108.78 12:33:52 INFO - PROCESS | 16755 | Values: 543.6 546.0 556.6 559.2 578.2 27609.9 37933.4 39374.0 39602.4 42755.4 38698.6 39233.2 39267.6 39267.6 39326.4 7441.1 7590.3 7590.4 7591.9 7595.8 7346.9 7440.3 7441.4 7443.3 7443.9 7396.5 7470.8 7474.7 7475.5 7479.3 7349.4 7407.0 7413.0 7453.3 7458.4 7451.6 7526.4 7526.6 7533.5 7533.8 36491.5 36651.8 36847.8 36888.3 37084.3 2896.1 2955.9 2974.9 3009.6 3053.1 27350.5 28215.6 28338.4 29033.3 29071.9 3466.7 3468.2 3502.6 3698.2 3715.1 232018.0 232019.0 232188.0 232592.0 232649.0 48315.8 48375.8 48419.0 48692.3 48726.3 50850.5 51062.5 51133.0 51177.0 51182.0 13805.9 13904.7 14088.3 14092.6 14412.2 10799.4 10914.5 10922.6 10923.2 10941.6 17239.7 17274.1 17305.0 17420.5 17441.7 6683.3 6697.2 6891.6 6896.3 6918.8 793.3 824.7 885.9 940.4 942.8 26273.7 26795.3 26908.6 27478.2 27545.7 875.4 891.6 939.1 988.3 1046.2 14354.8 14406.8 14440.9 14646.9 14697.5 336559.0 339780.0 339786.0 340004.0 340306.0 46499.0 46963.0 47097.0 47115.8 47159.5 1064.7 1094.0 1103.2 1166.5 1187.9 26130.6 27428.0 28012.9 28559.4 28577.0 38234.8 38761.0 38835.6 38842.2 38888.4 224361.0 225544.0 226178.0 226260.0 226699.0 21031.8 21628.7 23065.0 23956.0 23990.2 37817.0 38196.6 38234.0 38514.6 39451.8 33376.3 33491.3 33537.8 33783.7 34303.0 33445.5 33832.2 34265.3 34798.0 35261.0 33555.7 33709.8 33742.7 33970.5 34797.0 27295.5 27439.3 31259.2 31271.8 32420.5 23979.4 24087.0 24264.6 24392.8 24672.6 12:33:52 INFO - PROCESS | 16755 | 12:33:52 INFO - PROCESS | 16755 | [#2] jquery.html Cycles:180 Average:22812.64 Median:4410.65 stddev:59600.34 (1351.3%) stddev-sans-first:59743.59 12:33:52 INFO - PROCESS | 16755 | Values: 311.9 341.6 343.1 344.5 362.2 12355.6 13355.5 15746.6 16398.5 17283.7 16416.2 16662.3 16775.0 16780.0 16928.1 4618.7 4787.5 4891.2 5118.6 5120.1 4895.2 4937.4 4983.4 4990.2 5001.3 4141.6 4966.2 4966.3 4969.6 4972.1 4884.9 5015.4 5021.1 5023.9 5026.1 4452.5 4453.6 4453.7 4456.4 4457.4 12246.2 17245.9 18442.5 19176.2 19263.4 1841.8 1987.4 2112.9 2284.0 2343.9 8360.8 8663.3 9118.3 9326.5 9334.0 1556.6 1625.1 1704.8 1711.4 1737.1 62674.7 66604.7 67324.0 67630.0 70544.6 9090.6 9490.7 9522.4 9828.2 9942.5 13654.7 13655.7 13676.7 13684.7 13696.1 6976.9 7173.4 7208.7 7324.9 7348.3 6755.7 6819.1 7039.2 7048.0 7067.0 4190.1 4244.9 4265.7 4356.4 4368.8 1727.0 1736.7 1750.5 1862.4 1869.4 758.2 776.1 798.9 867.2 926.4 15929.2 16171.8 16343.3 16715.3 17041.3 815.9 818.6 859.2 867.6 884.8 8749.4 9483.4 9503.0 9517.3 9517.4 356331.0 361215.0 361934.0 363549.0 363573.0 53726.7 68808.7 69886.0 70573.0 76581.6 851.2 869.9 898.9 899.5 899.7 10924.4 14136.6 15045.5 15176.8 15414.0 35581.3 36272.6 36645.6 37316.4 38305.6 45110.8 45685.3 45827.8 45906.3 48186.8 7155.2 7448.9 7565.2 7636.8 7660.6 10903.3 11080.4 12083.3 12249.7 12259.4 10355.5 10392.4 10615.9 10629.6 11025.1 10445.3 10509.3 10598.3 10708.8 10717.9 10705.3 10854.8 10960.9 11313.7 11368.1 7518.5 7633.4 7707.8 7892.1 7910.1 10010.3 10699.5 10769.5 10954.1 11213.8 12:33:52 INFO - PROCESS | 16755 | 12:33:52 INFO - PROCESS | 16755 | [#3] mootools.html Cycles:180 Average:4756.83 Median:5782.97 stddev:2584.77 (44.7%) stddev-sans-first:2579.02 12:33:52 INFO - PROCESS | 16755 | Values: 1308.1 1347.9 1379.7 1629.5 1660.6 6205.7 6456.1 6686.6 7144.2 7157.2 6770.1 7036.6 7058.0 7212.7 7214.6 2058.9 2098.8 2105.0 2105.5 2114.9 1807.7 1885.0 2084.6 2121.1 2128.6 1990.4 2068.2 2072.1 2085.1 2093.0 2041.4 2062.8 2071.3 2085.7 2086.0 2107.3 2124.3 2128.1 2133.6 2134.7 7191.0 7259.1 7290.2 7291.5 7330.9 4212.9 4263.7 4343.8 4350.2 4352.2 2653.4 2819.0 2917.2 2931.7 2938.2 850.4 875.9 881.3 888.3 898.2 9651.7 9682.7 9684.0 9690.5 9702.5 3589.6 3811.8 3894.6 3900.3 3997.3 8402.1 8418.3 8424.2 8425.0 8427.0 4440.2 4446.4 4453.2 4455.8 4456.3 3879.1 4062.6 4062.7 4070.8 4073.7 3267.6 3304.5 3390.5 3408.8 3514.9 989.4 1037.1 1058.1 1106.0 1111.6 709.7 723.7 728.3 777.5 862.7 4855.0 5028.8 5055.7 5056.8 5174.2 855.3 856.9 888.4 896.8 903.8 3365.5 3440.0 3470.8 3473.7 3576.1 8191.9 8730.6 8752.0 8752.1 8828.4 8740.4 8745.0 8750.0 8751.7 8753.0 6622.9 6816.2 6853.8 6855.1 6858.8 4761.7 4778.9 4833.9 4856.5 4889.7 7895.0 7910.8 8079.5 8138.3 8148.7 8123.4 8294.9 8359.2 8367.8 8367.9 5773.1 6001.1 6049.9 6078.4 6097.6 6834.4 6895.2 6895.7 6900.8 6902.2 6155.2 6201.8 6215.2 6220.9 6493.4 6055.7 6108.1 6108.5 6137.5 6205.4 5717.7 5792.8 5804.8 5805.1 5805.8 4259.9 4470.4 4540.0 4545.2 4597.9 4303.4 4371.2 4462.6 4465.8 4558.4 12:33:52 INFO - PROCESS | 16755 | 12:33:52 INFO - PROCESS | 16755 | [#4] prototype.html Cycles:180 Average:4023.01 Median:4569.02 stddev:1187.39 (26.0%) stddev-sans-first:1156.83 12:33:52 INFO - PROCESS | 16755 | Values: 270.2 273.7 277.5 281.8 282.0 4583.2 4691.6 4732.0 4767.8 4773.6 4543.4 4655.8 4706.6 4715.3 4731.4 3500.1 3643.7 3661.2 3663.8 3708.2 3530.2 3641.3 3654.8 3665.9 3674.7 3628.6 3629.2 3643.3 3648.5 3648.9 3633.4 3652.7 3656.9 3673.3 3673.5 3010.6 3135.5 3175.7 3222.6 3235.2 4585.6 4592.1 4608.2 4608.3 4613.2 4117.5 4125.6 4134.1 4135.8 4161.3 4724.8 4885.7 4890.1 4892.6 4910.9 3360.8 3365.7 3381.7 3384.0 3390.0 5106.9 5122.3 5134.7 5137.1 5151.4 3310.8 3469.4 3491.5 3523.6 3545.9 3506.4 3509.8 3519.4 3529.8 3532.0 4055.0 4062.7 4066.2 4067.6 4077.2 4669.9 4839.7 4844.9 4855.9 4890.5 1108.6 1182.7 1182.8 1183.3 1193.6 771.8 772.4 786.6 796.5 804.7 4198.9 4219.6 4227.9 4230.7 4235.0 4837.4 4838.9 4852.7 4877.9 4878.8 4216.1 4222.0 4226.1 4231.6 4232.6 2497.8 2571.3 2579.5 2580.0 2582.2 4479.9 4513.0 4541.8 4549.6 4558.5 4919.3 4923.8 4926.7 4932.9 4946.6 4361.6 4429.7 4519.5 4567.7 4571.9 4866.4 4869.5 4885.5 4888.5 4908.2 4765.0 4766.3 4769.3 4774.5 4796.7 4485.4 4570.3 4769.6 4797.4 4802.0 3512.7 3524.5 3535.1 3535.8 3539.4 4904.8 5155.1 5164.6 5190.2 5206.7 4848.8 4914.6 4926.4 4978.6 4990.5 4937.9 4947.6 4957.2 4958.5 4970.1 4806.8 4898.6 4915.1 4921.5 4931.3 4977.0 5006.7 5014.3 5022.7 5029.3 4898.4 4904.3 4904.5 4906.2 4942.5 12:33:52 INFO - PROCESS | 16755 | 12:33:52 INFO - PROCESS | 16755 | [#5] yui.html Cycles:180 Average:14601.78 Median:58314.56 stddev:19090.58 (32.7%) stddev-sans-first:19115.31 12:33:52 INFO - PROCESS | 16755 | Values: 630.7 679.7 696.0 707.0 715.3 12186.0 12746.5 12750.9 12773.7 12810.8 11463.5 11490.4 11495.7 11506.9 11518.4 597.7 622.8 716.2 744.9 757.6 758.7 771.1 773.2 773.2 773.5 800.1 801.9 802.3 802.8 803.6 628.3 648.8 758.7 794.2 797.1 589.3 591.2 592.3 593.1 594.2 11841.3 11852.2 11880.6 11885.9 11914.8 11100.9 11131.2 11160.1 11641.8 11859.6 11044.4 11207.4 11346.1 11534.5 11973.7 3982.4 3988.9 3994.3 4083.6 4092.7 49288.8 49518.5 49628.3 50055.5 50480.7 9416.5 9468.7 9514.8 9533.1 9606.3 15929.9 16060.6 16868.7 17546.2 17740.6 5954.3 6161.5 6196.2 6313.3 6315.5 3544.2 3564.5 3571.7 3588.4 3649.4 2700.0 2781.6 2788.3 2790.9 2800.3 467.1 477.2 482.9 514.6 537.4 604.7 617.4 620.9 637.7 643.6 7871.4 8038.5 8150.8 8219.6 8258.0 570.1 621.7 624.6 635.3 639.4 3617.9 3629.8 3692.0 3854.6 3943.5 66508.0 68271.7 69786.3 70028.6 70171.0 60249.4 60886.7 61349.4 61361.7 64147.7 56584.4 57495.0 57617.4 57933.4 58695.7 7112.8 7391.4 7436.5 7518.8 7521.7 37767.0 38162.6 38400.8 38512.2 39539.2 52135.2 53575.0 54053.5 54500.5 56545.0 9479.2 9594.9 9679.7 9857.2 10123.3 10184.2 10429.4 10672.4 10708.8 10747.4 9987.7 10474.2 10944.4 11026.4 11169.9 9857.6 9989.2 10156.4 10302.1 10484.5 9661.7 9953.0 10118.1 10326.1 10337.8 8290.8 8342.6 8404.8 8614.8 8947.5 7961.7 8209.5 8248.3 8403.3 8449.3 12:33:52 INFO - PROCESS | 16755 | -------- Summary: end -------- 12:33:52 INFO - PROCESS | 16755 | 12:33:53 INFO - TEST-INFO | 16755: exit 0 12:33:53 INFO - TEST-OK | dromaeo_css | took 1123474ms 12:33:53 INFO - TEST-START | kraken 12:33:53 INFO - operating with platform_type : linux_ 12:33:53 INFO - Initialising browser for kraken test... 12:33:53 INFO - TEST-INFO | started process 17063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSb2lhb/profile http://localhost:42184/getInfo.html) 12:33:58 INFO - PROCESS | 17063 | __metrics Screen width/height:1600/1200 12:33:58 INFO - PROCESS | 17063 | colorDepth:24 12:33:58 INFO - PROCESS | 17063 | Browser inner width/height: 1024/697 12:33:58 INFO - PROCESS | 17063 | __metrics 12:33:58 INFO - PROCESS | 17063 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:33:58 INFO - PROCESS | 17063 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:33:59 INFO - PROCESS | 17063 | console.error: PushService: 12:33:59 INFO - PROCESS | 17063 | stateChangeProcessEnqueue: Error transitioning state 12:33:59 INFO - PROCESS | 17063 | UnknownError 12:34:00 INFO - TEST-INFO | 17063: exit 0 12:34:00 INFO - Browser initialized. 12:34:00 INFO - Running cycle 1/1 for kraken test... 12:34:00 INFO - TEST-INFO | started process 17146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSb2lhb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:34:12 INFO - PROCESS | 17146 | RSS: Main: 174952448 12:34:12 INFO - PROCESS | 17146 | 12:34:15 INFO - PROCESS | 17146 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42184/tests/kraken/driver.html?testName=audio-beat-detection) 12:34:16 INFO - PROCESS | 17146 | RSS: Main: 239534080 12:34:16 INFO - PROCESS | 17146 | 12:34:19 INFO - PROCESS | 17146 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42184/tests/kraken/driver.html?testName=audio-dft) 12:34:19 INFO - PROCESS | 17146 | RSS: Main: 218034176 12:34:19 INFO - PROCESS | 17146 | 12:34:22 INFO - PROCESS | 17146 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42184/tests/kraken/driver.html?testName=audio-fft) 12:34:23 INFO - PROCESS | 17146 | RSS: Main: 299622400 12:34:23 INFO - PROCESS | 17146 | 12:34:25 INFO - PROCESS | 17146 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42184/tests/kraken/driver.html?testName=audio-oscillator) 12:34:26 INFO - PROCESS | 17146 | RSS: Main: 209960960 12:34:26 INFO - PROCESS | 17146 | 12:34:28 INFO - PROCESS | 17146 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42184/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:34:29 INFO - PROCESS | 17146 | RSS: Main: 214622208 12:34:29 INFO - PROCESS | 17146 | 12:34:32 INFO - PROCESS | 17146 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42184/tests/kraken/driver.html?testName=imaging-darkroom) 12:34:32 INFO - PROCESS | 17146 | RSS: Main: 250462208 12:34:32 INFO - PROCESS | 17146 | 12:34:36 INFO - PROCESS | 17146 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42184/tests/kraken/driver.html?testName=imaging-desaturate) 12:34:37 INFO - PROCESS | 17146 | RSS: Main: 249245696 12:34:37 INFO - PROCESS | 17146 | 12:34:39 INFO - PROCESS | 17146 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42184/tests/kraken/driver.html?testName=json-parse-financial) 12:34:40 INFO - PROCESS | 17146 | RSS: Main: 248520704 12:34:40 INFO - PROCESS | 17146 | 12:34:42 INFO - PROCESS | 17146 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42184/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:34:42 INFO - PROCESS | 17146 | RSS: Main: 210464768 12:34:42 INFO - PROCESS | 17146 | 12:34:44 INFO - PROCESS | 17146 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42184/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:34:45 INFO - PROCESS | 17146 | RSS: Main: 219017216 12:34:45 INFO - PROCESS | 17146 | 12:34:47 INFO - PROCESS | 17146 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42184/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:34:47 INFO - PROCESS | 17146 | RSS: Main: 226893824 12:34:47 INFO - PROCESS | 17146 | 12:34:50 INFO - PROCESS | 17146 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42184/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:34:51 INFO - PROCESS | 17146 | RSS: Main: 235315200 12:34:51 INFO - PROCESS | 17146 | 12:34:54 INFO - PROCESS | 17146 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42184/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:34:55 INFO - PROCESS | 17146 | RSS: Main: 232542208 12:34:55 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | Cycle 1(1): loaded http://localhost:42184/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42184/tests/kraken/driver.html?testName=ai-astar) 12:34:57 INFO - PROCESS | 17146 | RSS: Main: 283590656 12:34:57 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | __start_tp_report 12:34:57 INFO - PROCESS | 17146 | _x_x_mozilla_page_load 12:34:57 INFO - PROCESS | 17146 | _x_x_mozilla_page_load_details 12:34:57 INFO - PROCESS | 17146 | |i|pagename|runs| 12:34:57 INFO - PROCESS | 17146 | |0;ai-astar;107;117;116;120;117;115;116;115;115;116 12:34:57 INFO - PROCESS | 17146 | |1;audio-beat-detection;164;129;130;169;136;132;130;136;169;130 12:34:57 INFO - PROCESS | 17146 | |2;audio-dft;162;162;162;163;162;161;162;161;161;171 12:34:57 INFO - PROCESS | 17146 | |3;audio-fft;76;77;76;107;79;77;77;77;104;78 12:34:57 INFO - PROCESS | 17146 | |4;audio-oscillator;84;83;127;85;84;84;114;83;83;118 12:34:57 INFO - PROCESS | 17146 | |5;imaging-gaussian-blur;118;118;118;118;117;118;120;117;118;118 12:34:57 INFO - PROCESS | 17146 | |6;imaging-darkroom;147;146;146;146;147;146;146;147;147;146 12:34:57 INFO - PROCESS | 17146 | |7;imaging-desaturate;85;84;84;85;85;85;84;85;86;85 12:34:57 INFO - PROCESS | 17146 | |8;json-parse-financial;64;65;64;63;64;65;65;65;64;63 12:34:57 INFO - PROCESS | 17146 | |9;json-stringify-tinderbox;66;66;65;67;66;66;65;66;66;67 12:34:57 INFO - PROCESS | 17146 | |10;stanford-crypto-aes;94;88;90;88;85;85;84;85;84;93 12:34:57 INFO - PROCESS | 17146 | |11;stanford-crypto-ccm;153;142;152;144;140;142;149;141;202;155 12:34:57 INFO - PROCESS | 17146 | |12;stanford-crypto-pbkdf2;178;183;183;178;180;180;179;181;177;187 12:34:57 INFO - PROCESS | 17146 | |13;stanford-crypto-sha256-iterative;70;69;72;69;70;69;73;69;69;68 12:34:57 INFO - PROCESS | 17146 | __end_tp_report 12:34:57 INFO - PROCESS | 17146 | __start_cc_report 12:34:57 INFO - PROCESS | 17146 | _x_x_mozilla_cycle_collect,1944 12:34:57 INFO - PROCESS | 17146 | __end_cc_report 12:34:57 INFO - PROCESS | 17146 | __startTimestamp1478810097300__endTimestamp 12:34:57 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | ------- Summary: start ------- 12:34:57 INFO - PROCESS | 17146 | Number of tests: 14 12:34:57 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.00 stddev:3.31 (2.9%) stddev-sans-first:1.58 12:34:57 INFO - PROCESS | 17146 | Values: 107.0 117.0 116.0 120.0 117.0 115.0 116.0 115.0 115.0 116.0 12:34:57 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:136.00 stddev:17.36 (12.8%) stddev-sans-first:16.58 12:34:57 INFO - PROCESS | 17146 | Values: 164.0 129.0 130.0 169.0 136.0 132.0 130.0 136.0 169.0 130.0 12:34:57 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:2.98 (1.8%) stddev-sans-first:3.15 12:34:57 INFO - PROCESS | 17146 | Values: 162.0 162.0 162.0 163.0 162.0 161.0 162.0 161.0 161.0 171.0 12:34:57 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | [#3] audio-fft Cycles:10 Average:82.80 Median:77.00 stddev:12.02 (15.6%) stddev-sans-first:12.49 12:34:57 INFO - PROCESS | 17146 | Values: 76.0 77.0 76.0 107.0 79.0 77.0 77.0 77.0 104.0 78.0 12:34:57 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:83.50 stddev:17.66 (21.1%) stddev-sans-first:18.32 12:34:57 INFO - PROCESS | 17146 | Values: 84.0 83.0 127.0 85.0 84.0 84.0 114.0 83.0 83.0 118.0 12:34:57 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 12:34:57 INFO - PROCESS | 17146 | Values: 118.0 118.0 118.0 118.0 117.0 118.0 120.0 117.0 118.0 118.0 12:34:57 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 12:34:57 INFO - PROCESS | 17146 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 12:34:57 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 12:34:57 INFO - PROCESS | 17146 | Values: 85.0 84.0 84.0 85.0 85.0 85.0 84.0 85.0 86.0 85.0 12:34:57 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 12:34:57 INFO - PROCESS | 17146 | Values: 64.0 65.0 64.0 63.0 64.0 65.0 65.0 65.0 64.0 63.0 12:34:57 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 12:34:57 INFO - PROCESS | 17146 | Values: 66.0 66.0 65.0 67.0 66.0 66.0 65.0 66.0 66.0 67.0 12:34:57 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:88.00 stddev:3.69 (4.2%) stddev-sans-first:3.10 12:34:57 INFO - PROCESS | 17146 | Values: 94.0 88.0 90.0 88.0 85.0 85.0 84.0 85.0 84.0 93.0 12:34:57 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | [#11] stanford-crypto-ccm Cycles:10 Average:152.00 Median:150.50 stddev:18.40 (12.2%) stddev-sans-first:19.52 12:34:57 INFO - PROCESS | 17146 | Values: 153.0 142.0 152.0 144.0 140.0 142.0 149.0 141.0 202.0 155.0 12:34:57 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.60 Median:180.50 stddev:3.03 (1.7%) stddev-sans-first:3.06 12:34:57 INFO - PROCESS | 17146 | Values: 178.0 183.0 183.0 178.0 180.0 180.0 179.0 181.0 177.0 187.0 12:34:57 INFO - PROCESS | 17146 | 12:34:57 INFO - PROCESS | 17146 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:69.50 stddev:1.55 (2.2%) stddev-sans-first:1.64 12:34:57 INFO - PROCESS | 17146 | Values: 70.0 69.0 72.0 69.0 70.0 69.0 73.0 69.0 69.0 68.0 12:34:57 INFO - PROCESS | 17146 | -------- Summary: end -------- 12:34:57 INFO - PROCESS | 17146 | 12:34:58 INFO - TEST-INFO | 17146: exit 0 12:34:58 INFO - TEST-OK | kraken | took 64861ms 12:34:58 INFO - SUITE-END | took 1188s 12:34:58 INFO - Completed test suite (00:19:48) 12:34:58 INFO - javascript benchmark 12:34:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.8173127881046, 2618.934526636835, 2642.312998620359, 2658.189252278056, 2672.078133044099, 4537.0, 4620.191466493367, 4644.187267228234, 4667.323238130469, 4675.228587283098, 4553.248713962201, 4597.954020459794, 4631.0, 4654.418197725285, 4666.78999445025, 4222.59885310895, 4284.164587905359, 4302.612764851163, 4332.956670433303, 4353.67347448941, 3989.7406668566596, 4371.191329604034, 4373.497047839507, 4394.1870753910625, 4430.357598148266, 4235.301175306071, 4350.303951367798, 4357.934630980538, 4406.603405693487, 4460.643148548108, 4288.185244803477, 4347.478302603708, 4350.630196433307, 4358.651307895392, 4362.694611377205, 4224.302990006645, 4250.213710463543, 4321.891952701176, 4332.0469496710675, 4332.870013899588, 4590.655700822418, 4593.058423023273, 4596.632269418438, 4648.837290694843, 4663.48701642819, 4942.382202224722, 4948.035133149037, 4948.233023881304, 4961.5038496150455, 4979.925301120486, 4830.951690483121, 4873.6832105913, 4887.266909963499, 4968.0, 5033.723145227011, 4572.565606267399, 4619.69971951822, 4630.120277147331, 4639.884002899955, 4717.0, 5026.824061157842, 5071.163258062378, 5071.518205770446, 5080.0, 5125.282460455539, 4816.8795780105775, 4866.489018653061, 4878.341423907798, 4884.145274577006, 4916.631252656065, 4912.189488734319, 4924.852254432372, 4943.653944223942, 4952.356193694796, 5009.44896061433, 4897.314375987365, 4913.238448040559, 4915.975420122948, 4926.1379258629595, 4979.278004689299, 4935.3090567320605, 4965.280034394992, 4980.8754781130765, 4981.850544483671, 5028.748562571856, 4091.202215567995, 4135.028268356994, 4136.462259906253, 4142.420061191436, 4182.686298527623, 3665.706743460517, 3677.2645470905927, 3687.391580389206, 3718.5537735471917, 3730.421784623388, 4378.868633940987, 4387.254166791653, 4389.648828093745, 4410.757408342508, 4440.2007638625355, 4878.609711223094, 4937.456879743226, 4942.678725882806, 5073.797048118107, 5100.923486147711, 4281.614654681093, 4326.437563116775, 4327.891802704958, 4341.674374421931, 4385.583369579948, 4456.264716321835, 4466.240739074366, 4466.620337271368, 4468.55314468557, 4515.571020753023, 4613.7923793430045, 4673.6494762892235, 4675.696079754805, 4684.0, 4711.26975318833, 4985.750712464434, 5006.874828129326, 5049.394072711299, 5067.949320506747, 5071.949280507148, 4730.763461826964, 4733.171694953438, 4744.098621261949, 4754.619630429488, 4773.856784296477, 4979.327790748347, 4979.825706100269, 4984.028114517634, 4985.1276026695905, 5033.446320904771, 4856.562909338035, 4900.681455705368, 4939.580135688363, 4984.925226121539, 5028.9245661315845, 4906.215005599087, 4907.705537667752, 4924.630652701134, 4935.037667654773, 4952.232403977389, 4901.975490122527, 4911.287863259879, 4913.091078150554, 4921.237208232729, 4921.926171107508, 4734.905301893874, 4748.715077095385, 4798.064377446504, 4865.416150062015, 4885.193942999507, 4892.996935628116, 4954.331165292783, 4958.281049247911, 4998.87502812418, 5000.724960127228, 4685.835995740133, 4721.858344249678, 4838.588719958702, 4848.10310092634, 4897.9510204898925], "value": 4583.911895908404, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.6466296907013, 545.9754311056003, 556.6020295488725, 559.2115117684066, 578.245389766355, 27609.858521221828, 37933.43099853501, 39374.01564960874, 39602.40596391049, 42755.35866961998, 38698.61301386985, 39233.21533569327, 39267.60732392675, 39267.60732392675, 39326.41010384839, 7441.069866266716, 7590.278923502258, 7590.3548198403205, 7591.924080759177, 7595.848083038363, 7346.853062938738, 7440.2931721486375, 7441.367483763859, 7443.292887175709, 7443.925560744377, 7396.519226250277, 7470.813229669275, 7474.701011959515, 7475.476716629838, 7479.252074792505, 7349.448791340671, 7406.962965185194, 7413.036305280333, 7453.291937265951, 7458.366038886728, 7451.590162541058, 7526.36025937796, 7526.586037767921, 7533.54798712079, 7533.811654708621, 36491.4526282106, 36651.816740916394, 36847.815760921025, 36888.26223475515, 37084.25831483382, 2896.139476961395, 2955.852207389622, 2974.866131024109, 3009.6087508623737, 3053.114596766935, 27350.45299094007, 28215.57676634852, 28338.433231335464, 29033.274168145756, 29071.854640726662, 3466.6706662866986, 3468.219650578625, 3502.6322236165347, 3698.204885949534, 3715.1269451678836, 232018.0, 232019.0, 232188.0, 232592.0, 232649.0, 48315.75842120767, 48375.75812120917, 48419.0, 48692.26961595579, 48726.26910596344, 50850.49149508531, 51062.489375105775, 51133.0, 51177.0, 51182.0, 13805.930970345084, 13904.652383690489, 14088.295585220698, 14092.577222683336, 14412.207328596818, 10799.406032668121, 10914.508847101899, 10922.617708380169, 10923.180761442924, 10941.56233750657, 17239.74140387895, 17274.13629318529, 17305.0, 17420.47738567845, 17441.65116697659, 6683.298253683391, 6697.229818570927, 6891.552049116792, 6896.310368963063, 6918.751405793138, 793.3296364571928, 824.6618886256726, 885.933554983366, 940.374650857186, 942.7829961643629, 26273.737262627128, 26795.33011674724, 26908.593289582645, 27478.17565473039, 27545.724542754317, 875.4397185801092, 891.5586784541694, 939.1125386509683, 988.3131223799534, 1046.1526163807341, 14354.784678229835, 14406.783898241325, 14440.927795360956, 14646.926765366105, 14697.485588004369, 336559.0, 339780.0, 339786.0, 340004.0, 340306.0, 46499.0, 46963.0, 47097.0, 47115.76442117836, 47159.5284047162, 1064.669952314785, 1093.9507722152523, 1103.1615971861604, 1166.5158959032076, 1187.8633957095044, 26130.608040879022, 27428.0, 28012.85993570019, 28559.42881142407, 28577.0, 38234.80882595569, 38761.0, 38835.61164388433, 38842.223155536165, 38888.41667374935, 224361.0, 225544.0, 226178.0, 226260.0, 226699.0, 21031.789682102983, 21628.67556986615, 23065.0, 23956.0, 23990.160344387863, 37817.0, 38196.61803382042, 38234.0, 38514.614853852225, 39451.80274098611, 33376.33247334991, 33491.330173396884, 33537.83231083829, 33783.66216337805, 34303.0, 33445.498317525744, 33832.1541961453, 34265.31469370649, 34798.0, 35261.0, 33555.66444335623, 33709.83145084259, 33742.66257337493, 33970.490442642884, 34797.0, 27295.45409091847, 27439.314017149733, 31259.218519537193, 31271.84364078165, 32420.46113544153, 23979.400514986566, 24087.0, 24264.636030459205, 24392.75607243905, 24672.629910551714], "value": 16567.867037939614, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.9079871437926, 341.57644520794213, 343.0839658112839, 344.5107946715665, 362.24110488526526, 12355.629331120059, 13355.53255636053, 15746.606334841636, 16398.508044758677, 17283.654326913453, 16416.17919104043, 16662.333506659717, 16775.0, 16780.0, 16928.068956207404, 4618.676692631517, 4787.473377928425, 4891.241857512083, 5118.590512758989, 5120.103981803189, 4895.241237608177, 4937.432195297551, 4983.401991760994, 4990.201567749161, 5001.274815151819, 4141.62725354718, 4966.162519867636, 4966.329545511364, 4969.602431805465, 4972.055309491185, 4884.902301953959, 5015.39815222172, 5021.096202683497, 5023.899522009576, 5026.095302845486, 4452.465704115494, 4453.621442177418, 4453.688241823073, 4456.376107344974, 4457.442819647544, 12246.203996740272, 17245.913770431194, 18442.538936526693, 19176.232950681955, 19263.4220973371, 1841.7881943576526, 1987.4335814292858, 2112.8732276063483, 2283.9543209135722, 2343.859368437882, 8360.790980225482, 8663.306935445213, 9118.316126290489, 9326.533673316308, 9334.0, 1556.564162034632, 1625.1143126995698, 1704.7869016372954, 1711.4352263753055, 1737.1140718233667, 62674.68662656703, 66604.66697666481, 67323.99014014842, 67630.0, 70544.6472767638, 9090.590923408463, 9490.667826626035, 9522.428654280766, 9828.164606008426, 9942.453165075991, 13654.726905461835, 13655.726885462234, 13676.726465470634, 13684.65788355299, 13696.109752866032, 6976.860462790817, 7173.390261827803, 7208.71165153388, 7324.926750732531, 7348.338649521569, 6755.695993680296, 6819.147606549182, 7039.190493093258, 7048.0, 7067.0, 4190.129761113647, 4244.915101697949, 4265.7014009019695, 4356.4336636237085, 4368.825246990148, 1726.9913650431668, 1736.7221244601055, 1750.536107931399, 1862.4226489787939, 1869.3550725000125, 758.1660173808766, 776.1268572855538, 798.876174193001, 867.2498288979987, 926.4163576946615, 15929.203539822962, 16171.787115966114, 16343.26455309514, 16715.331386744638, 17041.31834726597, 815.9224873636995, 818.5866137600593, 859.1537335724306, 867.6052396159732, 884.7922585670514, 8749.431286966326, 9483.430994140235, 9502.952485237529, 9517.333786634868, 9517.381370210915, 356331.0, 361215.0, 361934.0, 363549.0, 363573.0, 53726.7313663437, 68808.6559567199, 69886.0, 70573.0, 76581.61709191419, 851.2296371783669, 869.8956125264882, 898.9235914947172, 899.5457294066586, 899.6941040046415, 10924.399158046384, 14136.646583835074, 15045.548633541011, 15176.848231517544, 15414.0, 35581.288374232885, 36272.637273626926, 36645.63354366422, 37316.440253395675, 38305.6169438302, 45110.77444612756, 45685.314720278555, 45827.77086114548, 45906.31140532828, 48186.75906620585, 7155.24869888675, 7448.851022979402, 7565.167831538636, 7636.8472630548185, 7660.616969151409, 10903.34579925207, 11080.39057851826, 12083.335416552174, 12249.693757655774, 12259.448324825225, 10355.482225888825, 10392.37645741258, 10615.89384106149, 10629.627963021258, 11025.062869655849, 10445.321054131457, 10509.31689440184, 10598.31110977784, 10708.839367409651, 10717.89282107169, 10705.250632455653, 10854.782904342026, 10960.890391095987, 11313.660590182308, 11368.147388946027, 7518.511296765692, 7633.351165151024, 7707.766757318802, 7892.0924093729955, 7910.090339611018, 10010.349327293703, 10699.465026748476, 10769.515371808444, 10954.123670106213, 11213.831792522955], "value": 7902.467548759516, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.1431662261218, 1347.885429738472, 1379.655086228443, 1629.4785668586042, 1660.634660374718, 6205.658688772116, 6456.128422662939, 6686.598804071753, 7144.249853765357, 7157.176924653666, 6770.119884415019, 7036.5778053316835, 7057.964710176455, 7212.675429605667, 7214.603196824172, 2058.8558800883907, 2098.8320934325216, 2105.0316854247067, 2105.49468127649, 2114.8836813975227, 1807.6836553603132, 1884.971725424113, 2084.570880900917, 2121.1197353098446, 2128.57428514297, 1990.4327266728985, 2068.162394230339, 2072.0572139676487, 2085.092984551725, 2092.9581408371823, 2041.4386043838063, 2062.7937206279403, 2071.30611245233, 2085.655866781987, 2085.9687104693444, 2107.2519255664324, 2124.320217530391, 2128.063651993118, 2133.5626196629655, 2134.7331583552054, 7191.0, 7259.0563226780705, 7290.234525374813, 7291.52605080668, 7330.8900366494545, 4212.894677633053, 4263.680223983182, 4343.761093139876, 4350.195213885441, 4352.194843953878, 2653.4162484253625, 2818.957715634267, 2917.226934862263, 2931.721486458783, 2938.2213713365977, 850.3622283287534, 875.8598624220094, 881.2817553693719, 888.342626456424, 898.2140626951417, 9651.71044868655, 9682.661106861226, 9683.951580242125, 9690.51547422626, 9702.466364349957, 3589.587197472272, 3811.790351530637, 3894.5910679378258, 3900.297946369624, 3997.320455522568, 8402.117777633383, 8418.284445822052, 8424.157584241526, 8424.957875210584, 8427.0, 4440.156370289635, 4446.444194475691, 4453.220686379936, 4455.777211139495, 4456.331550267486, 3879.0690234343556, 4062.5734297898293, 4062.6952978526137, 4070.8371665133063, 4073.714839961174, 3267.607887053569, 3304.545999760098, 3390.5422767926507, 3408.761386702907, 3514.876979305712, 989.4113002763344, 1037.1184493180888, 1058.0953284941418, 1105.9668209953713, 1111.644273832382, 709.6912842913349, 723.6779633063342, 728.2717282717283, 777.5490215674895, 862.6635612111281, 4854.951450485521, 5028.7737051832755, 5055.7219352935945, 5056.772445239973, 5174.172132458863, 855.2858363266741, 856.8971723393232, 888.440282621944, 896.7668406214301, 903.8192361527721, 3365.528825964318, 3439.9656003440145, 3470.791752494808, 3473.6873681368797, 3576.088097535112, 8191.918080819235, 8730.563471826383, 8751.956240218886, 8752.124787521198, 8828.42615230008, 8740.388172827968, 8744.95627521871, 8750.0, 8751.737447876574, 8753.0, 6622.867542649216, 6816.216135144522, 6853.7943861684225, 6855.108835851407, 6858.828529286708, 4761.6904901181315, 4778.856634300976, 4833.879153021203, 4856.490068542752, 4889.731064791471, 7894.960525197567, 7910.802229944067, 8079.515229086273, 8138.3489320853005, 8148.674053037812, 8123.4313598047565, 8294.917050829414, 8359.205875441823, 8367.790805229917, 8367.874481882898, 5773.134029895549, 6001.099835024781, 6049.879002420015, 6078.422549857756, 6097.634141951497, 6834.384905358542, 6895.207051188977, 6895.6552172392185, 6900.758473453606, 6902.171739391305, 6155.230596175478, 6201.844953876189, 6215.160953271431, 6220.906686399798, 6493.383128602775, 6055.72749226277, 6108.083787431743, 6108.480779133645, 6137.539684523589, 6205.441510264098, 5717.685527296038, 5792.797252096157, 5804.796832110856, 5805.10020946754, 5805.767769289181, 4259.914801704011, 4470.351798989063, 4539.954600453953, 4545.181867263925, 4597.908041839078, 4303.419038429772, 4371.235033869124, 4462.642988560972, 4465.799039043316, 4558.430196225472], "value": 3872.937443701411, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.1880848051605, 273.7208047791253, 277.468647539961, 281.8435768148677, 282.0073341836733, 4583.220852455082, 4691.624670026398, 4731.976340118299, 4767.761611919404, 4773.618110551156, 4543.432070991126, 4655.767211639413, 4706.599939005188, 4715.269133284338, 4731.432228132629, 3500.1249687578106, 3643.6902863256655, 3661.2311414602964, 3663.7618554793985, 3708.1656627258853, 3530.2057037166687, 3641.3445579795625, 3654.835532401035, 3665.9083522911874, 3674.7060235181257, 3628.5827129880004, 3629.201575653352, 3643.344198044351, 3648.452732090181, 3648.872289469869, 3633.36416127178, 3652.7077833773233, 3656.926861462756, 3673.3204357194004, 3673.4673472346494, 3010.6452096556636, 3135.5453459248283, 3175.6665550117136, 3222.5649537312397, 3235.236795946215, 4585.564371384713, 4592.0815836832435, 4608.1705293047235, 4608.308753686941, 4613.192691279013, 4117.505899292074, 4125.608067233608, 4134.131832315217, 4135.7518548887165, 4161.292580261363, 4724.795177229818, 4885.7312847793355, 4890.095332363524, 4892.559669629715, 4910.919597688503, 3360.798352098882, 3365.7307415406954, 3381.7294616430872, 3384.0, 3389.9661003389897, 5106.876487172816, 5122.334096567422, 5134.743262836881, 5137.12668846297, 5151.381834179885, 3310.7915610801883, 3469.3755124077907, 3491.4762785582366, 3523.5947865995226, 3545.9290814183573, 3506.3688536063755, 3509.8069606171393, 3519.3665140274998, 3529.8235088245483, 3531.964680353215, 4054.9797251013556, 4062.695297852673, 4066.186762647423, 4067.613576710208, 4077.245709543744, 4669.906601867943, 4839.733814640158, 4844.878878028077, 4855.940757322935, 4890.535399137077, 1108.562117963416, 1182.7403814937065, 1182.751622159339, 1183.2663748475827, 1193.6061099837034, 771.7839005078587, 772.3820943245494, 786.6381464526382, 796.4942261663886, 804.6942161978411, 4198.916021679611, 4219.641330486943, 4227.936580951288, 4230.661547076226, 4234.9576504234565, 4837.419509658793, 4838.903221935612, 4852.675916996868, 4877.853664390074, 4878.804847806119, 4216.10275376082, 4222.015652643253, 4226.1336426032585, 4231.603570821683, 4232.560929284058, 2497.775200231988, 2571.344307201689, 2579.471208402273, 2580.0, 2582.2253324002722, 4479.865604031885, 4512.9774351128035, 4541.772911354419, 4549.5905368517, 4558.521355257716, 4919.262110683355, 4923.75381230937, 4926.655134140576, 4932.926006109911, 4946.629002824802, 4361.6074553290355, 4429.734215947054, 4519.502854685982, 4567.743870435656, 4571.885702857455, 4866.394089950379, 4869.467876704023, 4885.5358740919555, 4888.462269150462, 4908.165611846066, 4765.046990601824, 4766.307036524491, 4769.284607308793, 4774.498677638798, 4796.664233503621, 4485.416895803524, 4570.303520922539, 4769.57073863354, 4797.352357431702, 4802.0, 3512.736544759204, 3524.4537096750046, 3535.098549869767, 3535.8055306958363, 3539.3806083935724, 4904.75738486214, 5155.118381790545, 5164.561012313995, 5190.195519694454, 5206.687598743936, 4848.806047758191, 4914.631402644744, 4926.4088309403105, 4978.569073524638, 4990.476000019946, 4937.9012419752125, 4947.628927830499, 4957.231629097496, 4958.479359667327, 4970.130227210151, 4806.807727690853, 4898.583620392164, 4915.124652078574, 4921.50784921505, 4931.309616653743, 4976.975115124401, 5006.749662516932, 5014.297998280171, 5022.673526220784, 5029.346184995927, 4898.387701537308, 4904.313396124617, 4904.460509343898, 4906.1659517881335, 4942.5304596063315], "value": 3637.7770665486937, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.7193298981952, 679.7043286170516, 695.9686814093366, 707.0207762249283, 715.2739968931534, 12186.0, 12746.490140394397, 12750.872491275097, 12773.744525109492, 12810.807837882428, 11463.541458341677, 11490.36802975836, 11495.712607184825, 11506.884931150686, 11518.366489843056, 597.734008366275, 622.8256088295262, 716.1549371741343, 744.9143348514909, 757.6287619066673, 758.6813538313894, 771.0631582627107, 773.192014345008, 773.2190487607529, 773.4701729315409, 800.1158719614829, 801.9117897031322, 802.2699343597328, 802.8033131882668, 803.5821372886096, 628.2900322635438, 648.7794149989027, 758.6775620361325, 794.2256300107377, 797.143071198461, 589.2781342855011, 591.1664552980277, 592.2655906675734, 593.1103344982527, 594.2334388638651, 11841.289522628584, 11852.229605075643, 11880.58417955376, 11885.940570297093, 11914.821277680841, 11100.944495277472, 11131.165162612755, 11160.05139563138, 11641.767164656743, 11859.58491452795, 11044.447777611167, 11207.383593902332, 11346.149038822039, 11534.480948357344, 11973.700657483545, 3982.4260927842615, 3988.940165897514, 3994.2610617035944, 4083.5712250213596, 4092.6521245694153, 49288.75355623235, 49518.50481495211, 49628.25557616639, 50055.49944500545, 50480.74759626178, 9416.482093484925, 9468.715938521855, 9514.809703805886, 9533.094356036165, 9606.327557071078, 15929.920350398173, 16060.598485037734, 16868.746968795476, 17546.210420531108, 17740.645187096186, 5954.3152537458745, 6161.507079433634, 6196.194494715658, 6313.273973493107, 6315.526335524854, 3544.167120726627, 3564.465330200491, 3571.7321200910037, 3588.4079126944284, 3649.434337677664, 2699.973000269972, 2781.6105745195687, 2788.344738986337, 2790.9441811163665, 2800.271929298397, 467.08451435186737, 477.24356894322887, 482.9299751536078, 514.5549100028524, 537.4249552978275, 604.6583680220662, 617.3764497857196, 620.8758248350348, 637.7162162837585, 643.6331291163991, 7871.425714857051, 8038.477498962666, 8150.75547733569, 8219.589020548949, 8258.0, 570.0508653092554, 621.7473175408895, 624.5877720704314, 635.2599221906427, 639.4404895716249, 3617.8552857885916, 3629.764065335745, 3692.0, 3854.5567259765485, 3943.4676318697184, 66508.0, 68271.65864170747, 69786.30213697797, 70028.6498567514, 70171.0, 60249.397506025256, 60886.695566521885, 61349.38650613526, 61361.693191533755, 64147.67926160339, 56584.43415565792, 57494.99999999916, 57617.423825762045, 57933.420665793645, 58695.70652146712, 7112.822179445555, 7391.371733402721, 7436.479446438698, 7518.812029699083, 7521.661525231269, 37767.0, 38162.61837381591, 38400.80799596096, 38512.22975540529, 39539.209215816096, 52135.2179717297, 53575.0, 54053.45946540484, 54500.45499544954, 56545.0, 9479.241660667269, 9594.856077158987, 9679.70960871175, 9857.211423086279, 10123.291369604058, 10184.23618228621, 10429.426381549089, 10672.413017284123, 10708.785824283626, 10747.408892510673, 9987.700368988943, 10474.162067034771, 10944.398058106563, 11026.44867756625, 11169.944150279196, 9857.605695772088, 9989.150922171697, 10156.39061656303, 10302.124319432633, 10484.479750435992, 9661.71014869555, 9953.0, 10118.089371956265, 10326.070653641209, 10337.793244134924, 8290.834183316421, 8342.624581893951, 8404.831903361775, 8614.82770344602, 8947.463152210888, 7961.6752587618375, 8209.507429554245, 8248.340132789483, 8403.327733781405, 8449.324054075536], "value": 5990.91581826195, "unit": "score"}], "name": "dromaeo_css", "value": 6082.953315932248, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 116.0, 120.0, 117.0, 115.0, 116.0, 115.0, 115.0, 116.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 129.0, 130.0, 169.0, 136.0, 132.0, 130.0, 136.0, 169.0, 130.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 162.0, 161.0, 162.0, 161.0, 161.0, 171.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 107.0, 79.0, 77.0, 77.0, 77.0, 104.0, 78.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 127.0, 85.0, 84.0, 84.0, 114.0, 83.0, 83.0, 118.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 120.0, 117.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0, 85.0, 86.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 63.0, 64.0, 65.0, 65.0, 65.0, 64.0, 63.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 67.0, 66.0, 66.0, 65.0, 66.0, 66.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 88.0, 90.0, 88.0, 85.0, 85.0, 84.0, 85.0, 84.0, 93.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 142.0, 152.0, 144.0, 140.0, 142.0, 149.0, 141.0, 202.0, 155.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 183.0, 183.0, 178.0, 180.0, 180.0, 179.0, 181.0, 177.0, 187.0], "value": 180.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 72.0, 69.0, 70.0, 69.0, 73.0, 69.0, 69.0, 68.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1567.2999999999997, "alertThreshold": 2.0}]} 12:34:59 INFO - Return code: 0 12:34:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:34:59 INFO - # TBPL SUCCESS # 12:34:59 INFO - Running post-action listener: _resource_record_post_action 12:34:59 INFO - [mozharness: 2016-11-10 20:34:59.086703Z] Finished run-tests step (success) 12:34:59 INFO - Running post-run listener: _resource_record_post_run 12:34:59 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 0; Write bytes: 406892544; Read time: 0; Write time: 272892 12:34:59 INFO - TinderboxPrint: CPU usage
13.1% 12:34:59 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:34:59 INFO - TinderboxPrint: I/O write bytes / time
406,892,544 / 272,892 12:34:59 INFO - TinderboxPrint: CPU idle
8,356.1 (86.9%) 12:34:59 INFO - TinderboxPrint: CPU user
1,209.1 (12.6%) 12:34:59 INFO - TinderboxPrint: Swap in / out
0 / 0 12:34:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115978240; Read time: 0; Write time: 65816 12:34:59 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 290914304; Read time: 0; Write time: 207076 12:34:59 INFO - Running post-run listener: _upload_blobber_files 12:34:59 INFO - Blob upload gear active. 12:34:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:34:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:34:59 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'] 12:34:59 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 12:35:00 INFO - (blobuploader) - INFO - Open directory for files ... 12:35:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:35:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:35:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:00 INFO - (blobuploader) - INFO - Done attempting. 12:35:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:35:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:35:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:02 INFO - (blobuploader) - INFO - Done attempting. 12:35:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:35:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:35:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:05 INFO - (blobuploader) - INFO - Done attempting. 12:35:05 INFO - (blobuploader) - INFO - Iteration through files over. 12:35:05 INFO - Return code: 0 12:35:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:35:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:35:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4a58e851b77e7b9a5aadf553b6844347bdcd92f3066b5780265d5c04652546b6cc9bee72d9566712db25047c6dbf97dadb9c6a386720639e69bc5b2d87d4f114", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/68b835eea62f57b8c7ab37d1e964c4758918c60b7a18c5e1ae4f27e2aee8a8f5b2ce087fca8417b87db04be8a7d3498e78c46e215802cdc85d0e0c4b22261c46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1f44b98524a62b18b8fee6f55cdb97db725a3c06c35cb30dd0d5b77b184a671ddd99f4a176382946af39b99d4c8371c7aefbdd8169806b84eb1e75729d0de24e"} 12:35:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:35:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:35:05 INFO - Contents: 12:35:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4a58e851b77e7b9a5aadf553b6844347bdcd92f3066b5780265d5c04652546b6cc9bee72d9566712db25047c6dbf97dadb9c6a386720639e69bc5b2d87d4f114", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/68b835eea62f57b8c7ab37d1e964c4758918c60b7a18c5e1ae4f27e2aee8a8f5b2ce087fca8417b87db04be8a7d3498e78c46e215802cdc85d0e0c4b22261c46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1f44b98524a62b18b8fee6f55cdb97db725a3c06c35cb30dd0d5b77b184a671ddd99f4a176382946af39b99d4c8371c7aefbdd8169806b84eb1e75729d0de24e"} 12:35:05 INFO - Running post-run listener: copy_logs_to_upload_dir 12:35:05 INFO - Copying logs to upload dir... 12:35:05 INFO - mkdir: /builds/slave/test/build/upload/logs 12:35:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.097533 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-11-10 12:35:04.867757) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 12:35:04.871591) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4a58e851b77e7b9a5aadf553b6844347bdcd92f3066b5780265d5c04652546b6cc9bee72d9566712db25047c6dbf97dadb9c6a386720639e69bc5b2d87d4f114", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/68b835eea62f57b8c7ab37d1e964c4758918c60b7a18c5e1ae4f27e2aee8a8f5b2ce087fca8417b87db04be8a7d3498e78c46e215802cdc85d0e0c4b22261c46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1f44b98524a62b18b8fee6f55cdb97db725a3c06c35cb30dd0d5b77b184a671ddd99f4a176382946af39b99d4c8371c7aefbdd8169806b84eb1e75729d0de24e"} build_url:https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/VurCGZwARrKa87nGPHdS_g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4a58e851b77e7b9a5aadf553b6844347bdcd92f3066b5780265d5c04652546b6cc9bee72d9566712db25047c6dbf97dadb9c6a386720639e69bc5b2d87d4f114", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/68b835eea62f57b8c7ab37d1e964c4758918c60b7a18c5e1ae4f27e2aee8a8f5b2ce087fca8417b87db04be8a7d3498e78c46e215802cdc85d0e0c4b22261c46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1f44b98524a62b18b8fee6f55cdb97db725a3c06c35cb30dd0d5b77b184a671ddd99f4a176382946af39b99d4c8371c7aefbdd8169806b84eb1e75729d0de24e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 12:35:04.897443) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 12:35:04.897778) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1478808368.838882-461127391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 12:35:04.947121) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 12:35:04.947441) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 12:35:04.947750) ========= ========= Total master_lag: 0.13 =========