builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1483202158.98 results: success (0) buildid: 20161231070020 builduid: 2ef26604d014461394c2c28f88b52f6b revision: 623f7b10ae96b129068d1ceb85d0e83ef5b19502 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-31 08:35:58.981351) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-31 08:35:58.981907) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-31 08:35:58.982199) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-31 08:35:59.000638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 08:35:59.000958) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-31 08:35:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.8M=0s 2016-12-31 08:35:59 (39.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.204590 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 08:35:59.219953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 08:35:59.220236) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016830 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 08:35:59.269004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 08:35:59.269314) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 623f7b10ae96b129068d1ceb85d0e83ef5b19502 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 623f7b10ae96b129068d1ceb85d0e83ef5b19502 --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=9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-31 08:35:59,713 truncating revision to first 12 chars 2016-12-31 08:35:59,714 Setting DEBUG logging. 2016-12-31 08:35:59,714 attempt 1/10 2016-12-31 08:35:59,714 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/623f7b10ae96?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-31 08:36:00,024 unpacking tar archive at: mozilla-aurora-623f7b10ae96/testing/mozharness/ program finished with exit code 0 elapsedTime=0.616162 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 08:35:59.898592) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-31 08:35:59.898897) ========= script_repo_revision: 623f7b10ae96b129068d1ceb85d0e83ef5b19502 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-31 08:35:59.899328) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-31 08:35:59.899624) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-31 08:35:59.909992) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-31 08:35:59.910484) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:36:00 INFO - MultiFileLogger online at 20161231 08:36:00 in /builds/slave/test 08:36:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:36:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:36:00 INFO - {'append_to_log': False, 08:36:00 INFO - 'base_work_dir': '/builds/slave/test', 08:36:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:36:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:36:00 INFO - 'branch': 'Mozilla-Aurora', 08:36:00 INFO - 'buildbot_json_path': 'buildprops.json', 08:36:00 INFO - 'config_files': ('talos/linux_config.py',), 08:36:00 INFO - 'default_actions': ('clobber', 08:36:00 INFO - 'read-buildbot-config', 08:36:00 INFO - 'download-and-extract', 08:36:00 INFO - 'populate-webroot', 08:36:00 INFO - 'create-virtualenv', 08:36:00 INFO - 'install', 08:36:00 INFO - 'run-tests'), 08:36:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:36:00 INFO - 'download_minidump_stackwalk': True, 08:36:00 INFO - 'download_symbols': 'ondemand', 08:36:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:36:00 INFO - 'tooltool.py': '/tools/tooltool.py', 08:36:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:36:00 INFO - '/tools/misc-python/virtualenv.py')}, 08:36:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:36:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:36:00 INFO - 'installer_path': 'installer.exe', 08:36:00 INFO - 'log_level': 'info', 08:36:00 INFO - 'log_name': 'talos', 08:36:00 INFO - 'log_to_console': True, 08:36:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:36:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:36:00 INFO - 'opt_config_files': (), 08:36:00 INFO - 'pip_index': False, 08:36:00 INFO - 'sps_profile': False, 08:36:00 INFO - 'sps_profile_interval': 0, 08:36:00 INFO - 'suite': 'dromaeojs', 08:36:00 INFO - 'system_bits': '32', 08:36:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:36:00 INFO - 'title': 'talos-linux64-ix-013', 08:36:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:36:00 INFO - 'use_talos_json': True, 08:36:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:36:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:36:00 INFO - 'work_dir': 'build'} 08:36:00 INFO - [mozharness: 2016-12-31 16:36:00.460263Z] Running clobber step. 08:36:00 INFO - Running pre-action listener: _resource_record_pre_action 08:36:00 INFO - Running main action method: clobber 08:36:00 INFO - rmtree: /builds/slave/test/build 08:36:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:36:01 INFO - Running post-action listener: _resource_record_post_action 08:36:01 INFO - [mozharness: 2016-12-31 16:36:01.434937Z] Finished clobber step (success) 08:36:01 INFO - [mozharness: 2016-12-31 16:36:01.435036Z] Running read-buildbot-config step. 08:36:01 INFO - Running pre-action listener: _resource_record_pre_action 08:36:01 INFO - Running main action method: read_buildbot_config 08:36:01 INFO - Using buildbot properties: 08:36:01 INFO - { 08:36:01 INFO - "project": "", 08:36:01 INFO - "product": "firefox", 08:36:01 INFO - "script_repo_revision": "production", 08:36:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:36:01 INFO - "repository": "", 08:36:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:36:01 INFO - "buildid": "20161231070020", 08:36:01 INFO - "pgo_build": "True", 08:36:01 INFO - "basedir": "/builds/slave/test", 08:36:01 INFO - "buildnumber": 669, 08:36:01 INFO - "slavename": "talos-linux64-ix-013", 08:36:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:36:01 INFO - "platform": "ubuntu64_hw", 08:36:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:36:01 INFO - "branch": "mozilla-aurora", 08:36:01 INFO - "repo_path": "releases/mozilla-aurora", 08:36:01 INFO - "revision": "623f7b10ae96b129068d1ceb85d0e83ef5b19502", 08:36:01 INFO - "stage_platform": "linux64-pgo", 08:36:01 INFO - "builduid": "2ef26604d014461394c2c28f88b52f6b", 08:36:01 INFO - "slavebuilddir": "test" 08:36:01 INFO - } 08:36:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:36:01 INFO - Running post-action listener: _resource_record_post_action 08:36:01 INFO - [mozharness: 2016-12-31 16:36:01.437694Z] Finished read-buildbot-config step (success) 08:36:01 INFO - [mozharness: 2016-12-31 16:36:01.437781Z] Running download-and-extract step. 08:36:01 INFO - Running pre-action listener: _resource_record_pre_action 08:36:01 INFO - Running main action method: download_and_extract 08:36:01 INFO - mkdir: /builds/slave/test/build/tests 08:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:01 INFO - trying https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:36:01 INFO - Downloading https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:36:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:36:01 INFO - Downloaded 1361 bytes. 08:36:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:36:02 INFO - Using the following test package requirements: 08:36:02 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:36:02 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:36:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:36:02 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:36:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:36:02 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:36:02 INFO - u'jsshell-linux-x86_64.zip'], 08:36:02 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:36:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:36:02 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:36:02 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:36:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:36:02 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:36:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:36:02 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:36:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:36:02 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:36:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:36:02 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:36:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:36:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:36:02 INFO - Fetch https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:36:02 INFO - Http code: 200 08:36:02 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 08:36:02 INFO - x-amz-cf-id: RgQJdHBLR9Nn4MMnx1onUQXXni-saVyoSi-_3Okxejxn8IoLonmOAA== 08:36:02 INFO - x-amz-version-id: f8p9732kHaJrf.LirubuDvGdF7HHwMQX 08:36:02 INFO - Expected file size: 21941397 08:36:02 INFO - Obtained file size: 21941397 08:36:06 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:36:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:36:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:36:06 INFO - Fetch https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:36:07 INFO - Http code: 200 08:36:07 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 08:36:07 INFO - x-amz-cf-id: w0Z-xPx2VfenDPijSUpq6YC40x0CwSOGKsFiBPVbhKVEdaShiEZp7A== 08:36:07 INFO - x-amz-version-id: f8p9732kHaJrf.LirubuDvGdF7HHwMQX 08:36:07 INFO - Expected file size: 21941397 08:36:07 INFO - Obtained file size: 21941397 08:36:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:36:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:36:12 INFO - Fetch https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:36:12 INFO - Http code: 200 08:36:12 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 08:36:12 INFO - x-amz-cf-id: pCaAmxCvyuD_YbXU8qiLspr6diJN3cGjyegj2c8tRRlglldyr-PzhA== 08:36:12 INFO - x-amz-version-id: Wds_Z20gax5JQV9HX91wlgRCkWG77YUa 08:36:12 INFO - Expected file size: 14409038 08:36:12 INFO - Obtained file size: 14409038 08:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:13 INFO - trying https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:36:13 INFO - Downloading https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:36:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:36:15 INFO - Downloaded 64032696 bytes. 08:36:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:36:15 INFO - mkdir: /builds/slave/test/properties 08:36:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:36:15 INFO - Writing to file /builds/slave/test/properties/build_url 08:36:15 INFO - Contents: 08:36:15 INFO - build_url:https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:36:15 INFO - Running post-action listener: _resource_record_post_action 08:36:15 INFO - Running post-action listener: set_extra_try_arguments 08:36:15 INFO - [mozharness: 2016-12-31 16:36:15.971993Z] Finished download-and-extract step (success) 08:36:15 INFO - [mozharness: 2016-12-31 16:36:15.972216Z] Running populate-webroot step. 08:36:15 INFO - Running pre-action listener: _resource_record_pre_action 08:36:15 INFO - Running main action method: populate_webroot 08:36:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:36:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:36:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:36:15 INFO - '--tppagecycles', 08:36:15 INFO - '7'], 08:36:15 INFO - 'tests': ['tsvgm']}}, 08:36:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:36:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:36:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:36:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:36:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:36:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:36:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:15 INFO - 'talos_options': ['--disable-e10s'], 08:36:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:36:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:36:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:15 INFO - 'talos_options': ['--disable-e10s'], 08:36:15 INFO - 'tests': ['damp', 'tps']}, 08:36:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:15 INFO - 'tests': ['damp', 'tps']}, 08:36:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:36:15 INFO - 'tests': ['dromaeo_dom']}, 08:36:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:36:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:36:15 INFO - 'tests': ['basic_compositor_video']}, 08:36:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:36:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:36:15 INFO - 'tests': ['a11yr', 08:36:15 INFO - 'ts_paint', 08:36:15 INFO - 'tpaint', 08:36:15 INFO - 'sessionrestore', 08:36:15 INFO - 'sessionrestore_no_auto_restore', 08:36:15 INFO - 'tabpaint']}, 08:36:15 INFO - 'other-e10s': {'tests': ['a11yr', 08:36:15 INFO - 'ts_paint', 08:36:15 INFO - 'tpaint', 08:36:15 INFO - 'sessionrestore', 08:36:15 INFO - 'sessionrestore_no_auto_restore', 08:36:15 INFO - 'tabpaint']}, 08:36:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:36:15 INFO - 'ts_paint', 08:36:15 INFO - 'tpaint', 08:36:15 INFO - 'sessionrestore', 08:36:15 INFO - 'sessionrestore_no_auto_restore', 08:36:15 INFO - 'tabpaint']}, 08:36:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:36:15 INFO - 'ts_paint', 08:36:15 INFO - 'tpaint', 08:36:15 INFO - 'sessionrestore', 08:36:15 INFO - 'sessionrestore_no_auto_restore', 08:36:15 INFO - 'tabpaint']}, 08:36:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:36:15 INFO - 'tests': ['a11yr', 08:36:15 INFO - 'ts_paint', 08:36:15 INFO - 'tpaint', 08:36:15 INFO - 'sessionrestore', 08:36:15 INFO - 'sessionrestore_no_auto_restore', 08:36:15 INFO - 'tabpaint']}, 08:36:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:36:15 INFO - 'tests': ['a11yr', 08:36:15 INFO - 'ts_paint', 08:36:15 INFO - 'tpaint', 08:36:15 INFO - 'sessionrestore', 08:36:15 INFO - 'sessionrestore_no_auto_restore', 08:36:15 INFO - 'tabpaint']}, 08:36:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:36:15 INFO - 'tests': ['tsvgx', 08:36:15 INFO - 'tsvgr_opacity', 08:36:15 INFO - 'tart', 08:36:15 INFO - 'tscrollx', 08:36:15 INFO - 'cart']}, 08:36:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:36:15 INFO - 'tsvgr_opacity', 08:36:15 INFO - 'tart', 08:36:15 INFO - 'tscrollx', 08:36:15 INFO - 'cart']}, 08:36:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:15 INFO - 'talos_options': ['--disable-e10s'], 08:36:15 INFO - 'tests': ['tp5o']}, 08:36:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:15 INFO - 'tests': ['tp5o']}, 08:36:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:15 INFO - 'talos_options': ['--disable-e10s', 08:36:15 INFO - '--xperf_path', 08:36:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:36:15 INFO - 'tests': ['tp5n']}, 08:36:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:15 INFO - 'talos_options': ['--xperf_path', 08:36:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:36:15 INFO - 'tests': ['tp5n']}}, 08:36:15 INFO - 'talos.zip': {'path': '', 08:36:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:36:15 INFO - Running post-action listener: _resource_record_post_action 08:36:15 INFO - [mozharness: 2016-12-31 16:36:15.993468Z] Finished populate-webroot step (success) 08:36:15 INFO - [mozharness: 2016-12-31 16:36:15.993555Z] Running create-virtualenv step. 08:36:15 INFO - Running pre-action listener: _resource_record_pre_action 08:36:15 INFO - Running main action method: create_virtualenv 08:36:15 INFO - Creating virtualenv /builds/slave/test/build/venv 08:36:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:36:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:36:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:36:16 INFO - Using real prefix '/usr' 08:36:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:36:16 INFO - Installing distribute.............................................................................................................................................................................................done. 08:36:18 INFO - Installing pip.................done. 08:36:18 INFO - Return code: 0 08:36:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:36:18 INFO - Reading from file tmpfile_stdout 08:36:18 INFO - Output received: 08:36:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:36:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2bf7e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203ef60>, '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 0x203fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20401d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:36:18 INFO - Using env: {'DISPLAY': ':0', 08:36:18 INFO - 'HOME': '/home/cltbld', 08:36:18 INFO - 'LANG': 'en_US.UTF-8', 08:36:18 INFO - 'LANGUAGE': 'en_US:en', 08:36:18 INFO - 'LOGNAME': 'cltbld', 08:36:18 INFO - 'MAIL': '/var/mail/cltbld', 08:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:18 INFO - 'MOZ_NO_REMOTE': '1', 08:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:18 INFO - 'NO_EM_RESTART': '1', 08:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:18 INFO - 'PWD': '/builds/slave/test', 08:36:18 INFO - 'SHELL': '/bin/bash', 08:36:18 INFO - 'SHLVL': '1', 08:36:18 INFO - 'TERM': 'linux', 08:36:18 INFO - 'TMOUT': '86400', 08:36:18 INFO - 'USER': 'cltbld', 08:36:18 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 08:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:18 INFO - '_': '/tools/buildbot/bin/python'} 08:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:36:18 INFO - Cleaning up... 08:36:19 INFO - Return code: 0 08:36:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:19 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 0x7f2bf7e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203ef60>, '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 0x203fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20401d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:36:19 INFO - Using env: {'DISPLAY': ':0', 08:36:19 INFO - 'HOME': '/home/cltbld', 08:36:19 INFO - 'LANG': 'en_US.UTF-8', 08:36:19 INFO - 'LANGUAGE': 'en_US:en', 08:36:19 INFO - 'LOGNAME': 'cltbld', 08:36:19 INFO - 'MAIL': '/var/mail/cltbld', 08:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:19 INFO - 'MOZ_NO_REMOTE': '1', 08:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:19 INFO - 'NO_EM_RESTART': '1', 08:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:19 INFO - 'PWD': '/builds/slave/test', 08:36:19 INFO - 'SHELL': '/bin/bash', 08:36:19 INFO - 'SHLVL': '1', 08:36:19 INFO - 'TERM': 'linux', 08:36:19 INFO - 'TMOUT': '86400', 08:36:19 INFO - 'USER': 'cltbld', 08:36:19 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 08:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:19 INFO - '_': '/tools/buildbot/bin/python'} 08:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:19 INFO - Downloading/unpacking psutil>=3.1.1 08:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:36:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:21 INFO - Installing collected packages: psutil 08:36:21 INFO - Running setup.py install for psutil 08:36:21 INFO - building 'psutil._psutil_linux' extension 08:36:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:36:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:36:21 INFO - building 'psutil._psutil_posix' extension 08:36:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:36:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:36:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:21 INFO - Successfully installed psutil 08:36:21 INFO - Cleaning up... 08:36:21 INFO - Return code: 0 08:36:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:21 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 0x7f2bf7e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203ef60>, '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 0x203fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20401d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:36:21 INFO - Using env: {'DISPLAY': ':0', 08:36:21 INFO - 'HOME': '/home/cltbld', 08:36:21 INFO - 'LANG': 'en_US.UTF-8', 08:36:21 INFO - 'LANGUAGE': 'en_US:en', 08:36:21 INFO - 'LOGNAME': 'cltbld', 08:36:21 INFO - 'MAIL': '/var/mail/cltbld', 08:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:21 INFO - 'MOZ_NO_REMOTE': '1', 08:36:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:21 INFO - 'NO_EM_RESTART': '1', 08:36:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:21 INFO - 'PWD': '/builds/slave/test', 08:36:21 INFO - 'SHELL': '/bin/bash', 08:36:21 INFO - 'SHLVL': '1', 08:36:21 INFO - 'TERM': 'linux', 08:36:21 INFO - 'TMOUT': '86400', 08:36:21 INFO - 'USER': 'cltbld', 08:36:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 08:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:21 INFO - '_': '/tools/buildbot/bin/python'} 08:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:36:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:36:24 INFO - Installing collected packages: mozsystemmonitor 08:36:24 INFO - Running setup.py install for mozsystemmonitor 08:36:24 INFO - Successfully installed mozsystemmonitor 08:36:24 INFO - Cleaning up... 08:36:24 INFO - Return code: 0 08:36:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:24 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 0x7f2bf7e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203ef60>, '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 0x203fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20401d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:36:24 INFO - Using env: {'DISPLAY': ':0', 08:36:24 INFO - 'HOME': '/home/cltbld', 08:36:24 INFO - 'LANG': 'en_US.UTF-8', 08:36:24 INFO - 'LANGUAGE': 'en_US:en', 08:36:24 INFO - 'LOGNAME': 'cltbld', 08:36:24 INFO - 'MAIL': '/var/mail/cltbld', 08:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:24 INFO - 'MOZ_NO_REMOTE': '1', 08:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:24 INFO - 'NO_EM_RESTART': '1', 08:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:24 INFO - 'PWD': '/builds/slave/test', 08:36:24 INFO - 'SHELL': '/bin/bash', 08:36:24 INFO - 'SHLVL': '1', 08:36:24 INFO - 'TERM': 'linux', 08:36:24 INFO - 'TMOUT': '86400', 08:36:24 INFO - 'USER': 'cltbld', 08:36:24 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 08:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:24 INFO - '_': '/tools/buildbot/bin/python'} 08:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:24 INFO - Downloading/unpacking jsonschema==2.5.1 08:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:36:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:26 INFO - Downloading functools32-3.2.3-2.tar.gz 08:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:36:26 INFO - warning: no files found matching '*.txt' 08:36:26 INFO - no previously-included directories found matching 'build' 08:36:26 INFO - no previously-included directories found matching 'dist' 08:36:26 INFO - no previously-included directories found matching '.git*' 08:36:26 INFO - Installing collected packages: jsonschema, functools32 08:36:26 INFO - Running setup.py install for functools32 08:36:26 INFO - warning: no files found matching '*.txt' 08:36:26 INFO - no previously-included directories found matching 'build' 08:36:26 INFO - no previously-included directories found matching 'dist' 08:36:26 INFO - no previously-included directories found matching '.git*' 08:36:26 INFO - Successfully installed jsonschema functools32 08:36:26 INFO - Cleaning up... 08:36:26 INFO - Return code: 0 08:36:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:27 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 0x7f2bf7e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203ef60>, '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 0x203fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20401d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:36:27 INFO - Using env: {'DISPLAY': ':0', 08:36:27 INFO - 'HOME': '/home/cltbld', 08:36:27 INFO - 'LANG': 'en_US.UTF-8', 08:36:27 INFO - 'LANGUAGE': 'en_US:en', 08:36:27 INFO - 'LOGNAME': 'cltbld', 08:36:27 INFO - 'MAIL': '/var/mail/cltbld', 08:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:27 INFO - 'MOZ_NO_REMOTE': '1', 08:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:27 INFO - 'NO_EM_RESTART': '1', 08:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:27 INFO - 'PWD': '/builds/slave/test', 08:36:27 INFO - 'SHELL': '/bin/bash', 08:36:27 INFO - 'SHLVL': '1', 08:36:27 INFO - 'TERM': 'linux', 08:36:27 INFO - 'TMOUT': '86400', 08:36:27 INFO - 'USER': 'cltbld', 08:36:27 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 08:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:27 INFO - '_': '/tools/buildbot/bin/python'} 08:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:36:27 INFO - Cleaning up... 08:36:27 INFO - Return code: 0 08:36:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:27 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 0x7f2bf7e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203ef60>, '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 0x203fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20401d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:36:27 INFO - Using env: {'DISPLAY': ':0', 08:36:27 INFO - 'HOME': '/home/cltbld', 08:36:27 INFO - 'LANG': 'en_US.UTF-8', 08:36:27 INFO - 'LANGUAGE': 'en_US:en', 08:36:27 INFO - 'LOGNAME': 'cltbld', 08:36:27 INFO - 'MAIL': '/var/mail/cltbld', 08:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:27 INFO - 'MOZ_NO_REMOTE': '1', 08:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:27 INFO - 'NO_EM_RESTART': '1', 08:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:27 INFO - 'PWD': '/builds/slave/test', 08:36:27 INFO - 'SHELL': '/bin/bash', 08:36:27 INFO - 'SHLVL': '1', 08:36:27 INFO - 'TERM': 'linux', 08:36:27 INFO - 'TMOUT': '86400', 08:36:27 INFO - 'USER': 'cltbld', 08:36:27 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 08:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:27 INFO - '_': '/tools/buildbot/bin/python'} 08:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:27 INFO - Downloading/unpacking blobuploader==1.2.4 08:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:29 INFO - Downloading blobuploader-1.2.4.tar.gz 08:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:36:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:36:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:30 INFO - Downloading docopt-0.6.1.tar.gz 08:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:36:30 INFO - Installing collected packages: blobuploader, requests, docopt 08:36:30 INFO - Running setup.py install for blobuploader 08:36:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:36:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:36:30 INFO - Running setup.py install for requests 08:36:30 INFO - Running setup.py install for docopt 08:36:30 INFO - Successfully installed blobuploader requests docopt 08:36:30 INFO - Cleaning up... 08:36:30 INFO - Return code: 0 08:36:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:30 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 0x7f2bf7e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203ef60>, '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 0x203fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20401d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:30 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 08:36:30 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 08:36:30 INFO - Using env: {'DISPLAY': ':0', 08:36:30 INFO - 'HOME': '/home/cltbld', 08:36:30 INFO - 'LANG': 'en_US.UTF-8', 08:36:30 INFO - 'LANGUAGE': 'en_US:en', 08:36:30 INFO - 'LOGNAME': 'cltbld', 08:36:30 INFO - 'MAIL': '/var/mail/cltbld', 08:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:30 INFO - 'MOZ_NO_REMOTE': '1', 08:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:30 INFO - 'NO_EM_RESTART': '1', 08:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:30 INFO - 'PWD': '/builds/slave/test', 08:36:30 INFO - 'SHELL': '/bin/bash', 08:36:30 INFO - 'SHLVL': '1', 08:36:30 INFO - 'TERM': 'linux', 08:36:30 INFO - 'TMOUT': '86400', 08:36:30 INFO - 'USER': 'cltbld', 08:36:30 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 08:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:30 INFO - '_': '/tools/buildbot/bin/python'} 08:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:31 INFO - Running setup.py (path:/tmp/pip-gDavKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:31 INFO - Running setup.py (path:/tmp/pip-3yR2Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:31 INFO - Running setup.py (path:/tmp/pip-HbVvgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:31 INFO - Running setup.py (path:/tmp/pip-QdBkHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:31 INFO - Running setup.py (path:/tmp/pip-Lw4Ucz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:31 INFO - Running setup.py (path:/tmp/pip-jY3HK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:31 INFO - Running setup.py (path:/tmp/pip-qyCHU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:31 INFO - Running setup.py (path:/tmp/pip-qSh57e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:31 INFO - Running setup.py (path:/tmp/pip-ykKjbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:31 INFO - Running setup.py (path:/tmp/pip-cAxDlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:31 INFO - Running setup.py (path:/tmp/pip-kd_Fpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:31 INFO - Running setup.py (path:/tmp/pip-91WPqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:31 INFO - Running setup.py (path:/tmp/pip-40DUls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:32 INFO - Running setup.py (path:/tmp/pip-eyF9GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:32 INFO - Running setup.py (path:/tmp/pip-mRYc9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:32 INFO - Running setup.py (path:/tmp/pip-1iyFfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:32 INFO - Running setup.py (path:/tmp/pip-HDKFqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:36:32 INFO - Running setup.py install for manifestparser 08:36:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:36:32 INFO - Running setup.py install for mozcrash 08:36:32 INFO - Running setup.py install for mozdebug 08:36:32 INFO - Running setup.py install for mozdevice 08:36:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:36:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:36:32 INFO - Running setup.py install for mozfile 08:36:32 INFO - Running setup.py install for mozhttpd 08:36:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:36:32 INFO - Running setup.py install for mozinfo 08:36:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:36:33 INFO - Running setup.py install for mozInstall 08:36:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:36:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:36:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:36:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:36:33 INFO - Running setup.py install for mozleak 08:36:33 INFO - Running setup.py install for mozlog 08:36:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:36:33 INFO - Running setup.py install for moznetwork 08:36:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:36:33 INFO - Running setup.py install for mozprocess 08:36:33 INFO - Running setup.py install for mozprofile 08:36:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:36:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:36:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:36:33 INFO - Running setup.py install for mozrunner 08:36:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:36:33 INFO - Running setup.py install for mozscreenshot 08:36:33 INFO - Running setup.py install for moztest 08:36:33 INFO - Running setup.py install for mozversion 08:36:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:36:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:36:34 INFO - Cleaning up... 08:36:34 INFO - Return code: 0 08:36:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36: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')]} 08:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36: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')]} 08:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:34 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 0x7f2bf7e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203ef60>, '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 0x203fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20401d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:34 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 08:36:34 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 08:36:34 INFO - Using env: {'DISPLAY': ':0', 08:36:34 INFO - 'HOME': '/home/cltbld', 08:36:34 INFO - 'LANG': 'en_US.UTF-8', 08:36:34 INFO - 'LANGUAGE': 'en_US:en', 08:36:34 INFO - 'LOGNAME': 'cltbld', 08:36:34 INFO - 'MAIL': '/var/mail/cltbld', 08:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:34 INFO - 'MOZ_NO_REMOTE': '1', 08:36:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:34 INFO - 'NO_EM_RESTART': '1', 08:36:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:34 INFO - 'PWD': '/builds/slave/test', 08:36:34 INFO - 'SHELL': '/bin/bash', 08:36:34 INFO - 'SHLVL': '1', 08:36:34 INFO - 'TERM': 'linux', 08:36:34 INFO - 'TMOUT': '86400', 08:36:34 INFO - 'USER': 'cltbld', 08:36:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 08:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:34 INFO - '_': '/tools/buildbot/bin/python'} 08:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:34 INFO - Running setup.py (path:/tmp/pip-ZxAYVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:34 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)) 08:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:34 INFO - Running setup.py (path:/tmp/pip-pDvaJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:34 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)) 08:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:34 INFO - Running setup.py (path:/tmp/pip-59GigT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:34 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)) 08:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:34 INFO - Running setup.py (path:/tmp/pip-uM5nkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:34 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)) 08:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:34 INFO - Running setup.py (path:/tmp/pip-rNZGG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:34 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)) 08:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:34 INFO - Running setup.py (path:/tmp/pip-kiwaHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:34 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)) 08:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:34 INFO - Running setup.py (path:/tmp/pip-ZLehDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:34 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)) 08:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:34 INFO - Running setup.py (path:/tmp/pip-v5CNEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:34 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)) 08:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:34 INFO - Running setup.py (path:/tmp/pip-y32w8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:34 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)) 08:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:34 INFO - Running setup.py (path:/tmp/pip-dfN9TF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:35 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)) 08:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:35 INFO - Running setup.py (path:/tmp/pip-d6ZlD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:35 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)) 08:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:35 INFO - Running setup.py (path:/tmp/pip-X9tCbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:35 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)) 08:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:35 INFO - Running setup.py (path:/tmp/pip-TO5r5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:35 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)) 08:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:35 INFO - Running setup.py (path:/tmp/pip-eatX7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:35 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)) 08:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:35 INFO - Running setup.py (path:/tmp/pip-9XLutM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:35 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)) 08:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:35 INFO - Running setup.py (path:/tmp/pip-1WpgrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:35 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)) 08:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:35 INFO - Running setup.py (path:/tmp/pip-hw7gU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:35 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)) 08:36:35 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)) 08:36:35 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)) 08:36:35 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)) 08:36:35 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)) 08:36:35 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)) 08:36:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:37 INFO - Downloading blessings-1.6.tar.gz 08:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:36:37 INFO - Installing collected packages: blessings 08:36:37 INFO - Running setup.py install for blessings 08:36:37 INFO - Successfully installed blessings 08:36:37 INFO - Cleaning up... 08:36:37 INFO - Return code: 0 08:36:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:38 INFO - Reading from file tmpfile_stdout 08:36:38 INFO - Current package versions: 08:36:38 INFO - argparse == 1.2.1 08:36:38 INFO - blessings == 1.6 08:36:38 INFO - blobuploader == 1.2.4 08:36:38 INFO - docopt == 0.6.1 08:36:38 INFO - functools32 == 3.2.3-2 08:36:38 INFO - jsonschema == 2.5.1 08:36:38 INFO - manifestparser == 1.1 08:36:38 INFO - mozInstall == 1.12 08:36:38 INFO - mozcrash == 1.0 08:36:38 INFO - mozdebug == 0.1 08:36:38 INFO - mozdevice == 0.48 08:36:38 INFO - mozfile == 1.2 08:36:38 INFO - mozhttpd == 0.7 08:36:38 INFO - mozinfo == 0.9 08:36:38 INFO - mozleak == 0.1 08:36:38 INFO - mozlog == 3.4 08:36:38 INFO - moznetwork == 0.27 08:36:38 INFO - mozprocess == 0.23 08:36:38 INFO - mozprofile == 0.28 08:36:38 INFO - mozrunner == 6.13 08:36:38 INFO - mozscreenshot == 0.1 08:36:38 INFO - mozsystemmonitor == 0.3 08:36:38 INFO - moztest == 0.7 08:36:38 INFO - mozversion == 1.4 08:36:38 INFO - psutil == 3.1.1 08:36:38 INFO - requests == 1.2.3 08:36:38 INFO - wsgiref == 0.1.2 08:36:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:38 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 0x7f2bf7e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203ef60>, '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 0x203fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20401d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:38 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 08:36:38 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 08:36:38 INFO - Using env: {'DISPLAY': ':0', 08:36:38 INFO - 'HOME': '/home/cltbld', 08:36:38 INFO - 'LANG': 'en_US.UTF-8', 08:36:38 INFO - 'LANGUAGE': 'en_US:en', 08:36:38 INFO - 'LOGNAME': 'cltbld', 08:36:38 INFO - 'MAIL': '/var/mail/cltbld', 08:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:38 INFO - 'MOZ_NO_REMOTE': '1', 08:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:38 INFO - 'NO_EM_RESTART': '1', 08:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:38 INFO - 'PWD': '/builds/slave/test', 08:36:38 INFO - 'SHELL': '/bin/bash', 08:36:38 INFO - 'SHLVL': '1', 08:36:38 INFO - 'TERM': 'linux', 08:36:38 INFO - 'TMOUT': '86400', 08:36:38 INFO - 'USER': 'cltbld', 08:36:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 08:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:38 INFO - '_': '/tools/buildbot/bin/python'} 08:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:38 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)) 08:36:38 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)) 08:36:38 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)) 08:36:38 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)) 08:36:38 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)) 08:36:38 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)) 08:36:38 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)) 08:36:38 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)) 08:36:38 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)) 08:36:38 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)) 08:36:38 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)) 08:36:38 INFO - Cleaning up... 08:36:38 INFO - Return code: 0 08:36:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2bf7e36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2041ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203ef60>, '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 0x203fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20401d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:36:38 INFO - Using env: {'DISPLAY': ':0', 08:36:38 INFO - 'HOME': '/home/cltbld', 08:36:38 INFO - 'LANG': 'en_US.UTF-8', 08:36:38 INFO - 'LANGUAGE': 'en_US:en', 08:36:38 INFO - 'LOGNAME': 'cltbld', 08:36:38 INFO - 'MAIL': '/var/mail/cltbld', 08:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:38 INFO - 'MOZ_NO_REMOTE': '1', 08:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:38 INFO - 'NO_EM_RESTART': '1', 08:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:38 INFO - 'PWD': '/builds/slave/test', 08:36:38 INFO - 'SHELL': '/bin/bash', 08:36:38 INFO - 'SHLVL': '1', 08:36:38 INFO - 'TERM': 'linux', 08:36:38 INFO - 'TMOUT': '86400', 08:36:38 INFO - 'USER': 'cltbld', 08:36:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 08:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:38 INFO - '_': '/tools/buildbot/bin/python'} 08:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:36:38 INFO - Cleaning up... 08:36:38 INFO - Return code: 0 08:36:38 INFO - Running post-action listener: _resource_record_post_action 08:36:38 INFO - Running post-action listener: _start_resource_monitoring 08:36:38 INFO - Starting resource monitoring. 08:36:38 INFO - [mozharness: 2016-12-31 16:36:38.523207Z] Finished create-virtualenv step (success) 08:36:38 INFO - [mozharness: 2016-12-31 16:36:38.523661Z] Running install step. 08:36:38 INFO - Running pre-action listener: _resource_record_pre_action 08:36:38 INFO - Running main action method: install 08:36:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:38 INFO - Reading from file tmpfile_stdout 08:36:38 INFO - Detecting whether we're running mozinstall >=1.0... 08:36:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:36:38 INFO - Reading from file tmpfile_stdout 08:36:38 INFO - Output received: 08:36:38 INFO - Usage: mozinstall [options] installer 08:36:38 INFO - Options: 08:36:38 INFO - -h, --help show this help message and exit 08:36:38 INFO - -d DEST, --destination=DEST 08:36:38 INFO - Directory to install application into. [default: 08:36:38 INFO - "/builds/slave/test"] 08:36:38 INFO - --app=APP Application being installed. [default: firefox] 08:36:38 INFO - mkdir: /builds/slave/test/build/application 08:36:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:36:54 INFO - Reading from file tmpfile_stdout 08:36:54 INFO - Output received: 08:36:54 INFO - /builds/slave/test/build/application/firefox/firefox 08:36:54 INFO - Running post-action listener: _resource_record_post_action 08:36:54 INFO - [mozharness: 2016-12-31 16:36:54.747471Z] Finished install step (success) 08:36:54 INFO - [mozharness: 2016-12-31 16:36:54.747712Z] Running run-tests step. 08:36:54 INFO - Running pre-action listener: _resource_record_pre_action 08:36:54 INFO - Running main action method: run_tests 08:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:36:54 INFO - Python 2.7.3 08:36:54 INFO - Return code: 0 08:36:54 INFO - grabbing minidump binary from tooltool 08:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:54 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 0x203ef60>, '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 0x203fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20401d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:36:54 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 08:36:54 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 08:36:54 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 08:36:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:36:54 INFO - Return code: 0 08:36:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:36:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:36:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:36:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:36:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 08:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 08:36:54 INFO - Using env: {'DISPLAY': ':0', 08:36:54 INFO - 'HOME': '/home/cltbld', 08:36:54 INFO - 'LANG': 'en_US.UTF-8', 08:36:54 INFO - 'LANGUAGE': 'en_US:en', 08:36:54 INFO - 'LOGNAME': 'cltbld', 08:36:54 INFO - 'MAIL': '/var/mail/cltbld', 08:36:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:36:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:54 INFO - 'MOZ_NO_REMOTE': '1', 08:36:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:54 INFO - 'NO_EM_RESTART': '1', 08:36:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:54 INFO - 'PWD': '/builds/slave/test', 08:36:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:36:54 INFO - 'SHELL': '/bin/bash', 08:36:54 INFO - 'SHLVL': '1', 08:36:54 INFO - 'TERM': 'linux', 08:36:54 INFO - 'TMOUT': '86400', 08:36:54 INFO - 'USER': 'cltbld', 08:36:54 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253', 08:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:54 INFO - '_': '/tools/buildbot/bin/python'} 08:36:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 08:36:55 INFO - mozversion application_buildid: 20161231070020 08:36:55 INFO - mozversion application_changeset: 623f7b10ae96b129068d1ceb85d0e83ef5b19502 08:36:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:36:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:36:55 INFO - mozversion application_name: Firefox 08:36:55 INFO - mozversion application_remotingname: firefox-dev 08:36:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:36:55 INFO - mozversion application_vendor: Mozilla 08:36:55 INFO - mozversion application_version: 52.0a2 08:36:55 INFO - mozversion platform_buildid: 20161231070020 08:36:55 INFO - mozversion platform_changeset: 623f7b10ae96b129068d1ceb85d0e83ef5b19502 08:36:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:36:55 INFO - mozversion platform_version: 52.0a2 08:36:55 INFO - using testdate: 1483202215 08:36:55 INFO - actual date: 1483202215 08:36:55 INFO - starting webserver on 'localhost:40729' 08:36:55 INFO - SUITE-START | Running 2 tests 08:36:55 INFO - TEST-START | dromaeo_css 08:36:55 INFO - operating with platform_type : linux_ 08:36:55 INFO - Initialising browser for dromaeo_css test... 08:36:55 INFO - TEST-INFO | started process 7310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoPxPUF/profile http://localhost:40729/getInfo.html) 08:36:59 INFO - PROCESS | 7310 | __metrics Screen width/height:1600/1200 08:36:59 INFO - PROCESS | 7310 | colorDepth:24 08:36:59 INFO - PROCESS | 7310 | Browser inner width/height: 1024/697 08:36:59 INFO - PROCESS | 7310 | __metrics 08:36:59 INFO - PROCESS | 7310 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:36:59 INFO - PROCESS | 7310 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:37:00 INFO - PROCESS | 7310 | console.error: PushService: 08:37:00 INFO - PROCESS | 7310 | stateChangeProcessEnqueue: Error transitioning state 08:37:00 INFO - PROCESS | 7310 | UnknownError 08:37:00 INFO - TEST-INFO | 7310: exit 0 08:37:00 INFO - Browser initialized. 08:37:00 INFO - Running cycle 1/1 for dromaeo_css test... 08:37:00 INFO - TEST-INFO | started process 7401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoPxPUF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:37:12 INFO - PROCESS | 7401 | RSS: Main: 144814080 08:37:12 INFO - PROCESS | 7401 | 08:38:03 INFO - PROCESS | 7401 | 1483202283841 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] 08:40:14 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:40729/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40729/tests/dromaeo/cssquery-ext.html) 08:40:15 INFO - PROCESS | 7401 | RSS: Main: 232206336 08:40:15 INFO - PROCESS | 7401 | 08:43:17 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:40729/tests/dromaeo/cssquery-ext.html (next: http://localhost:40729/tests/dromaeo/cssquery-jquery.html) 08:43:18 INFO - PROCESS | 7401 | RSS: Main: 231084032 08:43:18 INFO - PROCESS | 7401 | 08:46:20 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:40729/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40729/tests/dromaeo/cssquery-mootools.html) 08:46:21 INFO - PROCESS | 7401 | RSS: Main: 217206784 08:46:21 INFO - PROCESS | 7401 | 08:49:23 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:40729/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40729/tests/dromaeo/cssquery-prototype.html) 08:49:23 INFO - PROCESS | 7401 | RSS: Main: 175583232 08:49:23 INFO - PROCESS | 7401 | 08:52:26 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:40729/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40729/tests/dromaeo/cssquery-yui.html) 08:52:26 INFO - PROCESS | 7401 | RSS: Main: 177864704 08:52:26 INFO - PROCESS | 7401 | 08:55:29 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:40729/tests/dromaeo/cssquery-yui.html (next: http://localhost:40729/tests/dromaeo/cssquery-dojo.html) 08:55:29 INFO - PROCESS | 7401 | RSS: Main: 260800512 08:55:29 INFO - PROCESS | 7401 | 08:55:29 INFO - PROCESS | 7401 | __start_tp_report 08:55:29 INFO - PROCESS | 7401 | _x_x_mozilla_page_load 08:55:29 INFO - PROCESS | 7401 | _x_x_mozilla_page_load_details 08:55:29 INFO - PROCESS | 7401 | |i|pagename|runs| 08:55:29 INFO - PROCESS | 7401 | |0;dojo.html;3200.9359812803746;3225.725813305869;3229.176559977206;3249.642539320676;3251.837408129593;5489.149181876805;5558.805441809537;5563.304586926634;5576.609637325389;5588.30146231721;5589.133684278933;5616.213730077792;5621.297337832761;5622.156676498527;5630.014747419195;5044.974775126128;5068.391792984847;5096.541311281984;5135.743212839362;5164.586833053347;4875.098106850226;4878.438979517347;5035.924461133086;5130.025295193901;5177.585793136559;5061.898762024757;5115.335006449156;5131.7434128293435;5154.123798954187;5170.224466330043;5153.665011774241;5153.943441594502;5155.896882062357;5158.3552055993005;5186.896262074775;4821.590164835993;4836.347093142451;5045.889904221065;5070.518300761421;5127.692338459704;5365.812196573102;5399.136138217867;5427.538659213971;5454.072807622674;5536.446355364472;5825.475707186331;5865;5912.142739302777;5920.023196172627;5921.73352199152;5940.940590594082;5965.463108320272;5969.701514924236;5973.313068997078;5980.581359304851;5485.835424937219;5487.725613719338;5528.530074943675;5533.03171944908;5539.806106786243;6049.062395328731;6064.181335519736;6077.574569780161;6085.5435842312;6091.14723938649;5828.737706803204;5834.124881267844;5845.269341332333;5847.6199047062655;5851.356350801409;5755.59710820247;5801.100829371454;5893.469587737124;5910.231669882888;5943.10853371989;5979.611325263844;6011.549133814981;6014.669193194416;6022.337542870281;6051.757929682852;6059.697015149225;6061.696915154224;6062.605930614496;6066.817995460143;6078.088286757022;4466.6203372713035;4498.077894031716;4554.63562914966;4657.69724967876;4665.533446655308;4113.218488487178;4131.834726610902;4142.109446469024;4176.686748493875;4179.958200418017;5742.167385729046;5757.798477053367;5761.711914404347;5764.625299355613;5777.075667893117;5739.71301434935;5821.563382746226;6063.151158837766;6079.574429789872;6082.1789058477425;5544.417836127229;5646.153077038395;5669.40471250521;5699.629524080921;5764.193012978187;5164.586833053347;5167.844964651066;5176.016556854186;5180.740962951837;5185.9887321971855;6229.159063526366;6268.686565671698;6281.309056003927;6282.465990390777;6287.993920972714;5821.417858214145;5880.117982302689;5893.823185304448;5928.110783382527;6049.848753781191;6187.133801267736;6199.132121502903;6201.10084037821;6202.627842329474;6209.875802483834;5793.3337666167245;5864.149698293809;5866.9732796759545;5867.706614669335;5874.295084589877;5803.3616302207565;5860.619059761102;5928.8814223716145;6001.0398336267735;6008.128821320972;5850.765969361178;5916.852078698067;5922.170896074639;5923.08192230205;5928.199693041384;5862.912056319244;5881.5588830837005;5892.381299963442;5901.970490147522;5905.5570832186895;5452.427495112956;5453.918191227055;5817.738201780845;5832.358440571449;5833.591648584558;5792.82621521355;5846.123081537803;5848.4151584841175;5910.024845900378;5930.733117009659;5690.800821971211;5726.398728133652;5736.5410767139365;5739.598228124159;5740.397258287987 08:55:29 INFO - PROCESS | 7401 | |1;ext.html;588.3586890289583;617.8084793713949;642.6626021338797;664.936831001055;677.5934439336396;33678;44063.11873762527;45383.09233815322;45392.3191152133;45409.31886021712;45880.54119458804;46239.76880115603;46253.7687311563;46262.53737462624;46344;8398.286145677625;8823.558822058887;8973.820523589524;8975.506347150904;8980.371374003822;8340.29107525861;10423;10665.040146386824;10667.626633067845;10974.396408197546;10861.511231994578;10882.23824332297;10896.073833724144;10918.563257469732;10923.508442120085;10465.895341046567;10525.684229473129;10533.473326333691;10549.20880933933;10571;10538.051575358255;10626.096781773558;10629.84055239172;10631.149508039338;10632.149428045737;44169.33745993813;44489.77755111236;44508;44581;44633.107337853064;3748.7750734955716;3852.325842977468;4408.889777755549;4418.64650827933;4485.730856148642;33395.16512087193;33787.83106084479;33789.662103379145;34112.82943585291;34430.13924651879;4357.324614684729;4403.383526306319;4432.22436073689;4455.198064348416;4521.706089104197;356096;357198;358578.4142158571;361007;364744;38529.61470385316;63305.366946329945;63581;63647.68176159182;63686.68156659187;38879.61120388816;40835.7958210213;41092.58907410948;41114.1777164461;41141.79429102835;16692.833071669127;16816;16859.409920652717;16860.325586976385;16865.494035178963;12428.943539799218;12575.93712031434;12736.936315318364;13866;13963.441462341596;9156.45061296311;9381.812363752822;9385.765355866022;9435.433873967446;9489.952550237205;3413.232022794901;3452.896413107611;3473.3574288756663;3496.8426420811124;3508.1231541125376;1041.8176819056634;1068.962586309491;1074.387599068539;1075.8224892892742;1157.085902137319;32566.34867302641;33931.32137357239;34097.488537671954;34686.826565867006;34951;1135.5798354608849;1167.7139100920328;1179.9646010619695;1263.008538297432;1269.5556555205603;17949.73075403844;18088;18103.909480452512;18151.09244537768;18176.36382726598;576821;581301;581724;581755;582151;63531.36468635254;63609;64046;64142.67928660327;64224.67887660532;1328.34247047712;1373.1829561410943;1386.5840247925785;1439.8128243328301;1453.4258967707697;33161.17097072496;35624.287514250085;35681;35992.820035899655;36024;54678;55116;55227.44772552223;55342;55424.44575554193;406418;407276;410903;531981;542504;45810;45985.77007114943;46421;46574.76712616415;47116.057678845544;50345.496545035545;50674.239886400996;50750.49249507458;50877.49122508727;51091.48908511016;44100;44624;45192.77403612961;45273.32090018586;45939.310910335706;43445;43571.56428435675;43626;44695;45329;43763.12473750571;44612.10775784401;45462.772686136355;45513.77243113763;45719.314210287535;37842;39680.2063958725;39957.80021099992;40164.3975340376;40567.59432405638;29717.702822971492;29862.10413687593;30126.54810177805;30130.3428311445;30442.238944026576 08:55:29 INFO - PROCESS | 7401 | |2;jquery.html;378.03816008233724;427.72639120439;434.6566212691973;434.7000569606971;439.25984715753935;15766.448174313888;19267.229310827566;20623.38129856103;20875.37373878782;21028;19474.610507789836;20084.698729519034;20118;20233.988300584984;20430.69353959688;5620.437956204367;5842.591018628697;5843.444872737083;5847.064469684851;5848.444397782225;5440.4287549807095;5718.571107166958;5728.026235539968;5734.967705812952;5735.627184233012;5617.550595952314;5711.114777209539;5714.25714657094;5716.028275193206;5719.456651618089;5588.944110558903;5706.1726049722765;5709.65742055478;5719.628224165416;5719.942800571983;5112.309838171874;5151.896962060775;5156.690598564098;5166.43169251382;5167.121589329823;23579.76420235793;23705.76294237053;23797.643035354482;24136.75863241363;24288.757112428826;2387.6537902004284;2658.5347564176386;3027.5610036544576;3027.6215473065868;3030.2878823476467;11004.284721493157;11440.542378304857;11566.53733850645;15263.923680381638;15630.374785008586;1865.4496923407628;1974.3780709076739;2020.5150763816725;2026.5136367271896;2055.7533096028574;86846.56576717076;89125.10874891233;90396.54801726015;90806;91096.54451727765;10333.74487036581;11508.712282193012;11691.532338706527;11780.175387722777;12144.878551214551;15055.473058443122;15102.697946041018;15958.521244362688;16001.359945602046;16664.16679166037;8524.829503409897;8742.30061595071;8822.25010874083;8927.642894284156;8931.240844528158;8251.8349633007;8332.16678332162;8340.874886876702;8423.915760842436;8517.148285171557;4996.600271978233;5036.84889453317;5057.974710126426;5152.536271735562;5182.766775495112;2082.292020712965;2085.0488324624753;2112.9366119016454;2114.7462304523556;2118.957620847605;989.4557993103764;990.64336838738;1069.8662667166604;1080.4921686807188;1136.363636363639;19440;19854.801451985295;20066.297679581436;20247.392578222676;20370.981450927393;993.4883534979491;1037.2894567221476;1041.5625437316346;1049.1554298789395;1103.7240689827543;10380.740481487872;10907.181961352771;11107.166962477846;11193.384363859903;11220.775584488265;475221;475809;484990;514632;518112;60572.697136514034;87983.24033519294;89837;103064.48467757613;104116;1063.4576366053368;1067.5356220044305;1084.2301965604352;1107.6067995861515;1108.700650824273;17393.56516087108;17666.470005899842;18080.63838723192;18098.095095245448;18213.854309131533;42632.78683606562;42824.143517130105;44072.338914916945;44329.55670443383;44409.33385999148;61902.69048654728;62182.68908655428;62578;63131.684341577995;63669.68165159145;8618.61216245283;8651.6106775194;8727.389082764146;8905.866412003954;8920;7592.924070759222;11667.416629168678;13066.673333166367;13155.671108221988;13203.207807531579;10748.570057197625;10990.285631433931;11513;11962.76074478523;11993.64019079429;11570.363630000431;11705.765884682429;11778.111720390663;11840.822387664364;11970.461329240032;11975.101867360157;11980.460879260629;12194.634160975185;12516.31160286193;12594.370281486072;8597.26923211534;8817.515036673045;8850.20348168668;8913.688020919237;8950.910490895008;10425.426601536989;11552.364619945984;11804.527818887493;12157.574484892986;12266.32535210572 08:55:29 INFO - PROCESS | 7401 | |3;mootools.html;1363.8499765025852;1534.992325038375;1537.0316700478697;1724.9913750431247;1838.9816101838985;7955.602219889004;8616.267617252533;8925.509096999662;8940.418872773265;9134.588943497542;8896.466212027282;8991.145841145097;8993.235574976135;8999.550022498865;9013.729588112366;2486.328691253365;2515.308290220195;2520.0045981837166;2520.294317591068;2521.1428114441087;2308.68832707584;2308.8730119843403;2310.7804758547995;2314.872682002489;2373.9406514837183;2443.926682199537;2449.7060352757694;2470.4318006858434;2474.814388920838;2474.826762126652;2381.785639292472;2406.470576473173;2430.343807172071;2439.0365805506813;2440.4386990992084;2388.940276493084;2408.4701365699516;2419.879006049708;2421.6125419932728;2426.1265944260053;8904;8954.41796283246;9009.594568244445;9025.368224224307;9046.502442365667;5715.542756579505;5862.677552734598;5864.941350586482;5906.9704651476895;5915.852103697399;3554.6445355464507;3682.1346983458866;3723.9627603724157;3734.906627334311;3751.3435148848844;1198.8801119888028;1205.2226314027491;1213.2174747288038;1231.9753604927942;1239.6157191270736;12835.807462888064;12915.483380664762;12932.741345173137;13032.80450793239;13042.021848361315;4718.504557021463;4888.437829649564;4892.902141957141;4931.309616653672;4986.401631804207;10179.287449878437;10183.33808302458;10192;10222.182225421948;10223.591056357662;5668.149777533321;5668.829935101953;5681.460261275255;5681.914771278434;5688.203651488795;4527.932081018787;4708.176069187947;4799.0641824844515;5165.302684137669;5306.416294207634;4114.799958555938;4125.257453658311;4192.559781222989;4206.9482629342665;4248.065425606424;1286.9549565765153;1288.2528133682442;1307.5031488034485;1312.9080964332595;1313.7832257677567;954.8090381923643;996.9102780749768;1012.4431562640518;1017.3234798858824;1017.8524114003428;5861.648301101947;6133.26400831903;6136.846578835475;6317;6321.37662869913;485.8591008607464;495.0198606758638;499.0493110624194;502.4648749082216;987.6247026130025;3933.977165936877;4079.3676980068135;4093.959060409358;4124.505059392832;4261.74429534229;10920.890791092146;11040.33757974524;11048.558057677763;11110;11146.665600032013;10909.34543927367;11073.944630276797;11082.22424430282;11082.612108576322;11286.774264514665;8360.498370097814;8544.871826922601;8548.957255213809;8552.315814734806;8554.486730796172;5638.774449022158;5709.942900571107;5769.9711501442225;5772.567057470623;5911.054231322968;10096.848547271944;10168.644097456554;10177.643782467578;10213.029762172582;10245.129164021142;9411.717648470556;9696.369735967139;10035.648752293635;10104.69685909424;10395.740106497398;8040.356771458386;8208.507489550646;8239.052508961546;8342.249197572248;8361;8746.38775285724;8746.606402712021;8768.167024132697;8781.165789250012;8850.291976641982;7922.881156782538;7965.920340796518;7985.64064617082;7998.280154786097;8057.959710201411;7864;7879.448438609472;7888.290053895177;7900.960495197487;8084.312833409226;7325.120985481776;7368.336849683555;7378.557286562824;7411.036565246483;7412.147603025721;5427.457254274541;5444;5473.890522189454;5534.584906131976;5667.4615911488345;5389.2455056291365;5404.621676482609;5451.890962180655;5530.336359636869;5532.91700624499 08:55:29 INFO - PROCESS | 7401 | |4;prototype.html;350.29415727309475;350.77725644215946;354.7215435882832;357.3514071959394;364.64447164015087;5315.654482458643;5360.169173778061;5368.328958880135;5385.142125966545;5386.973065134679;5254.4220135785035;5278.208268759688;5279.017355194322;5316.362036555609;5327.440618735025;3742.9625703743022;4010.598940105995;4118.752874827505;4132.834686612532;4185.363221170658;4184.456020717303;4205.962276214822;4212.178625168093;4214.810333534998;4215.473065866767;4185.74885506869;4194.370844373353;4206.915861682764;4207.558206388331;4219.324908014718;3926.666233370167;4027.1945610877647;4209.1581683663235;4214.8198504418815;4226.830926762926;3748.5501739791125;3763.322601931651;3782.527184101987;3784.9053773655605;3785.280796648628;5152.330197074356;5182.404023537304;5213.905079933219;5235.057689615867;5243.2659427680155;4723.740194289313;4739.312799644033;4792.904141917142;4865.19724245499;4873.415190177201;5466.098093814516;5491.313585801775;5527.143292789584;5533.833984980417;5554.361248456398;4105.58944105587;4119.237940980928;4129.566395528486;4131.566185550534;4134.152498737752;5633.197591625677;5697.31632204134;5707.260514952846;5860;5881.382454842265;4222.113356195172;4232.915341693149;4234.0050088229245;4240.809163587646;4242.639375653104;4287.699861009762;4296.324433470949;4296.839853239608;4323.178596066738;4326.372675962031;4626.236670949255;4834.081524510332;4850.054239423349;4868.294097355863;4873.317735516959;5471.562275017989;5525.11598144295;5542.667439953616;5545.61180717354;5568.7215639217875;1426.6090561702465;1445.6024593236943;1448.6957738874744;1448.7034104476434;1469.6178993461563;988.6539711101201;1013.7364285285731;1018.3940555369543;1033.0857191385678;1051.321897376188;5171.612129090333;5200.60995425337;5208.479152084837;5208.661437006658;5267.657602255841;5454.672719636835;5469.9179512306555;5470.671759694431;5508.338999320107;5523.005858945348;4968.677035992721;5156.8968620627375;5229.869253268699;5235.973820130875;5260.500252476008;2892.52273374895;2902.535594304901;2902.6081479000486;2912.7815413844046;2918;5678.290213723285;5681.431856814368;5689.374168841424;5698.17376480408;5716.28546431696;5326.227696983916;5488.69812160327;5554.528050066736;5556.833295001156;5582.413846546055;5792.623479473821;5794.681292528951;5892.616979896293;5917.852053698606;5921.319048309328;5705.201271822031;5713.400092990176;5715.9142612860005;5719.2279042328755;5736.225609542826;5517.048379117153;5642.407547207648;5648.971755141198;5678.138865571451;5689.431056894277;5905.940940590539;5911.467967882912;5911.911321330097;5918.260217472816;5922.407759224216;4178.310578754472;4188.85339013133;4196.559361267023;4201.558836322142;4215.178040282116;5550.195221692913;5653.519450846559;5673.914891276717;5681.4034526374135;5683.2895888014;5538.701438902971;5558.972205138948;5583.664980101207;5593.888122237451;5610.13042978339;5351.785928562969;5526.668399896019;5563.415841336601;5578.553715702653;5589;5466.289382380265;5495.2856128703015;5515.669059856261;5522.22688823573;5525.309336332958;5600.439956004367;5604.719764011865;5617.213590097308;5629.155626656035;5638.407967163553;5264.420913699413;5431.321084864392;5431.456854314695;5434.157705555645;5488.231647569263 08:55:29 INFO - PROCESS | 7401 | |5;yui.html;798.7923139983607;816.4856140631405;860.4880096342675;866.8829707989421;890.7016149589887;14791.334389952452;16170.353185872566;16194.35222591098;16213.837861621396;16224.594385140377;13279.468821247163;13382.197068175916;13388.062835601488;13390.397432115555;13403.195808251487;716.8888822232549;734.2070563791119;830.7217082277444;854.3421565394642;855.8887344645218;854.7521218846528;856.755824589992;856.9785755356104;857.0786404615033;857.7169534053747;913.2237598041678;914.1041779056495;914.995425022874;915.5971372596069;915.844306467902;753.4161025205455;765.4488768086941;766.0615745711515;773.0761739721036;903.5391950105428;650.3139188156493;661.7716887673745;665.2715276771927;669.0232260899094;669.4911866981081;15084.472043478425;15345.693086138326;15378.692426151414;15381.230938453033;15406.3837446502;13334.799978000337;13372.598822035354;13385.26381049042;13558.661033474144;14241.857581424158;13307.401166947511;13324.333783310796;13420.597382078553;13548.390322435514;13591.320433978262;4468.843590474317;4471.642268618502;4516.345129956171;4583.610393116589;4586.518415566351;62653.37346626521;63814.36185638131;65011.349886501004;65898.34101659017;65928;11266.267692599955;11572.022023016822;11580.247283926517;11827.763444731057;11881.40592970348;17989.820101799076;18897.716534252;20198;20211.696824547642;20284.290049848183;8496.745097647081;8528.360372971927;8688.95655521731;8966.68616598416;9111.772205694779;4734.644901632391;4838.709677419366;4910.975445122823;4920.8769780755765;4947.356843610308;3532.2229109595846;3652.0139562318554;3658.9451158232646;3659.341318562631;3659.4876717259604;641.3330136657823;648.251269783401;651.4788169464505;654.3129713800586;667.9064930909676;684.9760258391032;696.2376198063113;702.3187508117118;719.9028131202325;721.6355740351194;9632.518374081268;9679.225661947028;9900;9901.60393584263;9912.851307230398;717.4905816869976;766.5630590563326;798.1220657277065;800.4116974024088;811.2495941254316;4743.905121897543;5043.470435604282;5101.285819985205;5110.054639891558;5115.616328775282;82552;89536;90159;91322.63016054765;91749;80481.59759201166;82188;82890;83079;84231.15768842355;59642.10536841951;63775.6811215941;71947.64026179835;72643.63678181576;72813;10216.59133634676;10723.839142412715;10934.507947142238;10971.780564388508;11035.889641103486;43431.782841085595;43446.34830477609;43537.34693979656;44431;44444.55555444404;54820;55259;59531.404685952584;61767;63763.6811815938;12515.56195533152;12541.623751287476;12714.87285127137;12906;13492;14489.492867749577;14517.274136292932;14664.193469359288;14706.264686765406;14789.630259243606;12071;13295.20228786276;13374.665633359244;14190.645233869236;14465.059771114844;14077.084989475652;14093.577192684235;14291.499797507038;14550.199739014455;14730.337134829173;13132.868671313165;13311.933440332736;13442.865571344162;14308.213048282028;14438.639034024234;11021.228514003942;11460.770784584429;11615.303081815118;11830.112741544246;11870.881291187323;11280.492377842853;11420.428978551205;11813.173077884465;11884.108691847972;11953.521859125885 08:55:29 INFO - PROCESS | 7401 | __end_tp_report 08:55:29 INFO - PROCESS | 7401 | __start_cc_report 08:55:29 INFO - PROCESS | 7401 | _x_x_mozilla_cycle_collect,1306 08:55:29 INFO - PROCESS | 7401 | __end_cc_report 08:55:29 INFO - PROCESS | 7401 | __startTimestamp1483203329635__endTimestamp 08:55:29 INFO - PROCESS | 7401 | 08:55:29 INFO - PROCESS | 7401 | ------- Summary: start ------- 08:55:29 INFO - PROCESS | 7401 | Number of tests: 6 08:55:29 INFO - PROCESS | 7401 | 08:55:29 INFO - PROCESS | 7401 | [#0] dojo.html Cycles:165 Average:5544.16 Median:5764.63 stddev:626.49 (10.9%) stddev-sans-first:600.84 08:55:29 INFO - PROCESS | 7401 | Values: 3200.9 3225.7 3229.2 3249.6 3251.8 5489.1 5558.8 5563.3 5576.6 5588.3 5589.1 5616.2 5621.3 5622.2 5630.0 5045.0 5068.4 5096.5 5135.7 5164.6 4875.1 4878.4 5035.9 5130.0 5177.6 5061.9 5115.3 5131.7 5154.1 5170.2 5153.7 5153.9 5155.9 5158.4 5186.9 4821.6 4836.3 5045.9 5070.5 5127.7 5365.8 5399.1 5427.5 5454.1 5536.4 5825.5 5865.0 5912.1 5920.0 5921.7 5940.9 5965.5 5969.7 5973.3 5980.6 5485.8 5487.7 5528.5 5533.0 5539.8 6049.1 6064.2 6077.6 6085.5 6091.1 5828.7 5834.1 5845.3 5847.6 5851.4 5755.6 5801.1 5893.5 5910.2 5943.1 5979.6 6011.5 6014.7 6022.3 6051.8 6059.7 6061.7 6062.6 6066.8 6078.1 4466.6 4498.1 4554.6 4657.7 4665.5 4113.2 4131.8 4142.1 4176.7 4180.0 5742.2 5757.8 5761.7 5764.6 5777.1 5739.7 5821.6 6063.2 6079.6 6082.2 5544.4 5646.2 5669.4 5699.6 5764.2 5164.6 5167.8 5176.0 5180.7 5186.0 6229.2 6268.7 6281.3 6282.5 6288.0 5821.4 5880.1 5893.8 5928.1 6049.8 6187.1 6199.1 6201.1 6202.6 6209.9 5793.3 5864.1 5867.0 5867.7 5874.3 5803.4 5860.6 5928.9 6001.0 6008.1 5850.8 5916.9 5922.2 5923.1 5928.2 5862.9 5881.6 5892.4 5902.0 5905.6 5452.4 5453.9 5817.7 5832.4 5833.6 5792.8 5846.1 5848.4 5910.0 5930.7 5690.8 5726.4 5736.5 5739.6 5740.4 08:55:29 INFO - PROCESS | 7401 | 08:55:29 INFO - PROCESS | 7401 | [#1] ext.html Cycles:180 Average:63358.68 Median:224055.90 stddev:126617.96 (56.5%) stddev-sans-first:126885.45 08:55:29 INFO - PROCESS | 7401 | Values: 588.4 617.8 642.7 664.9 677.6 33678.0 44063.1 45383.1 45392.3 45409.3 45880.5 46239.8 46253.8 46262.5 46344.0 8398.3 8823.6 8973.8 8975.5 8980.4 8340.3 10423.0 10665.0 10667.6 10974.4 10861.5 10882.2 10896.1 10918.6 10923.5 10465.9 10525.7 10533.5 10549.2 10571.0 10538.1 10626.1 10629.8 10631.1 10632.1 44169.3 44489.8 44508.0 44581.0 44633.1 3748.8 3852.3 4408.9 4418.6 4485.7 33395.2 33787.8 33789.7 34112.8 34430.1 4357.3 4403.4 4432.2 4455.2 4521.7 356096.0 357198.0 358578.4 361007.0 364744.0 38529.6 63305.4 63581.0 63647.7 63686.7 38879.6 40835.8 41092.6 41114.2 41141.8 16692.8 16816.0 16859.4 16860.3 16865.5 12428.9 12575.9 12736.9 13866.0 13963.4 9156.5 9381.8 9385.8 9435.4 9490.0 3413.2 3452.9 3473.4 3496.8 3508.1 1041.8 1069.0 1074.4 1075.8 1157.1 32566.3 33931.3 34097.5 34686.8 34951.0 1135.6 1167.7 1180.0 1263.0 1269.6 17949.7 18088.0 18103.9 18151.1 18176.4 576821.0 581301.0 581724.0 581755.0 582151.0 63531.4 63609.0 64046.0 64142.7 64224.7 1328.3 1373.2 1386.6 1439.8 1453.4 33161.2 35624.3 35681.0 35992.8 36024.0 54678.0 55116.0 55227.4 55342.0 55424.4 406418.0 407276.0 410903.0 531981.0 542504.0 45810.0 45985.8 46421.0 46574.8 47116.1 50345.5 50674.2 50750.5 50877.5 51091.5 44100.0 44624.0 45192.8 45273.3 45939.3 43445.0 43571.6 43626.0 44695.0 45329.0 43763.1 44612.1 45462.8 45513.8 45719.3 37842.0 39680.2 39957.8 40164.4 40567.6 29717.7 29862.1 30126.5 30130.3 30442.2 08:55:29 INFO - PROCESS | 7401 | 08:55:29 INFO - PROCESS | 7401 | [#2] jquery.html Cycles:180 Average:29684.58 Median:13092.65 stddev:81611.94 (623.3%) stddev-sans-first:81811.22 08:55:29 INFO - PROCESS | 7401 | Values: 378.0 427.7 434.7 434.7 439.3 15766.4 19267.2 20623.4 20875.4 21028.0 19474.6 20084.7 20118.0 20234.0 20430.7 5620.4 5842.6 5843.4 5847.1 5848.4 5440.4 5718.6 5728.0 5735.0 5735.6 5617.6 5711.1 5714.3 5716.0 5719.5 5588.9 5706.2 5709.7 5719.6 5719.9 5112.3 5151.9 5156.7 5166.4 5167.1 23579.8 23705.8 23797.6 24136.8 24288.8 2387.7 2658.5 3027.6 3027.6 3030.3 11004.3 11440.5 11566.5 15263.9 15630.4 1865.4 1974.4 2020.5 2026.5 2055.8 86846.6 89125.1 90396.5 90806.0 91096.5 10333.7 11508.7 11691.5 11780.2 12144.9 15055.5 15102.7 15958.5 16001.4 16664.2 8524.8 8742.3 8822.3 8927.6 8931.2 8251.8 8332.2 8340.9 8423.9 8517.1 4996.6 5036.8 5058.0 5152.5 5182.8 2082.3 2085.0 2112.9 2114.7 2119.0 989.5 990.6 1069.9 1080.5 1136.4 19440.0 19854.8 20066.3 20247.4 20371.0 993.5 1037.3 1041.6 1049.2 1103.7 10380.7 10907.2 11107.2 11193.4 11220.8 475221.0 475809.0 484990.0 514632.0 518112.0 60572.7 87983.2 89837.0 103064.5 104116.0 1063.5 1067.5 1084.2 1107.6 1108.7 17393.6 17666.5 18080.6 18098.1 18213.9 42632.8 42824.1 44072.3 44329.6 44409.3 61902.7 62182.7 62578.0 63131.7 63669.7 8618.6 8651.6 8727.4 8905.9 8920.0 7592.9 11667.4 13066.7 13155.7 13203.2 10748.6 10990.3 11513.0 11962.8 11993.6 11570.4 11705.8 11778.1 11840.8 11970.5 11975.1 11980.5 12194.6 12516.3 12594.4 8597.3 8817.5 8850.2 8913.7 8950.9 10425.4 11552.4 11804.5 12157.6 12266.3 08:55:29 INFO - PROCESS | 7401 | 08:55:29 INFO - PROCESS | 7401 | [#3] mootools.html Cycles:180 Average:5969.78 Median:2687.15 stddev:3352.93 (124.8%) stddev-sans-first:3344.47 08:55:29 INFO - PROCESS | 7401 | Values: 1363.8 1535.0 1537.0 1725.0 1839.0 7955.6 8616.3 8925.5 8940.4 9134.6 8896.5 8991.1 8993.2 8999.6 9013.7 2486.3 2515.3 2520.0 2520.3 2521.1 2308.7 2308.9 2310.8 2314.9 2373.9 2443.9 2449.7 2470.4 2474.8 2474.8 2381.8 2406.5 2430.3 2439.0 2440.4 2388.9 2408.5 2419.9 2421.6 2426.1 8904.0 8954.4 9009.6 9025.4 9046.5 5715.5 5862.7 5864.9 5907.0 5915.9 3554.6 3682.1 3724.0 3734.9 3751.3 1198.9 1205.2 1213.2 1232.0 1239.6 12835.8 12915.5 12932.7 13032.8 13042.0 4718.5 4888.4 4892.9 4931.3 4986.4 10179.3 10183.3 10192.0 10222.2 10223.6 5668.1 5668.8 5681.5 5681.9 5688.2 4527.9 4708.2 4799.1 5165.3 5306.4 4114.8 4125.3 4192.6 4206.9 4248.1 1287.0 1288.3 1307.5 1312.9 1313.8 954.8 996.9 1012.4 1017.3 1017.9 5861.6 6133.3 6136.8 6317.0 6321.4 485.9 495.0 499.0 502.5 987.6 3934.0 4079.4 4094.0 4124.5 4261.7 10920.9 11040.3 11048.6 11110.0 11146.7 10909.3 11073.9 11082.2 11082.6 11286.8 8360.5 8544.9 8549.0 8552.3 8554.5 5638.8 5709.9 5770.0 5772.6 5911.1 10096.8 10168.6 10177.6 10213.0 10245.1 9411.7 9696.4 10035.6 10104.7 10395.7 8040.4 8208.5 8239.1 8342.2 8361.0 8746.4 8746.6 8768.2 8781.2 8850.3 7922.9 7965.9 7985.6 7998.3 8058.0 7864.0 7879.4 7888.3 7901.0 8084.3 7325.1 7368.3 7378.6 7411.0 7412.1 5427.5 5444.0 5473.9 5534.6 5667.5 5389.2 5404.6 5451.9 5530.3 5532.9 08:55:29 INFO - PROCESS | 7401 | 08:55:29 INFO - PROCESS | 7401 | [#4] prototype.html Cycles:180 Average:4685.42 Median:5272.93 stddev:1344.70 (25.5%) stddev-sans-first:1308.51 08:55:29 INFO - PROCESS | 7401 | Values: 350.3 350.8 354.7 357.4 364.6 5315.7 5360.2 5368.3 5385.1 5387.0 5254.4 5278.2 5279.0 5316.4 5327.4 3743.0 4010.6 4118.8 4132.8 4185.4 4184.5 4206.0 4212.2 4214.8 4215.5 4185.7 4194.4 4206.9 4207.6 4219.3 3926.7 4027.2 4209.2 4214.8 4226.8 3748.6 3763.3 3782.5 3784.9 3785.3 5152.3 5182.4 5213.9 5235.1 5243.3 4723.7 4739.3 4792.9 4865.2 4873.4 5466.1 5491.3 5527.1 5533.8 5554.4 4105.6 4119.2 4129.6 4131.6 4134.2 5633.2 5697.3 5707.3 5860.0 5881.4 4222.1 4232.9 4234.0 4240.8 4242.6 4287.7 4296.3 4296.8 4323.2 4326.4 4626.2 4834.1 4850.1 4868.3 4873.3 5471.6 5525.1 5542.7 5545.6 5568.7 1426.6 1445.6 1448.7 1448.7 1469.6 988.7 1013.7 1018.4 1033.1 1051.3 5171.6 5200.6 5208.5 5208.7 5267.7 5454.7 5469.9 5470.7 5508.3 5523.0 4968.7 5156.9 5229.9 5236.0 5260.5 2892.5 2902.5 2902.6 2912.8 2918.0 5678.3 5681.4 5689.4 5698.2 5716.3 5326.2 5488.7 5554.5 5556.8 5582.4 5792.6 5794.7 5892.6 5917.9 5921.3 5705.2 5713.4 5715.9 5719.2 5736.2 5517.0 5642.4 5649.0 5678.1 5689.4 5905.9 5911.5 5911.9 5918.3 5922.4 4178.3 4188.9 4196.6 4201.6 4215.2 5550.2 5653.5 5673.9 5681.4 5683.3 5538.7 5559.0 5583.7 5593.9 5610.1 5351.8 5526.7 5563.4 5578.6 5589.0 5466.3 5495.3 5515.7 5522.2 5525.3 5600.4 5604.7 5617.2 5629.2 5638.4 5264.4 5431.3 5431.5 5434.2 5488.2 08:55:29 INFO - PROCESS | 7401 | 08:55:29 INFO - PROCESS | 7401 | [#5] yui.html Cycles:180 Average:18243.54 Median:4739.28 stddev:23761.79 (501.4%) stddev-sans-first:23792.34 08:55:29 INFO - PROCESS | 7401 | Values: 798.8 816.5 860.5 866.9 890.7 14791.3 16170.4 16194.4 16213.8 16224.6 13279.5 13382.2 13388.1 13390.4 13403.2 716.9 734.2 830.7 854.3 855.9 854.8 856.8 857.0 857.1 857.7 913.2 914.1 915.0 915.6 915.8 753.4 765.4 766.1 773.1 903.5 650.3 661.8 665.3 669.0 669.5 15084.5 15345.7 15378.7 15381.2 15406.4 13334.8 13372.6 13385.3 13558.7 14241.9 13307.4 13324.3 13420.6 13548.4 13591.3 4468.8 4471.6 4516.3 4583.6 4586.5 62653.4 63814.4 65011.3 65898.3 65928.0 11266.3 11572.0 11580.2 11827.8 11881.4 17989.8 18897.7 20198.0 20211.7 20284.3 8496.7 8528.4 8689.0 8966.7 9111.8 4734.6 4838.7 4911.0 4920.9 4947.4 3532.2 3652.0 3658.9 3659.3 3659.5 641.3 648.3 651.5 654.3 667.9 685.0 696.2 702.3 719.9 721.6 9632.5 9679.2 9900.0 9901.6 9912.9 717.5 766.6 798.1 800.4 811.2 4743.9 5043.5 5101.3 5110.1 5115.6 82552.0 89536.0 90159.0 91322.6 91749.0 80481.6 82188.0 82890.0 83079.0 84231.2 59642.1 63775.7 71947.6 72643.6 72813.0 10216.6 10723.8 10934.5 10971.8 11035.9 43431.8 43446.3 43537.3 44431.0 44444.6 54820.0 55259.0 59531.4 61767.0 63763.7 12515.6 12541.6 12714.9 12906.0 13492.0 14489.5 14517.3 14664.2 14706.3 14789.6 12071.0 13295.2 13374.7 14190.6 14465.1 14077.1 14093.6 14291.5 14550.2 14730.3 13132.9 13311.9 13442.9 14308.2 14438.6 11021.2 11460.8 11615.3 11830.1 11870.9 11280.5 11420.4 11813.2 11884.1 11953.5 08:55:29 INFO - PROCESS | 7401 | -------- Summary: end -------- 08:55:29 INFO - PROCESS | 7401 | 08:55:30 INFO - TEST-INFO | 7401: exit 0 08:55:30 INFO - TEST-OK | dromaeo_css | took 1115414ms 08:55:30 INFO - TEST-START | kraken 08:55:30 INFO - operating with platform_type : linux_ 08:55:30 INFO - Initialising browser for kraken test... 08:55:30 INFO - TEST-INFO | started process 7719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHVOnc4/profile http://localhost:40729/getInfo.html) 08:55:34 INFO - PROCESS | 7719 | __metrics Screen width/height:1600/1200 08:55:34 INFO - PROCESS | 7719 | colorDepth:24 08:55:34 INFO - PROCESS | 7719 | Browser inner width/height: 1024/697 08:55:34 INFO - PROCESS | 7719 | __metrics 08:55:35 INFO - PROCESS | 7719 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:55:35 INFO - PROCESS | 7719 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:55:35 INFO - PROCESS | 7719 | console.error: PushService: 08:55:35 INFO - PROCESS | 7719 | stateChangeProcessEnqueue: Error transitioning state 08:55:35 INFO - PROCESS | 7719 | UnknownError 08:55:36 INFO - TEST-INFO | 7719: exit 0 08:55:36 INFO - Browser initialized. 08:55:36 INFO - Running cycle 1/1 for kraken test... 08:55:36 INFO - TEST-INFO | started process 7815 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHVOnc4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:47 INFO - PROCESS | 7815 | RSS: Main: 147636224 08:55:47 INFO - PROCESS | 7815 | 08:55:50 INFO - PROCESS | 7815 | Cycle 1(1): loaded http://localhost:40729/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40729/tests/kraken/driver.html?testName=audio-beat-detection) 08:55:51 INFO - PROCESS | 7815 | RSS: Main: 189382656 08:55:51 INFO - PROCESS | 7815 | 08:55:53 INFO - PROCESS | 7815 | Cycle 1(1): loaded http://localhost:40729/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40729/tests/kraken/driver.html?testName=audio-dft) 08:55:54 INFO - PROCESS | 7815 | RSS: Main: 178274304 08:55:54 INFO - PROCESS | 7815 | 08:55:57 INFO - PROCESS | 7815 | Cycle 1(1): loaded http://localhost:40729/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40729/tests/kraken/driver.html?testName=audio-fft) 08:55:57 INFO - PROCESS | 7815 | RSS: Main: 270110720 08:55:57 INFO - PROCESS | 7815 | 08:55:59 INFO - PROCESS | 7815 | Cycle 1(1): loaded http://localhost:40729/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40729/tests/kraken/driver.html?testName=audio-oscillator) 08:56:00 INFO - PROCESS | 7815 | RSS: Main: 176586752 08:56:00 INFO - PROCESS | 7815 | 08:56:02 INFO - PROCESS | 7815 | Cycle 1(1): loaded http://localhost:40729/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40729/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:56:03 INFO - PROCESS | 7815 | RSS: Main: 178761728 08:56:03 INFO - PROCESS | 7815 | 08:56:06 INFO - PROCESS | 7815 | Cycle 1(1): loaded http://localhost:40729/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40729/tests/kraken/driver.html?testName=imaging-darkroom) 08:56:06 INFO - PROCESS | 7815 | RSS: Main: 218058752 08:56:06 INFO - PROCESS | 7815 | 08:56:10 INFO - PROCESS | 7815 | Cycle 1(1): loaded http://localhost:40729/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40729/tests/kraken/driver.html?testName=imaging-desaturate) 08:56:10 INFO - PROCESS | 7815 | RSS: Main: 216272896 08:56:10 INFO - PROCESS | 7815 | 08:56:13 INFO - PROCESS | 7815 | Cycle 1(1): loaded http://localhost:40729/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40729/tests/kraken/driver.html?testName=json-parse-financial) 08:56:13 INFO - PROCESS | 7815 | RSS: Main: 214773760 08:56:13 INFO - PROCESS | 7815 | 08:56:15 INFO - PROCESS | 7815 | Cycle 1(1): loaded http://localhost:40729/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40729/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:56:15 INFO - PROCESS | 7815 | RSS: Main: 177512448 08:56:15 INFO - PROCESS | 7815 | 08:56:17 INFO - PROCESS | 7815 | Cycle 1(1): loaded http://localhost:40729/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40729/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:56:18 INFO - PROCESS | 7815 | RSS: Main: 184107008 08:56:18 INFO - PROCESS | 7815 | 08:56:20 INFO - PROCESS | 7815 | Cycle 1(1): loaded http://localhost:40729/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40729/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:56:20 INFO - PROCESS | 7815 | RSS: Main: 189894656 08:56:20 INFO - PROCESS | 7815 | 08:56:23 INFO - PROCESS | 7815 | Cycle 1(1): loaded http://localhost:40729/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:56:24 INFO - PROCESS | 7815 | RSS: Main: 199364608 08:56:24 INFO - PROCESS | 7815 | 08:56:26 INFO - PROCESS | 7815 | Cycle 1(1): loaded http://localhost:40729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:56:27 INFO - PROCESS | 7815 | RSS: Main: 195231744 08:56:27 INFO - PROCESS | 7815 | 08:56:28 INFO - PROCESS | 7815 | Cycle 1(1): loaded http://localhost:40729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40729/tests/kraken/driver.html?testName=ai-astar) 08:56:29 INFO - PROCESS | 7815 | RSS: Main: 245669888 08:56:29 INFO - PROCESS | 7815 | 08:56:29 INFO - PROCESS | 7815 | __start_tp_report 08:56:29 INFO - PROCESS | 7815 | _x_x_mozilla_page_load 08:56:29 INFO - PROCESS | 7815 | _x_x_mozilla_page_load_details 08:56:29 INFO - PROCESS | 7815 | |i|pagename|runs| 08:56:29 INFO - PROCESS | 7815 | |0;ai-astar;102;112;111;111;113;109;113;111;110;111 08:56:29 INFO - PROCESS | 7815 | |1;audio-beat-detection;154;121;117;157;123;122;122;121;147;118 08:56:29 INFO - PROCESS | 7815 | |2;audio-dft;162;159;160;160;162;162;163;159;161;161 08:56:29 INFO - PROCESS | 7815 | |3;audio-fft;75;75;75;123;76;78;74;75;99;75 08:56:29 INFO - PROCESS | 7815 | |4;audio-oscillator;81;82;109;82;82;82;99;82;82;113 08:56:29 INFO - PROCESS | 7815 | |5;imaging-gaussian-blur;117;116;117;117;116;117;117;117;117;117 08:56:29 INFO - PROCESS | 7815 | |6;imaging-darkroom;146;147;146;146;145;145;146;147;146;146 08:56:29 INFO - PROCESS | 7815 | |7;imaging-desaturate;85;84;84;85;84;85;86;84;85;84 08:56:29 INFO - PROCESS | 7815 | |8;json-parse-financial;52;51;50;51;53;53;52;52;51;52 08:56:29 INFO - PROCESS | 7815 | |9;json-stringify-tinderbox;59;60;59;61;60;59;60;60;59;59 08:56:29 INFO - PROCESS | 7815 | |10;stanford-crypto-aes;79;74;74;74;80;74;75;74;75;82 08:56:29 INFO - PROCESS | 7815 | |11;stanford-crypto-ccm;123;122;122;121;128;139;120;118;159;124 08:56:29 INFO - PROCESS | 7815 | |12;stanford-crypto-pbkdf2;153;154;156;153;159;155;155;155;157;154 08:56:29 INFO - PROCESS | 7815 | |13;stanford-crypto-sha256-iterative;65;63;63;62;61;62;60;67;60;60 08:56:29 INFO - PROCESS | 7815 | __end_tp_report 08:56:29 INFO - PROCESS | 7815 | __start_cc_report 08:56:29 INFO - PROCESS | 7815 | _x_x_mozilla_cycle_collect,1642 08:56:29 INFO - PROCESS | 7815 | __end_cc_report 08:56:29 INFO - PROCESS | 7815 | __startTimestamp1483203389243__endTimestamp 08:56:29 INFO - PROCESS | 7815 | 08:56:29 INFO - PROCESS | 7815 | ------- Summary: start ------- 08:56:29 INFO - PROCESS | 7815 | Number of tests: 14 08:56:29 INFO - PROCESS | 7815 | 08:56:29 INFO - PROCESS | 7815 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:3.16 (2.9%) stddev-sans-first:1.30 08:56:29 INFO - PROCESS | 7815 | Values: 102.0 112.0 111.0 111.0 113.0 109.0 113.0 111.0 110.0 111.0 08:56:29 INFO - PROCESS | 7815 | 08:56:29 INFO - PROCESS | 7815 | [#1] audio-beat-detection Cycles:10 Average:130.20 Median:122.50 stddev:15.80 (12.9%) stddev-sans-first:14.21 08:56:29 INFO - PROCESS | 7815 | Values: 154.0 121.0 117.0 157.0 123.0 122.0 122.0 121.0 147.0 118.0 08:56:29 INFO - PROCESS | 7815 | 08:56:29 INFO - PROCESS | 7815 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.37 (0.8%) stddev-sans-first:1.39 08:56:29 INFO - PROCESS | 7815 | Values: 162.0 159.0 160.0 160.0 162.0 162.0 163.0 159.0 161.0 161.0 08:56:29 INFO - PROCESS | 7815 | 08:56:29 INFO - PROCESS | 7815 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:16.08 (21.4%) stddev-sans-first:16.83 08:56:29 INFO - PROCESS | 7815 | Values: 75.0 75.0 75.0 123.0 76.0 78.0 74.0 75.0 99.0 75.0 08:56:29 INFO - PROCESS | 7815 | 08:56:29 INFO - PROCESS | 7815 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:82.00 stddev:12.62 (15.4%) stddev-sans-first:13.01 08:56:29 INFO - PROCESS | 7815 | Values: 81.0 82.0 109.0 82.0 82.0 82.0 99.0 82.0 82.0 113.0 08:56:29 INFO - PROCESS | 7815 | 08:56:29 INFO - PROCESS | 7815 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:56:29 INFO - PROCESS | 7815 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 08:56:29 INFO - PROCESS | 7815 | 08:56:29 INFO - PROCESS | 7815 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:56:29 INFO - PROCESS | 7815 | Values: 146.0 147.0 146.0 146.0 145.0 145.0 146.0 147.0 146.0 146.0 08:56:29 INFO - PROCESS | 7815 | 08:56:29 INFO - PROCESS | 7815 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 08:56:29 INFO - PROCESS | 7815 | Values: 85.0 84.0 84.0 85.0 84.0 85.0 86.0 84.0 85.0 84.0 08:56:29 INFO - PROCESS | 7815 | 08:56:29 INFO - PROCESS | 7815 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:0.95 (1.8%) stddev-sans-first:1.00 08:56:29 INFO - PROCESS | 7815 | Values: 52.0 51.0 50.0 51.0 53.0 53.0 52.0 52.0 51.0 52.0 08:56:29 INFO - PROCESS | 7815 | 08:56:29 INFO - PROCESS | 7815 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 08:56:29 INFO - PROCESS | 7815 | Values: 59.0 60.0 59.0 61.0 60.0 59.0 60.0 60.0 59.0 59.0 08:56:29 INFO - PROCESS | 7815 | 08:56:29 INFO - PROCESS | 7815 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:75.00 stddev:3.03 (4.0%) stddev-sans-first:3.03 08:56:29 INFO - PROCESS | 7815 | Values: 79.0 74.0 74.0 74.0 80.0 74.0 75.0 74.0 75.0 82.0 08:56:29 INFO - PROCESS | 7815 | 08:56:29 INFO - PROCESS | 7815 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:123.50 stddev:12.50 (10.1%) stddev-sans-first:13.15 08:56:29 INFO - PROCESS | 7815 | Values: 123.0 122.0 122.0 121.0 128.0 139.0 120.0 118.0 159.0 124.0 08:56:29 INFO - PROCESS | 7815 | 08:56:29 INFO - PROCESS | 7815 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.10 Median:155.00 stddev:1.85 (1.2%) stddev-sans-first:1.80 08:56:29 INFO - PROCESS | 7815 | Values: 153.0 154.0 156.0 153.0 159.0 155.0 155.0 155.0 157.0 154.0 08:56:29 INFO - PROCESS | 7815 | 08:56:29 INFO - PROCESS | 7815 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:2.31 (3.7%) stddev-sans-first:2.24 08:56:29 INFO - PROCESS | 7815 | Values: 65.0 63.0 63.0 62.0 61.0 62.0 60.0 67.0 60.0 60.0 08:56:29 INFO - PROCESS | 7815 | -------- Summary: end -------- 08:56:29 INFO - PROCESS | 7815 | 08:56:30 INFO - TEST-INFO | 7815: exit 0 08:56:30 INFO - TEST-OK | kraken | took 59905ms 08:56:30 INFO - SUITE-END | took 1175s 08:56:30 INFO - Completed test suite (00:19:35) 08:56:30 INFO - javascript benchmark 08:56:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3200.9359812803746, 3225.725813305869, 3229.176559977206, 3249.642539320676, 3251.837408129593, 5489.149181876805, 5558.805441809537, 5563.304586926634, 5576.609637325389, 5588.30146231721, 5589.133684278933, 5616.213730077792, 5621.297337832761, 5622.156676498527, 5630.014747419195, 5044.974775126128, 5068.391792984847, 5096.541311281984, 5135.743212839362, 5164.586833053347, 4875.098106850226, 4878.438979517347, 5035.924461133086, 5130.025295193901, 5177.585793136559, 5061.898762024757, 5115.335006449156, 5131.7434128293435, 5154.123798954187, 5170.224466330043, 5153.665011774241, 5153.943441594502, 5155.896882062357, 5158.3552055993005, 5186.896262074775, 4821.590164835993, 4836.347093142451, 5045.889904221065, 5070.518300761421, 5127.692338459704, 5365.812196573102, 5399.136138217867, 5427.538659213971, 5454.072807622674, 5536.446355364472, 5825.475707186331, 5865.0, 5912.142739302777, 5920.023196172627, 5921.73352199152, 5940.940590594082, 5965.463108320272, 5969.701514924236, 5973.313068997078, 5980.581359304851, 5485.835424937219, 5487.725613719338, 5528.530074943675, 5533.03171944908, 5539.806106786243, 6049.062395328731, 6064.181335519736, 6077.574569780161, 6085.5435842312, 6091.14723938649, 5828.737706803204, 5834.124881267844, 5845.269341332333, 5847.6199047062655, 5851.356350801409, 5755.59710820247, 5801.100829371454, 5893.469587737124, 5910.231669882888, 5943.10853371989, 5979.611325263844, 6011.549133814981, 6014.669193194416, 6022.337542870281, 6051.757929682852, 6059.697015149225, 6061.696915154224, 6062.605930614496, 6066.817995460143, 6078.088286757022, 4466.6203372713035, 4498.077894031716, 4554.63562914966, 4657.69724967876, 4665.533446655308, 4113.218488487178, 4131.834726610902, 4142.109446469024, 4176.686748493875, 4179.958200418017, 5742.167385729046, 5757.798477053367, 5761.711914404347, 5764.625299355613, 5777.075667893117, 5739.71301434935, 5821.563382746226, 6063.151158837766, 6079.574429789872, 6082.1789058477425, 5544.417836127229, 5646.153077038395, 5669.40471250521, 5699.629524080921, 5764.193012978187, 5164.586833053347, 5167.844964651066, 5176.016556854186, 5180.740962951837, 5185.9887321971855, 6229.159063526366, 6268.686565671698, 6281.309056003927, 6282.465990390777, 6287.993920972714, 5821.417858214145, 5880.117982302689, 5893.823185304448, 5928.110783382527, 6049.848753781191, 6187.133801267736, 6199.132121502903, 6201.10084037821, 6202.627842329474, 6209.875802483834, 5793.3337666167245, 5864.149698293809, 5866.9732796759545, 5867.706614669335, 5874.295084589877, 5803.3616302207565, 5860.619059761102, 5928.8814223716145, 6001.0398336267735, 6008.128821320972, 5850.765969361178, 5916.852078698067, 5922.170896074639, 5923.08192230205, 5928.199693041384, 5862.912056319244, 5881.5588830837005, 5892.381299963442, 5901.970490147522, 5905.5570832186895, 5452.427495112956, 5453.918191227055, 5817.738201780845, 5832.358440571449, 5833.591648584558, 5792.82621521355, 5846.123081537803, 5848.4151584841175, 5910.024845900378, 5930.733117009659, 5690.800821971211, 5726.398728133652, 5736.5410767139365, 5739.598228124159, 5740.397258287987], "value": 5502.339860466561, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.3586890289583, 617.8084793713949, 642.6626021338797, 664.936831001055, 677.5934439336396, 33678.0, 44063.11873762527, 45383.09233815322, 45392.3191152133, 45409.31886021712, 45880.54119458804, 46239.76880115603, 46253.7687311563, 46262.53737462624, 46344.0, 8398.286145677625, 8823.558822058887, 8973.820523589524, 8975.506347150904, 8980.371374003822, 8340.29107525861, 10423.0, 10665.040146386824, 10667.626633067845, 10974.396408197546, 10861.511231994578, 10882.23824332297, 10896.073833724144, 10918.563257469732, 10923.508442120085, 10465.895341046567, 10525.684229473129, 10533.473326333691, 10549.20880933933, 10571.0, 10538.051575358255, 10626.096781773558, 10629.84055239172, 10631.149508039338, 10632.149428045737, 44169.33745993813, 44489.77755111236, 44508.0, 44581.0, 44633.107337853064, 3748.7750734955716, 3852.325842977468, 4408.889777755549, 4418.64650827933, 4485.730856148642, 33395.16512087193, 33787.83106084479, 33789.662103379145, 34112.82943585291, 34430.13924651879, 4357.324614684729, 4403.383526306319, 4432.22436073689, 4455.198064348416, 4521.706089104197, 356096.0, 357198.0, 358578.4142158571, 361007.0, 364744.0, 38529.61470385316, 63305.366946329945, 63581.0, 63647.68176159182, 63686.68156659187, 38879.61120388816, 40835.7958210213, 41092.58907410948, 41114.1777164461, 41141.79429102835, 16692.833071669127, 16816.0, 16859.409920652717, 16860.325586976385, 16865.494035178963, 12428.943539799218, 12575.93712031434, 12736.936315318364, 13866.0, 13963.441462341596, 9156.45061296311, 9381.812363752822, 9385.765355866022, 9435.433873967446, 9489.952550237205, 3413.232022794901, 3452.896413107611, 3473.3574288756663, 3496.8426420811124, 3508.1231541125376, 1041.8176819056634, 1068.962586309491, 1074.387599068539, 1075.8224892892742, 1157.085902137319, 32566.34867302641, 33931.32137357239, 34097.488537671954, 34686.826565867006, 34951.0, 1135.5798354608849, 1167.7139100920328, 1179.9646010619695, 1263.008538297432, 1269.5556555205603, 17949.73075403844, 18088.0, 18103.909480452512, 18151.09244537768, 18176.36382726598, 576821.0, 581301.0, 581724.0, 581755.0, 582151.0, 63531.36468635254, 63609.0, 64046.0, 64142.67928660327, 64224.67887660532, 1328.34247047712, 1373.1829561410943, 1386.5840247925785, 1439.8128243328301, 1453.4258967707697, 33161.17097072496, 35624.287514250085, 35681.0, 35992.820035899655, 36024.0, 54678.0, 55116.0, 55227.44772552223, 55342.0, 55424.44575554193, 406418.0, 407276.0, 410903.0, 531981.0, 542504.0, 45810.0, 45985.77007114943, 46421.0, 46574.76712616415, 47116.057678845544, 50345.496545035545, 50674.239886400996, 50750.49249507458, 50877.49122508727, 51091.48908511016, 44100.0, 44624.0, 45192.77403612961, 45273.32090018586, 45939.310910335706, 43445.0, 43571.56428435675, 43626.0, 44695.0, 45329.0, 43763.12473750571, 44612.10775784401, 45462.772686136355, 45513.77243113763, 45719.314210287535, 37842.0, 39680.2063958725, 39957.80021099992, 40164.3975340376, 40567.59432405638, 29717.702822971492, 29862.10413687593, 30126.54810177805, 30130.3428311445, 30442.238944026576], "value": 20664.469599153417, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.03816008233724, 427.72639120439, 434.6566212691973, 434.7000569606971, 439.25984715753935, 15766.448174313888, 19267.229310827566, 20623.38129856103, 20875.37373878782, 21028.0, 19474.610507789836, 20084.698729519034, 20118.0, 20233.988300584984, 20430.69353959688, 5620.437956204367, 5842.591018628697, 5843.444872737083, 5847.064469684851, 5848.444397782225, 5440.4287549807095, 5718.571107166958, 5728.026235539968, 5734.967705812952, 5735.627184233012, 5617.550595952314, 5711.114777209539, 5714.25714657094, 5716.028275193206, 5719.456651618089, 5588.944110558903, 5706.1726049722765, 5709.65742055478, 5719.628224165416, 5719.942800571983, 5112.309838171874, 5151.896962060775, 5156.690598564098, 5166.43169251382, 5167.121589329823, 23579.76420235793, 23705.76294237053, 23797.643035354482, 24136.75863241363, 24288.757112428826, 2387.6537902004284, 2658.5347564176386, 3027.5610036544576, 3027.6215473065868, 3030.2878823476467, 11004.284721493157, 11440.542378304857, 11566.53733850645, 15263.923680381638, 15630.374785008586, 1865.4496923407628, 1974.3780709076739, 2020.5150763816725, 2026.5136367271896, 2055.7533096028574, 86846.56576717076, 89125.10874891233, 90396.54801726015, 90806.0, 91096.54451727765, 10333.74487036581, 11508.712282193012, 11691.532338706527, 11780.175387722777, 12144.878551214551, 15055.473058443122, 15102.697946041018, 15958.521244362688, 16001.359945602046, 16664.16679166037, 8524.829503409897, 8742.30061595071, 8822.25010874083, 8927.642894284156, 8931.240844528158, 8251.8349633007, 8332.16678332162, 8340.874886876702, 8423.915760842436, 8517.148285171557, 4996.600271978233, 5036.84889453317, 5057.974710126426, 5152.536271735562, 5182.766775495112, 2082.292020712965, 2085.0488324624753, 2112.9366119016454, 2114.7462304523556, 2118.957620847605, 989.4557993103764, 990.64336838738, 1069.8662667166604, 1080.4921686807188, 1136.363636363639, 19440.0, 19854.801451985295, 20066.297679581436, 20247.392578222676, 20370.981450927393, 993.4883534979491, 1037.2894567221476, 1041.5625437316346, 1049.1554298789395, 1103.7240689827543, 10380.740481487872, 10907.181961352771, 11107.166962477846, 11193.384363859903, 11220.775584488265, 475221.0, 475809.0, 484990.0, 514632.0, 518112.0, 60572.697136514034, 87983.24033519294, 89837.0, 103064.48467757613, 104116.0, 1063.4576366053368, 1067.5356220044305, 1084.2301965604352, 1107.6067995861515, 1108.700650824273, 17393.56516087108, 17666.470005899842, 18080.63838723192, 18098.095095245448, 18213.854309131533, 42632.78683606562, 42824.143517130105, 44072.338914916945, 44329.55670443383, 44409.33385999148, 61902.69048654728, 62182.68908655428, 62578.0, 63131.684341577995, 63669.68165159145, 8618.61216245283, 8651.6106775194, 8727.389082764146, 8905.866412003954, 8920.0, 7592.924070759222, 11667.416629168678, 13066.673333166367, 13155.671108221988, 13203.207807531579, 10748.570057197625, 10990.285631433931, 11513.0, 11962.76074478523, 11993.64019079429, 11570.363630000431, 11705.765884682429, 11778.111720390663, 11840.822387664364, 11970.461329240032, 11975.101867360157, 11980.460879260629, 12194.634160975185, 12516.31160286193, 12594.370281486072, 8597.26923211534, 8817.515036673045, 8850.20348168668, 8913.688020919237, 8950.910490895008, 10425.426601536989, 11552.364619945984, 11804.527818887493, 12157.574484892986, 12266.32535210572], "value": 9563.573129428536, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.8499765025852, 1534.992325038375, 1537.0316700478697, 1724.9913750431247, 1838.9816101838985, 7955.602219889004, 8616.267617252533, 8925.509096999662, 8940.418872773265, 9134.588943497542, 8896.466212027282, 8991.145841145097, 8993.235574976135, 8999.550022498865, 9013.729588112366, 2486.328691253365, 2515.308290220195, 2520.0045981837166, 2520.294317591068, 2521.1428114441087, 2308.68832707584, 2308.8730119843403, 2310.7804758547995, 2314.872682002489, 2373.9406514837183, 2443.926682199537, 2449.7060352757694, 2470.4318006858434, 2474.814388920838, 2474.826762126652, 2381.785639292472, 2406.470576473173, 2430.343807172071, 2439.0365805506813, 2440.4386990992084, 2388.940276493084, 2408.4701365699516, 2419.879006049708, 2421.6125419932728, 2426.1265944260053, 8904.0, 8954.41796283246, 9009.594568244445, 9025.368224224307, 9046.502442365667, 5715.542756579505, 5862.677552734598, 5864.941350586482, 5906.9704651476895, 5915.852103697399, 3554.6445355464507, 3682.1346983458866, 3723.9627603724157, 3734.906627334311, 3751.3435148848844, 1198.8801119888028, 1205.2226314027491, 1213.2174747288038, 1231.9753604927942, 1239.6157191270736, 12835.807462888064, 12915.483380664762, 12932.741345173137, 13032.80450793239, 13042.021848361315, 4718.504557021463, 4888.437829649564, 4892.902141957141, 4931.309616653672, 4986.401631804207, 10179.287449878437, 10183.33808302458, 10192.0, 10222.182225421948, 10223.591056357662, 5668.149777533321, 5668.829935101953, 5681.460261275255, 5681.914771278434, 5688.203651488795, 4527.932081018787, 4708.176069187947, 4799.0641824844515, 5165.302684137669, 5306.416294207634, 4114.799958555938, 4125.257453658311, 4192.559781222989, 4206.9482629342665, 4248.065425606424, 1286.9549565765153, 1288.2528133682442, 1307.5031488034485, 1312.9080964332595, 1313.7832257677567, 954.8090381923643, 996.9102780749768, 1012.4431562640518, 1017.3234798858824, 1017.8524114003428, 5861.648301101947, 6133.26400831903, 6136.846578835475, 6317.0, 6321.37662869913, 485.8591008607464, 495.0198606758638, 499.0493110624194, 502.4648749082216, 987.6247026130025, 3933.977165936877, 4079.3676980068135, 4093.959060409358, 4124.505059392832, 4261.74429534229, 10920.890791092146, 11040.33757974524, 11048.558057677763, 11110.0, 11146.665600032013, 10909.34543927367, 11073.944630276797, 11082.22424430282, 11082.612108576322, 11286.774264514665, 8360.498370097814, 8544.871826922601, 8548.957255213809, 8552.315814734806, 8554.486730796172, 5638.774449022158, 5709.942900571107, 5769.9711501442225, 5772.567057470623, 5911.054231322968, 10096.848547271944, 10168.644097456554, 10177.643782467578, 10213.029762172582, 10245.129164021142, 9411.717648470556, 9696.369735967139, 10035.648752293635, 10104.69685909424, 10395.740106497398, 8040.356771458386, 8208.507489550646, 8239.052508961546, 8342.249197572248, 8361.0, 8746.38775285724, 8746.606402712021, 8768.167024132697, 8781.165789250012, 8850.291976641982, 7922.881156782538, 7965.920340796518, 7985.64064617082, 7998.280154786097, 8057.959710201411, 7864.0, 7879.448438609472, 7888.290053895177, 7900.960495197487, 8084.312833409226, 7325.120985481776, 7368.336849683555, 7378.557286562824, 7411.036565246483, 7412.147603025721, 5427.457254274541, 5444.0, 5473.890522189454, 5534.584906131976, 5667.4615911488345, 5389.2455056291365, 5404.621676482609, 5451.890962180655, 5530.336359636869, 5532.91700624499], "value": 4747.314148103404, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.29415727309475, 350.77725644215946, 354.7215435882832, 357.3514071959394, 364.64447164015087, 5315.654482458643, 5360.169173778061, 5368.328958880135, 5385.142125966545, 5386.973065134679, 5254.4220135785035, 5278.208268759688, 5279.017355194322, 5316.362036555609, 5327.440618735025, 3742.9625703743022, 4010.598940105995, 4118.752874827505, 4132.834686612532, 4185.363221170658, 4184.456020717303, 4205.962276214822, 4212.178625168093, 4214.810333534998, 4215.473065866767, 4185.74885506869, 4194.370844373353, 4206.915861682764, 4207.558206388331, 4219.324908014718, 3926.666233370167, 4027.1945610877647, 4209.1581683663235, 4214.8198504418815, 4226.830926762926, 3748.5501739791125, 3763.322601931651, 3782.527184101987, 3784.9053773655605, 3785.280796648628, 5152.330197074356, 5182.404023537304, 5213.905079933219, 5235.057689615867, 5243.2659427680155, 4723.740194289313, 4739.312799644033, 4792.904141917142, 4865.19724245499, 4873.415190177201, 5466.098093814516, 5491.313585801775, 5527.143292789584, 5533.833984980417, 5554.361248456398, 4105.58944105587, 4119.237940980928, 4129.566395528486, 4131.566185550534, 4134.152498737752, 5633.197591625677, 5697.31632204134, 5707.260514952846, 5860.0, 5881.382454842265, 4222.113356195172, 4232.915341693149, 4234.0050088229245, 4240.809163587646, 4242.639375653104, 4287.699861009762, 4296.324433470949, 4296.839853239608, 4323.178596066738, 4326.372675962031, 4626.236670949255, 4834.081524510332, 4850.054239423349, 4868.294097355863, 4873.317735516959, 5471.562275017989, 5525.11598144295, 5542.667439953616, 5545.61180717354, 5568.7215639217875, 1426.6090561702465, 1445.6024593236943, 1448.6957738874744, 1448.7034104476434, 1469.6178993461563, 988.6539711101201, 1013.7364285285731, 1018.3940555369543, 1033.0857191385678, 1051.321897376188, 5171.612129090333, 5200.60995425337, 5208.479152084837, 5208.661437006658, 5267.657602255841, 5454.672719636835, 5469.9179512306555, 5470.671759694431, 5508.338999320107, 5523.005858945348, 4968.677035992721, 5156.8968620627375, 5229.869253268699, 5235.973820130875, 5260.500252476008, 2892.52273374895, 2902.535594304901, 2902.6081479000486, 2912.7815413844046, 2918.0, 5678.290213723285, 5681.431856814368, 5689.374168841424, 5698.17376480408, 5716.28546431696, 5326.227696983916, 5488.69812160327, 5554.528050066736, 5556.833295001156, 5582.413846546055, 5792.623479473821, 5794.681292528951, 5892.616979896293, 5917.852053698606, 5921.319048309328, 5705.201271822031, 5713.400092990176, 5715.9142612860005, 5719.2279042328755, 5736.225609542826, 5517.048379117153, 5642.407547207648, 5648.971755141198, 5678.138865571451, 5689.431056894277, 5905.940940590539, 5911.467967882912, 5911.911321330097, 5918.260217472816, 5922.407759224216, 4178.310578754472, 4188.85339013133, 4196.559361267023, 4201.558836322142, 4215.178040282116, 5550.195221692913, 5653.519450846559, 5673.914891276717, 5681.4034526374135, 5683.2895888014, 5538.701438902971, 5558.972205138948, 5583.664980101207, 5593.888122237451, 5610.13042978339, 5351.785928562969, 5526.668399896019, 5563.415841336601, 5578.553715702653, 5589.0, 5466.289382380265, 5495.2856128703015, 5515.669059856261, 5522.22688823573, 5525.309336332958, 5600.439956004367, 5604.719764011865, 5617.213590097308, 5629.155626656035, 5638.407967163553, 5264.420913699413, 5431.321084864392, 5431.456854314695, 5434.157705555645, 5488.231647569263], "value": 4266.972338485797, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.7923139983607, 816.4856140631405, 860.4880096342675, 866.8829707989421, 890.7016149589887, 14791.334389952452, 16170.353185872566, 16194.35222591098, 16213.837861621396, 16224.594385140377, 13279.468821247163, 13382.197068175916, 13388.062835601488, 13390.397432115555, 13403.195808251487, 716.8888822232549, 734.2070563791119, 830.7217082277444, 854.3421565394642, 855.8887344645218, 854.7521218846528, 856.755824589992, 856.9785755356104, 857.0786404615033, 857.7169534053747, 913.2237598041678, 914.1041779056495, 914.995425022874, 915.5971372596069, 915.844306467902, 753.4161025205455, 765.4488768086941, 766.0615745711515, 773.0761739721036, 903.5391950105428, 650.3139188156493, 661.7716887673745, 665.2715276771927, 669.0232260899094, 669.4911866981081, 15084.472043478425, 15345.693086138326, 15378.692426151414, 15381.230938453033, 15406.3837446502, 13334.799978000337, 13372.598822035354, 13385.26381049042, 13558.661033474144, 14241.857581424158, 13307.401166947511, 13324.333783310796, 13420.597382078553, 13548.390322435514, 13591.320433978262, 4468.843590474317, 4471.642268618502, 4516.345129956171, 4583.610393116589, 4586.518415566351, 62653.37346626521, 63814.36185638131, 65011.349886501004, 65898.34101659017, 65928.0, 11266.267692599955, 11572.022023016822, 11580.247283926517, 11827.763444731057, 11881.40592970348, 17989.820101799076, 18897.716534252, 20198.0, 20211.696824547642, 20284.290049848183, 8496.745097647081, 8528.360372971927, 8688.95655521731, 8966.68616598416, 9111.772205694779, 4734.644901632391, 4838.709677419366, 4910.975445122823, 4920.8769780755765, 4947.356843610308, 3532.2229109595846, 3652.0139562318554, 3658.9451158232646, 3659.341318562631, 3659.4876717259604, 641.3330136657823, 648.251269783401, 651.4788169464505, 654.3129713800586, 667.9064930909676, 684.9760258391032, 696.2376198063113, 702.3187508117118, 719.9028131202325, 721.6355740351194, 9632.518374081268, 9679.225661947028, 9900.0, 9901.60393584263, 9912.851307230398, 717.4905816869976, 766.5630590563326, 798.1220657277065, 800.4116974024088, 811.2495941254316, 4743.905121897543, 5043.470435604282, 5101.285819985205, 5110.054639891558, 5115.616328775282, 82552.0, 89536.0, 90159.0, 91322.63016054765, 91749.0, 80481.59759201166, 82188.0, 82890.0, 83079.0, 84231.15768842355, 59642.10536841951, 63775.6811215941, 71947.64026179835, 72643.63678181576, 72813.0, 10216.59133634676, 10723.839142412715, 10934.507947142238, 10971.780564388508, 11035.889641103486, 43431.782841085595, 43446.34830477609, 43537.34693979656, 44431.0, 44444.55555444404, 54820.0, 55259.0, 59531.404685952584, 61767.0, 63763.6811815938, 12515.56195533152, 12541.623751287476, 12714.87285127137, 12906.0, 13492.0, 14489.492867749577, 14517.274136292932, 14664.193469359288, 14706.264686765406, 14789.630259243606, 12071.0, 13295.20228786276, 13374.665633359244, 14190.645233869236, 14465.059771114844, 14077.084989475652, 14093.577192684235, 14291.499797507038, 14550.199739014455, 14730.337134829173, 13132.868671313165, 13311.933440332736, 13442.865571344162, 14308.213048282028, 14438.639034024234, 11021.228514003942, 11460.770784584429, 11615.303081815118, 11830.112741544246, 11870.881291187323, 11280.492377842853, 11420.428978551205, 11813.173077884465, 11884.108691847972, 11953.521859125885], "value": 7477.626716177461, "unit": "score"}], "name": "dromaeo_css", "value": 7403.913962709326, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 111.0, 113.0, 109.0, 113.0, 111.0, 110.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 117.0, 157.0, 123.0, 122.0, 122.0, 121.0, 147.0, 118.0], "value": 130.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 160.0, 160.0, 162.0, 162.0, 163.0, 159.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 123.0, 76.0, 78.0, 74.0, 75.0, 99.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 109.0, 82.0, 82.0, 82.0, 99.0, 82.0, 82.0, 113.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 145.0, 146.0, 147.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 86.0, 84.0, 85.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 50.0, 51.0, 53.0, 53.0, 52.0, 52.0, 51.0, 52.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 61.0, 60.0, 59.0, 60.0, 60.0, 59.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 74.0, 74.0, 80.0, 74.0, 75.0, 74.0, 75.0, 82.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 122.0, 121.0, 128.0, 139.0, 120.0, 118.0, 159.0, 124.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 156.0, 153.0, 159.0, 155.0, 155.0, 155.0, 157.0, 154.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 62.0, 61.0, 62.0, 60.0, 67.0, 60.0, 60.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1453.0999999999997, "alertThreshold": 2.0}]} 08:56:30 INFO - Return code: 0 08:56:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:56:30 INFO - # TBPL SUCCESS # 08:56:30 INFO - Running post-action listener: _resource_record_post_action 08:56:30 INFO - [mozharness: 2016-12-31 16:56:30.579483Z] Finished run-tests step (success) 08:56:30 INFO - Running post-run listener: _resource_record_post_run 08:56:30 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 356204544; Read time: 0; Write time: 252040 08:56:30 INFO - TinderboxPrint: CPU usage
13.0% 08:56:30 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:56:30 INFO - TinderboxPrint: I/O write bytes / time
356,204,544 / 252,040 08:56:30 INFO - TinderboxPrint: CPU idle
8,278.1 (87.0%) 08:56:30 INFO - TinderboxPrint: CPU user
1,190.2 (12.5%) 08:56:30 INFO - TinderboxPrint: Swap in / out
0 / 0 08:56:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107634688; Read time: 0; Write time: 82312 08:56:30 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 247631872; Read time: 0; Write time: 169720 08:56:31 INFO - Running post-run listener: _upload_blobber_files 08:56:31 INFO - Blob upload gear active. 08:56:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:56:31 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 08:56:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:56:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:56:31 INFO - (blobuploader) - INFO - Open directory for files ... 08:56:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:56:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:56:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:32 INFO - (blobuploader) - INFO - Done attempting. 08:56:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:56:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:56:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:35 INFO - (blobuploader) - INFO - Done attempting. 08:56:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:56:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:56:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:36 INFO - (blobuploader) - INFO - Done attempting. 08:56:36 INFO - (blobuploader) - INFO - Iteration through files over. 08:56:36 INFO - Return code: 0 08:56:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:56:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:56:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b6a0b6b6b1837c771cee4cd39af8f3790a91f7af3a723ca219446867b1ec6044519645f7def43b35fb55c5a42242a0799d6f700ed7fa013d2887bd623776dd0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d0b2de5463716a96549ee5000eeb5173aad1ed260299d6aa895fb0e1ef99d65dd566304281dc577f14712528cbc4304b9ac691c0e7b03e0b064e2893f4e58e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf4420e4bcc4bd180b08632aee95a2a6abc7adad04f4b261eac5d0fd3c57464cd8dd99eec9c49140a663322530fe6d2378b85aca2ce81c52bad1f71429b85c7d"} 08:56:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:56:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:56:36 INFO - Contents: 08:56:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b6a0b6b6b1837c771cee4cd39af8f3790a91f7af3a723ca219446867b1ec6044519645f7def43b35fb55c5a42242a0799d6f700ed7fa013d2887bd623776dd0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d0b2de5463716a96549ee5000eeb5173aad1ed260299d6aa895fb0e1ef99d65dd566304281dc577f14712528cbc4304b9ac691c0e7b03e0b064e2893f4e58e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf4420e4bcc4bd180b08632aee95a2a6abc7adad04f4b261eac5d0fd3c57464cd8dd99eec9c49140a663322530fe6d2378b85aca2ce81c52bad1f71429b85c7d"} 08:56:36 INFO - Running post-run listener: copy_logs_to_upload_dir 08:56:36 INFO - Copying logs to upload dir... 08:56:36 INFO - mkdir: /builds/slave/test/build/upload/logs 08:56:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.035841 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-31 08:56:35.975749) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-31 08:56:35.982021) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b6a0b6b6b1837c771cee4cd39af8f3790a91f7af3a723ca219446867b1ec6044519645f7def43b35fb55c5a42242a0799d6f700ed7fa013d2887bd623776dd0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d0b2de5463716a96549ee5000eeb5173aad1ed260299d6aa895fb0e1ef99d65dd566304281dc577f14712528cbc4304b9ac691c0e7b03e0b064e2893f4e58e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf4420e4bcc4bd180b08632aee95a2a6abc7adad04f4b261eac5d0fd3c57464cd8dd99eec9c49140a663322530fe6d2378b85aca2ce81c52bad1f71429b85c7d"} build_url:https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011859 build_url: 'https://queue.taskcluster.net/v1/task/HR69km8GTRWY9lgm7zdRBw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b6a0b6b6b1837c771cee4cd39af8f3790a91f7af3a723ca219446867b1ec6044519645f7def43b35fb55c5a42242a0799d6f700ed7fa013d2887bd623776dd0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d0b2de5463716a96549ee5000eeb5173aad1ed260299d6aa895fb0e1ef99d65dd566304281dc577f14712528cbc4304b9ac691c0e7b03e0b064e2893f4e58e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf4420e4bcc4bd180b08632aee95a2a6abc7adad04f4b261eac5d0fd3c57464cd8dd99eec9c49140a663322530fe6d2378b85aca2ce81c52bad1f71429b85c7d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-31 08:56:36.009682) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 08:56:36.010046) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1483201941.479174-1062287253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 08:56:36.090506) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-31 08:56:36.090834) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-31 08:56:36.091124) ========= ========= Total master_lag: 0.18 =========