builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1479304795.32 results: success (0) buildid: 20161116031933 builduid: 5b3fd484cbc447d1b083843ae5fb9eda revision: 3d28fa9f98e1eafc400662d32823cc3594627496 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 05:59:55.322142) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 05:59:55.322503) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 05:59:55.322894) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 05:59:55.341362) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 05:59:55.341651) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-16 05:59:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.6M=0s 2016-11-16 05:59:55 (40.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085326 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 05:59:55.440677) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 05:59:55.440992) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016855 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 05:59:55.491526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-16 05:59:55.491868) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3d28fa9f98e1eafc400662d32823cc3594627496 --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 3d28fa9f98e1eafc400662d32823cc3594627496 --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=9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-16 05:59:55,870 truncating revision to first 12 chars 2016-11-16 05:59:55,870 Setting DEBUG logging. 2016-11-16 05:59:55,870 attempt 1/10 2016-11-16 05:59:55,870 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3d28fa9f98e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-16 05:59:56,829 unpacking tar archive at: mozilla-aurora-3d28fa9f98e1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.313753 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-16 05:59:56.818934) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 05:59:56.819302) ========= script_repo_revision: 3d28fa9f98e1eafc400662d32823cc3594627496 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 05:59:56.819784) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 05:59:56.820052) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 05:59:56.829700) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-16 05:59:56.829980) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:59:57 INFO - MultiFileLogger online at 20161116 05:59:57 in /builds/slave/test 05:59:57 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 05:59:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:59:57 INFO - {'append_to_log': False, 05:59:57 INFO - 'base_work_dir': '/builds/slave/test', 05:59:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:59:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:59:57 INFO - 'branch': 'Mozilla-Aurora', 05:59:57 INFO - 'buildbot_json_path': 'buildprops.json', 05:59:57 INFO - 'config_files': ('talos/linux_config.py',), 05:59:57 INFO - 'default_actions': ('clobber', 05:59:57 INFO - 'read-buildbot-config', 05:59:57 INFO - 'download-and-extract', 05:59:57 INFO - 'populate-webroot', 05:59:57 INFO - 'create-virtualenv', 05:59:57 INFO - 'install', 05:59:57 INFO - 'run-tests'), 05:59:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:59:57 INFO - 'download_minidump_stackwalk': True, 05:59:57 INFO - 'download_symbols': 'ondemand', 05:59:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:59:57 INFO - 'tooltool.py': '/tools/tooltool.py', 05:59:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:59:57 INFO - '/tools/misc-python/virtualenv.py')}, 05:59:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:59:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:59:57 INFO - 'installer_path': 'installer.exe', 05:59:57 INFO - 'log_level': 'info', 05:59:57 INFO - 'log_name': 'talos', 05:59:57 INFO - 'log_to_console': True, 05:59:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:59:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:59:57 INFO - 'opt_config_files': (), 05:59:57 INFO - 'pip_index': False, 05:59:57 INFO - 'sps_profile': False, 05:59:57 INFO - 'sps_profile_interval': 0, 05:59:57 INFO - 'suite': 'dromaeojs', 05:59:57 INFO - 'system_bits': '32', 05:59:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:59:57 INFO - 'title': 'talos-linux64-ix-040', 05:59:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:59:57 INFO - 'use_talos_json': True, 05:59:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:59:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:59:57 INFO - 'work_dir': 'build'} 05:59:57 INFO - [mozharness: 2016-11-16 13:59:57.304536Z] Running clobber step. 05:59:57 INFO - Running pre-action listener: _resource_record_pre_action 05:59:57 INFO - Running main action method: clobber 05:59:57 INFO - rmtree: /builds/slave/test/build 05:59:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:59:57 INFO - Running post-action listener: _resource_record_post_action 05:59:57 INFO - [mozharness: 2016-11-16 13:59:57.765926Z] Finished clobber step (success) 05:59:57 INFO - [mozharness: 2016-11-16 13:59:57.766028Z] Running read-buildbot-config step. 05:59:57 INFO - Running pre-action listener: _resource_record_pre_action 05:59:57 INFO - Running main action method: read_buildbot_config 05:59:57 INFO - Using buildbot properties: 05:59:57 INFO - { 05:59:57 INFO - "project": "", 05:59:57 INFO - "product": "firefox", 05:59:57 INFO - "script_repo_revision": "production", 05:59:57 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 05:59:57 INFO - "repository": "", 05:59:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 05:59:57 INFO - "buildid": "20161116031933", 05:59:57 INFO - "pgo_build": "True", 05:59:57 INFO - "basedir": "/builds/slave/test", 05:59:57 INFO - "buildnumber": 909, 05:59:57 INFO - "slavename": "talos-linux64-ix-040", 05:59:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:59:57 INFO - "platform": "ubuntu64_hw", 05:59:57 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:59:57 INFO - "branch": "mozilla-aurora", 05:59:57 INFO - "repo_path": "releases/mozilla-aurora", 05:59:57 INFO - "revision": "3d28fa9f98e1eafc400662d32823cc3594627496", 05:59:57 INFO - "stage_platform": "linux64-pgo", 05:59:57 INFO - "builduid": "5b3fd484cbc447d1b083843ae5fb9eda", 05:59:57 INFO - "slavebuilddir": "test" 05:59:57 INFO - } 05:59:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 05:59:57 INFO - Running post-action listener: _resource_record_post_action 05:59:57 INFO - [mozharness: 2016-11-16 13:59:57.768463Z] Finished read-buildbot-config step (success) 05:59:57 INFO - [mozharness: 2016-11-16 13:59:57.768552Z] Running download-and-extract step. 05:59:57 INFO - Running pre-action listener: _resource_record_pre_action 05:59:57 INFO - Running main action method: download_and_extract 05:59:57 INFO - mkdir: /builds/slave/test/build/tests 05:59:57 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')]} 05:59:57 INFO - trying https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 05:59:57 INFO - Downloading https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/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 05:59:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/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 05:59:58 INFO - Downloaded 1361 bytes. 05:59:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 05:59:58 INFO - Using the following test package requirements: 05:59:58 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 05:59:58 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:59:58 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:59:58 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:58 INFO - u'jsshell-linux-x86_64.zip'], 05:59:58 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:59:58 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 05:59:58 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:59:58 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:59:58 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:59:58 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 05:59:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:59:58 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:59:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 05:59:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:59:58 INFO - Fetch https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 05:59:58 INFO - Http code: 200 05:59:58 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 05:59:58 INFO - x-amz-cf-id: uGnugY37VyTP5ll5T5jb2bY1OfOSDaUR-WZ4JKBWpCzbsRWA8vwW8g== 05:59:58 INFO - x-amz-version-id: q1S9a8rS6w3cLLbvPGi543srVj7aOvld 05:59:59 INFO - Expected file size: 21999559 05:59:59 INFO - Obtained file size: 21999559 06:00:03 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 06:00:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 06:00:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:00:03 INFO - Fetch https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 06:00:03 INFO - Http code: 200 06:00:03 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 06:00:03 INFO - x-amz-cf-id: E39AuOvhvZTdkeOm6Ml0XqXzr3o6Nfgbiji06DHPIzYwdeTkB7LjhA== 06:00:03 INFO - x-amz-version-id: q1S9a8rS6w3cLLbvPGi543srVj7aOvld 06:00:04 INFO - Expected file size: 21999559 06:00:04 INFO - Obtained file size: 21999559 06:00:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 06:00:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:00:08 INFO - Fetch https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 06:00:09 INFO - Http code: 200 06:00:09 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 06:00:09 INFO - x-amz-cf-id: 3ex4ykfaAUWpDiMKpXoo11i8VwruOUENHgA1C4VioI9uoJUABg1TWw== 06:00:09 INFO - x-amz-version-id: wHZE9g99bTfmyB1K5AWAT4yfPUVNZCvd 06:00:10 INFO - Expected file size: 14409038 06:00:10 INFO - Obtained file size: 14409038 06:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:10 INFO - trying https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 06:00:10 INFO - Downloading https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/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 06:00:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/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 06:00:13 INFO - Downloaded 63927613 bytes. 06:00:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 06:00:13 INFO - mkdir: /builds/slave/test/properties 06:00:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:00:13 INFO - Writing to file /builds/slave/test/properties/build_url 06:00:13 INFO - Contents: 06:00:13 INFO - build_url:https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 06:00:13 INFO - Running post-action listener: _resource_record_post_action 06:00:13 INFO - Running post-action listener: set_extra_try_arguments 06:00:13 INFO - [mozharness: 2016-11-16 14:00:13.755616Z] Finished download-and-extract step (success) 06:00:13 INFO - [mozharness: 2016-11-16 14:00:13.755843Z] Running populate-webroot step. 06:00:13 INFO - Running pre-action listener: _resource_record_pre_action 06:00:13 INFO - Running main action method: populate_webroot 06:00:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:00:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:00:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:00:13 INFO - '--tppagecycles', 06:00:13 INFO - '7'], 06:00:13 INFO - 'tests': ['tsvgm']}}, 06:00:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:00:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:00:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:00:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:00:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:00:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:00:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:13 INFO - 'talos_options': ['--disable-e10s'], 06:00:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:13 INFO - 'talos_options': ['--disable-e10s'], 06:00:13 INFO - 'tests': ['damp', 'tps']}, 06:00:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:13 INFO - 'tests': ['damp', 'tps']}, 06:00:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:00:13 INFO - 'tests': ['dromaeo_dom']}, 06:00:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:00:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:00:13 INFO - 'tests': ['basic_compositor_video']}, 06:00:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:00:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:00:13 INFO - 'tests': ['a11yr', 06:00:13 INFO - 'ts_paint', 06:00:13 INFO - 'tpaint', 06:00:13 INFO - 'sessionrestore', 06:00:13 INFO - 'sessionrestore_no_auto_restore', 06:00:13 INFO - 'tabpaint']}, 06:00:13 INFO - 'other-e10s': {'tests': ['a11yr', 06:00:13 INFO - 'ts_paint', 06:00:13 INFO - 'tpaint', 06:00:13 INFO - 'sessionrestore', 06:00:13 INFO - 'sessionrestore_no_auto_restore', 06:00:13 INFO - 'tabpaint']}, 06:00:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:00:13 INFO - 'ts_paint', 06:00:13 INFO - 'tpaint', 06:00:13 INFO - 'sessionrestore', 06:00:13 INFO - 'sessionrestore_no_auto_restore', 06:00:13 INFO - 'tabpaint']}, 06:00:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:00:13 INFO - 'ts_paint', 06:00:13 INFO - 'tpaint', 06:00:13 INFO - 'sessionrestore', 06:00:13 INFO - 'sessionrestore_no_auto_restore', 06:00:13 INFO - 'tabpaint']}, 06:00:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:00:13 INFO - 'tests': ['a11yr', 06:00:13 INFO - 'ts_paint', 06:00:13 INFO - 'tpaint', 06:00:13 INFO - 'sessionrestore', 06:00:13 INFO - 'sessionrestore_no_auto_restore', 06:00:13 INFO - 'tabpaint']}, 06:00:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:00:13 INFO - 'tests': ['a11yr', 06:00:13 INFO - 'ts_paint', 06:00:13 INFO - 'tpaint', 06:00:13 INFO - 'sessionrestore', 06:00:13 INFO - 'sessionrestore_no_auto_restore', 06:00:13 INFO - 'tabpaint']}, 06:00:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:00:13 INFO - 'tests': ['tsvgx', 06:00:13 INFO - 'tsvgr_opacity', 06:00:13 INFO - 'tart', 06:00:13 INFO - 'tscrollx', 06:00:13 INFO - 'cart']}, 06:00:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:00:13 INFO - 'tsvgr_opacity', 06:00:13 INFO - 'tart', 06:00:13 INFO - 'tscrollx', 06:00:13 INFO - 'cart']}, 06:00:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:13 INFO - 'talos_options': ['--disable-e10s'], 06:00:13 INFO - 'tests': ['tp5o']}, 06:00:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:13 INFO - 'tests': ['tp5o']}, 06:00:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:13 INFO - 'talos_options': ['--disable-e10s', 06:00:13 INFO - '--xperf_path', 06:00:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:13 INFO - 'tests': ['tp5n']}, 06:00:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:13 INFO - 'talos_options': ['--xperf_path', 06:00:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:13 INFO - 'tests': ['tp5n']}}, 06:00:13 INFO - 'talos.zip': {'path': '', 06:00:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:00:13 INFO - Running post-action listener: _resource_record_post_action 06:00:13 INFO - [mozharness: 2016-11-16 14:00:13.782588Z] Finished populate-webroot step (success) 06:00:13 INFO - [mozharness: 2016-11-16 14:00:13.782676Z] Running create-virtualenv step. 06:00:13 INFO - Running pre-action listener: _resource_record_pre_action 06:00:13 INFO - Running main action method: create_virtualenv 06:00:13 INFO - Creating virtualenv /builds/slave/test/build/venv 06:00:13 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 06:00:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:00:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:00:13 INFO - Using real prefix '/usr' 06:00:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:00:14 INFO - Installing distribute.............................................................................................................................................................................................done. 06:00:16 INFO - Installing pip.................done. 06:00:16 INFO - Return code: 0 06:00:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:00:16 INFO - Reading from file tmpfile_stdout 06:00:16 INFO - Output received: 06:00:16 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) 06:00:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:00:16 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')]} 06:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:16 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')]} 06:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:16 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 0x7fba8e297f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f8f60>, '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 0x15f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fa1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', '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 06:00:16 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 06:00:16 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 06:00:16 INFO - Using env: {'DISPLAY': ':0', 06:00:16 INFO - 'HOME': '/home/cltbld', 06:00:16 INFO - 'LANG': 'en_US.UTF-8', 06:00:16 INFO - 'LANGUAGE': 'en_US:en', 06:00:16 INFO - 'LOGNAME': 'cltbld', 06:00:16 INFO - 'MAIL': '/var/mail/cltbld', 06:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:16 INFO - 'MOZ_NO_REMOTE': '1', 06:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:16 INFO - 'NO_EM_RESTART': '1', 06:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:16 INFO - 'PWD': '/builds/slave/test', 06:00:16 INFO - 'SHELL': '/bin/bash', 06:00:16 INFO - 'SHLVL': '1', 06:00:16 INFO - 'TERM': 'linux', 06:00:16 INFO - 'TMOUT': '86400', 06:00:16 INFO - 'USER': 'cltbld', 06:00:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', 06:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:16 INFO - '_': '/tools/buildbot/bin/python'} 06:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:16 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 06:00:16 INFO - Cleaning up... 06:00:16 INFO - Return code: 0 06:00:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:00:16 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')]} 06:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:16 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')]} 06:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:16 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 0x7fba8e297f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f8f60>, '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 0x15f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fa1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', '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 06:00:16 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 06:00:16 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 06:00:16 INFO - Using env: {'DISPLAY': ':0', 06:00:16 INFO - 'HOME': '/home/cltbld', 06:00:16 INFO - 'LANG': 'en_US.UTF-8', 06:00:16 INFO - 'LANGUAGE': 'en_US:en', 06:00:16 INFO - 'LOGNAME': 'cltbld', 06:00:16 INFO - 'MAIL': '/var/mail/cltbld', 06:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:16 INFO - 'MOZ_NO_REMOTE': '1', 06:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:16 INFO - 'NO_EM_RESTART': '1', 06:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:16 INFO - 'PWD': '/builds/slave/test', 06:00:16 INFO - 'SHELL': '/bin/bash', 06:00:16 INFO - 'SHLVL': '1', 06:00:16 INFO - 'TERM': 'linux', 06:00:16 INFO - 'TMOUT': '86400', 06:00:16 INFO - 'USER': 'cltbld', 06:00:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', 06:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:16 INFO - '_': '/tools/buildbot/bin/python'} 06:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:16 INFO - Downloading/unpacking psutil>=3.1.1 06:00:16 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 06:00:16 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 06:00:16 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 06:00:16 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 06:00:16 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 06:00:16 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 06:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:00:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:19 INFO - Installing collected packages: psutil 06:00:19 INFO - Running setup.py install for psutil 06:00:19 INFO - building 'psutil._psutil_linux' extension 06:00:19 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 06:00:19 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 06:00:19 INFO - building 'psutil._psutil_posix' extension 06:00:19 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 06:00:19 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 06:00:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:19 INFO - Successfully installed psutil 06:00:19 INFO - Cleaning up... 06:00:19 INFO - Return code: 0 06:00:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba8e297f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f8f60>, '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 0x15f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fa1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', '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 06:00: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:00: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 mozsystemmonitor==0.3 06:00:19 INFO - Using env: {'DISPLAY': ':0', 06:00:19 INFO - 'HOME': '/home/cltbld', 06:00:19 INFO - 'LANG': 'en_US.UTF-8', 06:00:19 INFO - 'LANGUAGE': 'en_US:en', 06:00:19 INFO - 'LOGNAME': 'cltbld', 06:00:19 INFO - 'MAIL': '/var/mail/cltbld', 06:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:19 INFO - 'MOZ_NO_REMOTE': '1', 06:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:19 INFO - 'NO_EM_RESTART': '1', 06:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:19 INFO - 'PWD': '/builds/slave/test', 06:00:19 INFO - 'SHELL': '/bin/bash', 06:00:19 INFO - 'SHLVL': '1', 06:00:19 INFO - 'TERM': 'linux', 06:00:19 INFO - 'TMOUT': '86400', 06:00:19 INFO - 'USER': 'cltbld', 06:00:19 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', 06:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:19 INFO - '_': '/tools/buildbot/bin/python'} 06:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:00:21 INFO - Installing collected packages: mozsystemmonitor 06:00:21 INFO - Running setup.py install for mozsystemmonitor 06:00:21 INFO - Successfully installed mozsystemmonitor 06:00:21 INFO - Cleaning up... 06:00:21 INFO - Return code: 0 06:00:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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', '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 0x7fba8e297f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f8f60>, '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 0x15f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fa1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', '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 06:00: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:00: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 jsonschema==2.5.1 06:00:21 INFO - Using env: {'DISPLAY': ':0', 06:00:21 INFO - 'HOME': '/home/cltbld', 06:00:21 INFO - 'LANG': 'en_US.UTF-8', 06:00:21 INFO - 'LANGUAGE': 'en_US:en', 06:00:21 INFO - 'LOGNAME': 'cltbld', 06:00:21 INFO - 'MAIL': '/var/mail/cltbld', 06:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:21 INFO - 'MOZ_NO_REMOTE': '1', 06:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:21 INFO - 'NO_EM_RESTART': '1', 06:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:21 INFO - 'PWD': '/builds/slave/test', 06:00:21 INFO - 'SHELL': '/bin/bash', 06:00:21 INFO - 'SHLVL': '1', 06:00:21 INFO - 'TERM': 'linux', 06:00:21 INFO - 'TMOUT': '86400', 06:00:21 INFO - 'USER': 'cltbld', 06:00:21 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', 06:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:21 INFO - '_': '/tools/buildbot/bin/python'} 06:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:22 INFO - Downloading/unpacking jsonschema==2.5.1 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:00:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00:24 INFO - Downloading functools32-3.2.3-2.tar.gz 06:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:00:24 INFO - warning: no files found matching '*.txt' 06:00:24 INFO - no previously-included directories found matching 'build' 06:00:24 INFO - no previously-included directories found matching 'dist' 06:00:24 INFO - no previously-included directories found matching '.git*' 06:00:24 INFO - Installing collected packages: jsonschema, functools32 06:00:24 INFO - Running setup.py install for functools32 06:00:24 INFO - warning: no files found matching '*.txt' 06:00:24 INFO - no previously-included directories found matching 'build' 06:00:24 INFO - no previously-included directories found matching 'dist' 06:00:24 INFO - no previously-included directories found matching '.git*' 06:00:24 INFO - Successfully installed jsonschema functools32 06:00:24 INFO - Cleaning up... 06:00:24 INFO - Return code: 0 06:00:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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', '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 0x7fba8e297f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f8f60>, '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 0x15f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fa1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', '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 06:00: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:00: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 functools32==3.2.3-2 06:00:24 INFO - Using env: {'DISPLAY': ':0', 06:00:24 INFO - 'HOME': '/home/cltbld', 06:00:24 INFO - 'LANG': 'en_US.UTF-8', 06:00:24 INFO - 'LANGUAGE': 'en_US:en', 06:00:24 INFO - 'LOGNAME': 'cltbld', 06:00:24 INFO - 'MAIL': '/var/mail/cltbld', 06:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:24 INFO - 'MOZ_NO_REMOTE': '1', 06:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:24 INFO - 'NO_EM_RESTART': '1', 06:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:24 INFO - 'PWD': '/builds/slave/test', 06:00:24 INFO - 'SHELL': '/bin/bash', 06:00:24 INFO - 'SHLVL': '1', 06:00:24 INFO - 'TERM': 'linux', 06:00:24 INFO - 'TMOUT': '86400', 06:00:24 INFO - 'USER': 'cltbld', 06:00:24 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', 06:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:24 INFO - '_': '/tools/buildbot/bin/python'} 06:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:00:24 INFO - Cleaning up... 06:00:24 INFO - Return code: 0 06:00:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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', '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 0x7fba8e297f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f8f60>, '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 0x15f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fa1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', '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 06:00: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:00: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 blobuploader==1.2.4 06:00:24 INFO - Using env: {'DISPLAY': ':0', 06:00:24 INFO - 'HOME': '/home/cltbld', 06:00:24 INFO - 'LANG': 'en_US.UTF-8', 06:00:24 INFO - 'LANGUAGE': 'en_US:en', 06:00:24 INFO - 'LOGNAME': 'cltbld', 06:00:24 INFO - 'MAIL': '/var/mail/cltbld', 06:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:24 INFO - 'MOZ_NO_REMOTE': '1', 06:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:24 INFO - 'NO_EM_RESTART': '1', 06:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:24 INFO - 'PWD': '/builds/slave/test', 06:00:24 INFO - 'SHELL': '/bin/bash', 06:00:24 INFO - 'SHLVL': '1', 06:00:24 INFO - 'TERM': 'linux', 06:00:24 INFO - 'TMOUT': '86400', 06:00:24 INFO - 'USER': 'cltbld', 06:00:24 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', 06:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:24 INFO - '_': '/tools/buildbot/bin/python'} 06:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:24 INFO - Downloading/unpacking blobuploader==1.2.4 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00:27 INFO - Downloading blobuploader-1.2.4.tar.gz 06:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:00:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:00:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00: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 06:00:27 INFO - Downloading docopt-0.6.1.tar.gz 06:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:00:27 INFO - Installing collected packages: blobuploader, requests, docopt 06:00:27 INFO - Running setup.py install for blobuploader 06:00:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:00:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:00:27 INFO - Running setup.py install for requests 06:00:28 INFO - Running setup.py install for docopt 06:00:28 INFO - Successfully installed blobuploader requests docopt 06:00:28 INFO - Cleaning up... 06:00:28 INFO - Return code: 0 06:00:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00:28 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')]} 06:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:28 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')]} 06:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:28 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 0x7fba8e297f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f8f60>, '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 0x15f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fa1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', '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 06:00:28 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 06:00:28 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 06:00:28 INFO - Using env: {'DISPLAY': ':0', 06:00:28 INFO - 'HOME': '/home/cltbld', 06:00:28 INFO - 'LANG': 'en_US.UTF-8', 06:00:28 INFO - 'LANGUAGE': 'en_US:en', 06:00:28 INFO - 'LOGNAME': 'cltbld', 06:00:28 INFO - 'MAIL': '/var/mail/cltbld', 06:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:28 INFO - 'MOZ_NO_REMOTE': '1', 06:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:28 INFO - 'NO_EM_RESTART': '1', 06:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:28 INFO - 'PWD': '/builds/slave/test', 06:00:28 INFO - 'SHELL': '/bin/bash', 06:00:28 INFO - 'SHLVL': '1', 06:00:28 INFO - 'TERM': 'linux', 06:00:28 INFO - 'TMOUT': '86400', 06:00:28 INFO - 'USER': 'cltbld', 06:00:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', 06:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:28 INFO - '_': '/tools/buildbot/bin/python'} 06:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:00:28 INFO - Running setup.py (path:/tmp/pip-u0Q4_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:00:28 INFO - Running setup.py (path:/tmp/pip-iMeLd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:00:28 INFO - Running setup.py (path:/tmp/pip-l52yER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:00:28 INFO - Running setup.py (path:/tmp/pip-pKNt2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:00:28 INFO - Running setup.py (path:/tmp/pip-AtbAV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:00:28 INFO - Running setup.py (path:/tmp/pip-hNKkTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:00:29 INFO - Running setup.py (path:/tmp/pip-zUiLYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:00:29 INFO - Running setup.py (path:/tmp/pip-7zcHUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:00:29 INFO - Running setup.py (path:/tmp/pip-ffKZMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:00:29 INFO - Running setup.py (path:/tmp/pip-nGA4tW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:00:29 INFO - Running setup.py (path:/tmp/pip-FA0UlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:00:29 INFO - Running setup.py (path:/tmp/pip-Ydqo8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:00:29 INFO - Running setup.py (path:/tmp/pip-CRyTL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:00:29 INFO - Running setup.py (path:/tmp/pip-N1Zasd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:29 INFO - Running setup.py (path:/tmp/pip-f1914r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:00:29 INFO - Running setup.py (path:/tmp/pip-nj_tb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:00:29 INFO - Running setup.py (path:/tmp/pip-xnyVGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:00:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:00:29 INFO - Running setup.py install for manifestparser 06:00:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:00:29 INFO - Running setup.py install for mozcrash 06:00:30 INFO - Running setup.py install for mozdebug 06:00:30 INFO - Running setup.py install for mozdevice 06:00:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:00:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:00:30 INFO - Running setup.py install for mozfile 06:00:30 INFO - Running setup.py install for mozhttpd 06:00:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:00:30 INFO - Running setup.py install for mozinfo 06:00:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:00:30 INFO - Running setup.py install for mozInstall 06:00:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:00:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:00:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:00:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:00:30 INFO - Running setup.py install for mozleak 06:00:30 INFO - Running setup.py install for mozlog 06:00:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:00:30 INFO - Running setup.py install for moznetwork 06:00:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:00:30 INFO - Running setup.py install for mozprocess 06:00:31 INFO - Running setup.py install for mozprofile 06:00:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:00:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:00:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:00:31 INFO - Running setup.py install for mozrunner 06:00:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:00:31 INFO - Running setup.py install for mozscreenshot 06:00:31 INFO - Running setup.py install for moztest 06:00:31 INFO - Running setup.py install for mozversion 06:00:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:00:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:00:31 INFO - Cleaning up... 06:00:31 INFO - Return code: 0 06:00:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00:31 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')]} 06:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:31 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')]} 06:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:31 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 0x7fba8e297f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f8f60>, '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 0x15f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fa1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', '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 06:00:31 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 06:00:31 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 06:00:31 INFO - Using env: {'DISPLAY': ':0', 06:00:31 INFO - 'HOME': '/home/cltbld', 06:00:31 INFO - 'LANG': 'en_US.UTF-8', 06:00:31 INFO - 'LANGUAGE': 'en_US:en', 06:00:31 INFO - 'LOGNAME': 'cltbld', 06:00:31 INFO - 'MAIL': '/var/mail/cltbld', 06:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:31 INFO - 'MOZ_NO_REMOTE': '1', 06:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:31 INFO - 'NO_EM_RESTART': '1', 06:00:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:31 INFO - 'PWD': '/builds/slave/test', 06:00:31 INFO - 'SHELL': '/bin/bash', 06:00:31 INFO - 'SHLVL': '1', 06:00:31 INFO - 'TERM': 'linux', 06:00:31 INFO - 'TMOUT': '86400', 06:00:31 INFO - 'USER': 'cltbld', 06:00:31 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', 06:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:31 INFO - '_': '/tools/buildbot/bin/python'} 06:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:00:31 INFO - Running setup.py (path:/tmp/pip-3D410n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:00:31 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)) 06:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:00:31 INFO - Running setup.py (path:/tmp/pip-3cA03y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:00:32 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)) 06:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:00:32 INFO - Running setup.py (path:/tmp/pip-qKfvAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:00:32 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)) 06:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:00:32 INFO - Running setup.py (path:/tmp/pip-Ig4uJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:00:32 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)) 06:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:00:32 INFO - Running setup.py (path:/tmp/pip-XvUqZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:00:32 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)) 06:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:00:32 INFO - Running setup.py (path:/tmp/pip-uttsiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:00:32 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)) 06:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:00:32 INFO - Running setup.py (path:/tmp/pip-fO8ZgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:00:32 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)) 06:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:00:32 INFO - Running setup.py (path:/tmp/pip-nrTrxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:00:32 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)) 06:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:00:32 INFO - Running setup.py (path:/tmp/pip-_WBiMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:00:32 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)) 06:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:00:32 INFO - Running setup.py (path:/tmp/pip-hyC0Rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:00:32 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)) 06:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:00:32 INFO - Running setup.py (path:/tmp/pip-WJGg6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:00:32 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)) 06:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:00:32 INFO - Running setup.py (path:/tmp/pip-z6XDTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:00:32 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)) 06:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:00:32 INFO - Running setup.py (path:/tmp/pip-rZTJ7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:00:32 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)) 06:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:00:32 INFO - Running setup.py (path:/tmp/pip-jRxH3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:00:32 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)) 06:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:32 INFO - Running setup.py (path:/tmp/pip-1jiDH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:00:32 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)) 06:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:00:33 INFO - Running setup.py (path:/tmp/pip-FrEJU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:00:33 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)) 06:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:00:33 INFO - Running setup.py (path:/tmp/pip-rvX45I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:00:33 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)) 06:00:33 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)) 06:00:33 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)) 06:00:33 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)) 06:00:33 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)) 06:00:33 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)) 06:00:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:35 INFO - Downloading blessings-1.6.tar.gz 06:00:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:00:35 INFO - Installing collected packages: blessings 06:00:35 INFO - Running setup.py install for blessings 06:00:35 INFO - Successfully installed blessings 06:00:35 INFO - Cleaning up... 06:00:35 INFO - Return code: 0 06:00:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:00:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:00:35 INFO - Reading from file tmpfile_stdout 06:00:35 INFO - Current package versions: 06:00:35 INFO - argparse == 1.2.1 06:00:35 INFO - blessings == 1.6 06:00:35 INFO - blobuploader == 1.2.4 06:00:35 INFO - docopt == 0.6.1 06:00:35 INFO - functools32 == 3.2.3-2 06:00:35 INFO - jsonschema == 2.5.1 06:00:35 INFO - manifestparser == 1.1 06:00:35 INFO - mozInstall == 1.12 06:00:35 INFO - mozcrash == 1.0 06:00:35 INFO - mozdebug == 0.1 06:00:35 INFO - mozdevice == 0.48 06:00:35 INFO - mozfile == 1.2 06:00:35 INFO - mozhttpd == 0.7 06:00:35 INFO - mozinfo == 0.9 06:00:35 INFO - mozleak == 0.1 06:00:35 INFO - mozlog == 3.4 06:00:35 INFO - moznetwork == 0.27 06:00:35 INFO - mozprocess == 0.23 06:00:35 INFO - mozprofile == 0.28 06:00:35 INFO - mozrunner == 6.13 06:00:35 INFO - mozscreenshot == 0.1 06:00:35 INFO - mozsystemmonitor == 0.3 06:00:35 INFO - moztest == 0.7 06:00:35 INFO - mozversion == 1.4 06:00:35 INFO - psutil == 3.1.1 06:00:35 INFO - requests == 1.2.3 06:00:35 INFO - wsgiref == 0.1.2 06:00:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:35 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 0x7fba8e297f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f8f60>, '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 0x15f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fa1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', '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 06:00:35 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 06:00:35 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 06:00:35 INFO - Using env: {'DISPLAY': ':0', 06:00:35 INFO - 'HOME': '/home/cltbld', 06:00:35 INFO - 'LANG': 'en_US.UTF-8', 06:00:35 INFO - 'LANGUAGE': 'en_US:en', 06:00:35 INFO - 'LOGNAME': 'cltbld', 06:00:35 INFO - 'MAIL': '/var/mail/cltbld', 06:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:35 INFO - 'MOZ_NO_REMOTE': '1', 06:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:35 INFO - 'NO_EM_RESTART': '1', 06:00:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:35 INFO - 'PWD': '/builds/slave/test', 06:00:35 INFO - 'SHELL': '/bin/bash', 06:00:35 INFO - 'SHLVL': '1', 06:00:35 INFO - 'TERM': 'linux', 06:00:35 INFO - 'TMOUT': '86400', 06:00:35 INFO - 'USER': 'cltbld', 06:00:35 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', 06:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:35 INFO - '_': '/tools/buildbot/bin/python'} 06:00:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:35 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)) 06:00:35 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)) 06:00:35 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)) 06:00:35 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)) 06:00:35 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)) 06:00:35 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)) 06:00:35 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)) 06:00:35 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)) 06:00:35 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)) 06:00:35 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)) 06:00:35 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)) 06:00:35 INFO - Cleaning up... 06:00:35 INFO - Return code: 0 06:00:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba8e297f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15fbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f8f60>, '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 0x15f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fa1d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', '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 06:00:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:00:35 INFO - Using env: {'DISPLAY': ':0', 06:00:35 INFO - 'HOME': '/home/cltbld', 06:00:35 INFO - 'LANG': 'en_US.UTF-8', 06:00:35 INFO - 'LANGUAGE': 'en_US:en', 06:00:35 INFO - 'LOGNAME': 'cltbld', 06:00:35 INFO - 'MAIL': '/var/mail/cltbld', 06:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:35 INFO - 'MOZ_NO_REMOTE': '1', 06:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:35 INFO - 'NO_EM_RESTART': '1', 06:00:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:35 INFO - 'PWD': '/builds/slave/test', 06:00:35 INFO - 'SHELL': '/bin/bash', 06:00:35 INFO - 'SHLVL': '1', 06:00:35 INFO - 'TERM': 'linux', 06:00:35 INFO - 'TMOUT': '86400', 06:00:35 INFO - 'USER': 'cltbld', 06:00:35 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', 06:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:35 INFO - '_': '/tools/buildbot/bin/python'} 06:00:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:00:35 INFO - Cleaning up... 06:00:35 INFO - Return code: 0 06:00:35 INFO - Running post-action listener: _resource_record_post_action 06:00:35 INFO - Running post-action listener: _start_resource_monitoring 06:00:36 INFO - Starting resource monitoring. 06:00:36 INFO - [mozharness: 2016-11-16 14:00:36.015482Z] Finished create-virtualenv step (success) 06:00:36 INFO - [mozharness: 2016-11-16 14:00:36.015988Z] Running install step. 06:00:36 INFO - Running pre-action listener: _resource_record_pre_action 06:00:36 INFO - Running main action method: install 06:00:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:00:36 INFO - Reading from file tmpfile_stdout 06:00:36 INFO - Detecting whether we're running mozinstall >=1.0... 06:00:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:00:36 INFO - Reading from file tmpfile_stdout 06:00:36 INFO - Output received: 06:00:36 INFO - Usage: mozinstall [options] installer 06:00:36 INFO - Options: 06:00:36 INFO - -h, --help show this help message and exit 06:00:36 INFO - -d DEST, --destination=DEST 06:00:36 INFO - Directory to install application into. [default: 06:00:36 INFO - "/builds/slave/test"] 06:00:36 INFO - --app=APP Application being installed. [default: firefox] 06:00:36 INFO - mkdir: /builds/slave/test/build/application 06:00:36 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'] 06:00:36 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 06:00:52 INFO - Reading from file tmpfile_stdout 06:00:52 INFO - Output received: 06:00:52 INFO - /builds/slave/test/build/application/firefox/firefox 06:00:52 INFO - Running post-action listener: _resource_record_post_action 06:00:52 INFO - [mozharness: 2016-11-16 14:00:52.221153Z] Finished install step (success) 06:00:52 INFO - [mozharness: 2016-11-16 14:00:52.221398Z] Running run-tests step. 06:00:52 INFO - Running pre-action listener: _resource_record_pre_action 06:00:52 INFO - Running main action method: run_tests 06:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:00:52 INFO - Python 2.7.3 06:00:52 INFO - Return code: 0 06:00:52 INFO - grabbing minidump binary from tooltool 06:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:00:52 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 0x15f8f60>, '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 0x15f9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15fa1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:00:52 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 06:00:52 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 06:00:52 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 06:00:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:00:52 INFO - Return code: 0 06:00:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:00:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:00:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:00:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:00:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:00:52 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/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 06:00:52 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/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 06:00:52 INFO - Using env: {'DISPLAY': ':0', 06:00:52 INFO - 'HOME': '/home/cltbld', 06:00:52 INFO - 'LANG': 'en_US.UTF-8', 06:00:52 INFO - 'LANGUAGE': 'en_US:en', 06:00:52 INFO - 'LOGNAME': 'cltbld', 06:00:52 INFO - 'MAIL': '/var/mail/cltbld', 06:00:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:00:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:52 INFO - 'MOZ_NO_REMOTE': '1', 06:00:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:52 INFO - 'NO_EM_RESTART': '1', 06:00:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:52 INFO - 'PWD': '/builds/slave/test', 06:00:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:00:52 INFO - 'SHELL': '/bin/bash', 06:00:52 INFO - 'SHLVL': '1', 06:00:52 INFO - 'TERM': 'linux', 06:00:52 INFO - 'TMOUT': '86400', 06:00:52 INFO - 'USER': 'cltbld', 06:00:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785', 06:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:52 INFO - '_': '/tools/buildbot/bin/python'} 06:00:52 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/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 06:00:52 INFO - mozversion application_buildid: 20161116031933 06:00:52 INFO - mozversion application_changeset: 3d28fa9f98e1eafc400662d32823cc3594627496 06:00:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:00:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:00:52 INFO - mozversion application_name: Firefox 06:00:52 INFO - mozversion application_remotingname: firefox-dev 06:00:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:00:52 INFO - mozversion application_vendor: Mozilla 06:00:52 INFO - mozversion application_version: 52.0a2 06:00:52 INFO - mozversion platform_buildid: 20161116031933 06:00:52 INFO - mozversion platform_changeset: 3d28fa9f98e1eafc400662d32823cc3594627496 06:00:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:00:52 INFO - mozversion platform_version: 52.0a2 06:00:52 INFO - using testdate: 1479304852 06:00:52 INFO - actual date: 1479304852 06:00:52 INFO - starting webserver on 'localhost:48468' 06:00:52 INFO - SUITE-START | Running 2 tests 06:00:52 INFO - TEST-START | dromaeo_css 06:00:52 INFO - operating with platform_type : linux_ 06:00:52 INFO - Initialising browser for dromaeo_css test... 06:00:52 INFO - TEST-INFO | started process 5160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGDh279/profile http://localhost:48468/getInfo.html) 06:00:55 ERROR - PROCESS | 5160 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 06:00:56 INFO - PROCESS | 5160 | __metrics Screen width/height:1600/1200 06:00:56 INFO - PROCESS | 5160 | colorDepth:24 06:00:56 INFO - PROCESS | 5160 | Browser inner width/height: 1024/697 06:00:56 INFO - PROCESS | 5160 | __metrics 06:00:57 INFO - PROCESS | 5160 | 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" 06:00:57 INFO - PROCESS | 5160 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:00:57 INFO - PROCESS | 5160 | console.error: PushService: 06:00:57 INFO - PROCESS | 5160 | stateChangeProcessEnqueue: Error transitioning state 06:00:57 INFO - PROCESS | 5160 | UnknownError 06:00:58 INFO - TEST-INFO | 5160: exit 0 06:00:58 INFO - Browser initialized. 06:00:58 INFO - Running cycle 1/1 for dromaeo_css test... 06:00:58 INFO - TEST-INFO | started process 5254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGDh279/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:10 INFO - PROCESS | 5254 | RSS: Main: 145039360 06:01:10 INFO - PROCESS | 5254 | 06:02:01 INFO - PROCESS | 5254 | 1479304921428 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] 06:04:11 INFO - PROCESS | 5254 | Cycle 1(1): loaded http://localhost:48468/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48468/tests/dromaeo/cssquery-ext.html) 06:04:12 INFO - PROCESS | 5254 | RSS: Main: 238837760 06:04:12 INFO - PROCESS | 5254 | 06:07:15 INFO - PROCESS | 5254 | Cycle 1(1): loaded http://localhost:48468/tests/dromaeo/cssquery-ext.html (next: http://localhost:48468/tests/dromaeo/cssquery-jquery.html) 06:07:15 INFO - PROCESS | 5254 | RSS: Main: 232906752 06:07:15 INFO - PROCESS | 5254 | 06:10:17 INFO - PROCESS | 5254 | Cycle 1(1): loaded http://localhost:48468/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48468/tests/dromaeo/cssquery-mootools.html) 06:10:18 INFO - PROCESS | 5254 | RSS: Main: 177606656 06:10:18 INFO - PROCESS | 5254 | 06:13:20 INFO - PROCESS | 5254 | Cycle 1(1): loaded http://localhost:48468/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48468/tests/dromaeo/cssquery-prototype.html) 06:13:20 INFO - PROCESS | 5254 | RSS: Main: 188473344 06:13:20 INFO - PROCESS | 5254 | 06:16:23 INFO - PROCESS | 5254 | Cycle 1(1): loaded http://localhost:48468/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48468/tests/dromaeo/cssquery-yui.html) 06:16:24 INFO - PROCESS | 5254 | RSS: Main: 176291840 06:16:24 INFO - PROCESS | 5254 | 06:19:26 INFO - PROCESS | 5254 | Cycle 1(1): loaded http://localhost:48468/tests/dromaeo/cssquery-yui.html (next: http://localhost:48468/tests/dromaeo/cssquery-dojo.html) 06:19:26 INFO - PROCESS | 5254 | RSS: Main: 257875968 06:19:26 INFO - PROCESS | 5254 | 06:19:26 INFO - PROCESS | 5254 | __start_tp_report 06:19:26 INFO - PROCESS | 5254 | _x_x_mozilla_page_load 06:19:26 INFO - PROCESS | 5254 | _x_x_mozilla_page_load_details 06:19:26 INFO - PROCESS | 5254 | |i|pagename|runs| 06:19:26 INFO - PROCESS | 5254 | |0;dojo.html;3166.572512710784;3198.9680103198966;3201.855916483758;3217.5817143771337;3236.8867089651867;5494.423085576017;5559.638623489471;5559.749811258493;5562.332520097594;5564.582656300773;5605.831825045255;5657.066584013633;5661.433856614337;5674.744636491358;5696.316442026962;5085.186370180762;5111.054454925832;5142.3829140503;5193.766280517386;5203.141481655542;5021.548060674539;5167.431582525919;5214.530692237698;5226.843194704146;5229.320188375525;4985.326980857574;5017.247412888059;5027.748612569375;5029.371328583927;5091.439941606421;5123.1546794778815;5153;5155.510226528492;5212.739363031833;5222.97388513055;5049.6212784041345;5128.051310507568;5172.2241663750365;5183.352080989876;5212.244224587452;5338.439463856278;5368.221607866876;5423.403425623178;5427.674339539641;5466.180072989084;5696.458836410535;5711.143328500717;5738.6556806591325;5793.478586927196;5803.071508558653;5863.355030946593;5867.501262392701;5875;5882.794102206445;5883.14694369314;5424.701641409761;5481.75332110056;5585.329760428734;5599.720013999284;5609.298837645294;6138.891802656385;6150.415710507495;6159.753609855646;6167.629942203482;6170.50635949123;5903.970480147572;5914.142449344907;5919.911201331984;5926.851828704231;5942.405759424109;5753.021986262345;5808.099744539603;5826.067829147316;5888.587798854039;6018;5905.055191169478;5910.408959104141;5919.378465261172;5945.583809133405;5956.55325850563;5864.8533786654825;5909.674967876722;5919.260092488439;5922.289325280908;5922.466977971917;4407.360932664746;4445.51099379068;4545.5908968193025;4565.726056436624;4582.358469814229;4090.3455447128317;4096.897577560525;4123.484564429446;4143.709940304149;4149.854755083618;5728.598998070095;5729.742161602738;5734.340550836707;5737.713114344266;5771.7114144293455;5758.3665796762325;5834.795782147605;6025.66858822769;6029.6683682397015;6046.546509011841;5601.187827764951;5611.6071874969175;5629.437056294338;5683.54531637468;5723.742431590588;5147.047796157723;5155.175171972466;5157.432682404932;5161.709572606848;5165.121929271958;5932.317783454958;6109.053096770008;6185;6200.224971878515;6213.471854892385;5844.211031510862;5899.823005309848;5900.586958912835;5949.0481522956115;6032.879342413039;6161.84595385119;6187.195664563578;6189.381061893775;6198.442140207403;6202.255729312331;5889.411058894248;5902.1441890926435;5902.675352855634;5903.91144132847;5920.822375328747;5777.104548794943;5780.797672081457;5945.286565612154;5987.5808693391045;5996.4603185713495;5934.080217566284;5935.0503919372695;5946.821595352147;5949.434803693643;5972.731227094704;5856.443637854397;5907.9704601476715;5912.290525137011;5915;5921.2006379138265;5674.659520428788;5683.5453163747625;5734.827955161351;5765.192872997867;5898.705064746659;5895.734691938959;5897.557683173865;5908.497777688945;5917.1715959766525;5921.7631294747725;5600.243967064394;5732.398098199796;5736.483716465538;5736.512396446182;5736.971315143398 06:19:26 INFO - PROCESS | 5254 | |1;ext.html;578.7482445136366;609.5215256024021;643.8197304754669;651.1404945471972;670.8289386206523;33742.32515349692;34551.82724086379;36350;36441.453378199345;36448.271034579324;36755;37404.81297593515;46696.299555506695;47745.04509909808;47836.52163478364;8826.691065812682;8977.910220897773;8982.966958799723;8988.865167022499;8989.820203595924;8911.15344042315;8997.05530919254;9009.549522523881;9015.098490150998;9015.14356136166;8397.28623067037;8598.78503037426;10625.415602141878;10870.239083264174;10884.727881802979;10735.946320268427;10787.137029037658;10812.513436895359;10818.459077046116;10824.621138260123;10788.5684572617;10839.620613278497;10844.945775271073;10847;10861.83707244392;43018.35472467916;43261.13477730428;43446.56553434457;43448.348274775904;43458.565414346085;3828.7894165820867;3885.572587015426;3949.98025009876;4052.4124002019544;4227.3447615619625;32741.836290818632;32743;32815.343693126;33180.668193318;33599.83200083984;4318.265894797861;4386.539413361583;4403.801828917706;4406.581374769392;4468.8882777930485;363238;364128;364566;364602;367138.1643091794;38132.809335953694;62812;63266.36733632697;63570;63573.68213158905;39553.80223098866;42306;42454;42472.78763606162;42500.36249456261;17015.659686806193;17197.57006074858;17208.31166753316;17220.483385498454;17232.741508877378;14355.282235888164;14446.422143114158;14447.711045779026;14454.060486068372;14454.638634034232;8938.776530586787;9185.862212066824;9599.722580005917;9618.374805637752;9676.806463870684;3489.4940233666484;3645.3073915955883;3672.5042119313553;3685.1339935115225;3698.260347930425;998.4259051045677;1061.8247989081715;1083.918706097046;1168.550108208329;1177.3583397048628;33997.830010849786;34025.65974340225;34518.30963380769;34598.82700586481;34815.65184348175;1146.2316762268922;1166.8249762535688;1177.4995626858722;1193.2721040165493;1255.598208573266;17846.28614855391;17924.386805187594;17967.64064718698;18007;18014.819851801578;560225;564464;565120;566079;567622;54704.45295547073;55451.44548554543;60091;63703;64231.67884160643;1414.7743145627778;1431.3415828718698;1450.52132796177;1459.5548357750777;1462.6928345047447;33035.339293214485;35043.29913401769;35215.295694085464;35266.47100293549;35482;56800;58386.708066459396;60297;60540;68459.65770171117;403691;405291;528285;535758;537417;44517;48326.5167348322;48364;48709.26936096032;49426;52961;53917.460825391245;57507.05969779539;57785.42214577801;57923;44537;44587.76416240452;45980.7700961493;46719.76640116914;47782.76108619435;45132;45297.77351113223;45809.541904580525;46291.3056304149;46859;45130.77434612937;45597.54402455933;46089;46123.76938115288;46456.53543464522;37772.62227377801;39238.80380598079;39276;39920.01399754973;40255.99360016023;29529.409411812074;29699.592161543304;29721.25696857596;30079;30318.545221822133 06:19:26 INFO - PROCESS | 5254 | |2;jquery.html;400.69146756997094;425.61056633180624;426.62030792594584;429.7593347725273;434.07758513159536;15197;19052.809471905293;20202.59594808103;20465.18139274427;20593;19583.216671333164;19825.504362390948;20293.49266268344;20447.693284600744;20491;5534.501894829465;5762.9135562966585;5765.913511297334;5766.509846663039;5771.22088518051;5464.316960379952;5741.397153298906;5778.42215778423;5781.219535362714;5791.160281759142;5605.27131472908;5739.253896993385;5746.942530574683;5752.712364381785;5764.452377024197;5639.464250896179;5695.658260504383;5697.401772813836;5703.201551782754;5729.914051289234;5105.081085404626;5142.7685754140775;5144.0740666679985;5145.4597267287145;5158.484151584849;23925.401864953514;24033.75966240333;24072.518549629083;24152.15467458648;24233.39416514601;2462.298245000184;2573.3566608347915;2780.3466185446405;2781.3602871339704;2907.651081870189;14296.356663950148;14362.784558231635;14682.265886705622;14888.478903238334;14983.700325993528;1925.4608709561346;1973.6940774180025;1997.6304383688919;2009.1260301768777;2026.9797302026939;87416.562917185;87891.56054219752;87937;87975;88944;10453.320534165256;11586.408213453687;11653.126015548867;11694.356810375511;11928.522859085713;15326.616834579001;15898.52304430869;16178.919105404397;16188.595285117966;16816.74774878378;8649;8683.305335573265;8866.77833054166;8873.467591944504;8918.598663060178;8329.792180133847;8356.33149348063;8388.11924747905;8523;8536.274416674529;4789.257665061921;4917.139500587455;4946.604271658259;4995.525425084611;5049.899002019939;2090.811826935583;2119.004068087996;2147.8281737460966;2150.4301360139575;2169.3600387885613;898.0615257056392;975.11264749078;1014.3102690170607;1054.8206804843196;1068.4871261794383;19474.707879381822;19693.606127877363;20394;20424.0809163588;20532;950.9144177024101;996.4952921089063;1013.1135256650431;1061.7557961668706;1076.4025965589017;10371.274010819321;11381.235908434206;11392.316461012366;11410.372429516456;11471.770564588662;483374;485181;485970;489274;489652;70243.64878175576;88873;90156.54921725349;90586.54706726556;91341;984.07988530724;988.4958671077659;993.7217579077869;1001.9348742331725;1015.8120747661707;17375.7393639093;17511.82488175102;17688.646227075646;18068.90965545164;18245.452636420927;44176.7791161055;44358.778206108764;44661;44874;45517;59975;60195.69902150461;60372.39627603843;61078;61560;8081.83836323282;8109.148539403278;8140.389470789596;8295.087540370676;8373.62318695648;10967.177461690246;11751.588694395656;12441.813372799234;12630.179038362478;12846.42191101384;10311.432871192157;10552.577896884346;10718;10798.730031748955;10864.239503234698;10605.628802991858;10675.145988321072;10767.89232107669;10835.783284334428;11017.944910275397;10383.792324153626;10532.578696852346;10713.89286107129;10924.781504369708;11201.831972520256;8268.297194738514;8289.709860154866;8315.916840831756;8365;8526.82946341082;10279.743006424898;10428.322159059637;10611.31026483276;10633.574657013633;10820.080293175168 06:19:26 INFO - PROCESS | 5254 | |3;mootools.html;1373.7595920713884;1505.759078547432;1531.5558488038469;1689.3918189451795;1857.6749068912936;7300.050993370861;8212.425130240885;8500.532470714108;8515.659373625056;8722.084181160966;8584.785380365494;8622.137786221374;8623.310135189186;8632.784180395478;8639.740807775761;2426.854388736677;2451.595486744685;2455.791257743094;2457.410221546834;2458.299384675368;2389.7593002122785;2456.520978409211;2471.4192164841247;2474.923408317388;2475.517274131545;2444.5721998650256;2453.521563295158;2461.6430617560445;2468.0374653885;2471.6910386201725;2327.8719670418122;2375.477394973103;2392.808575313971;2394.700662417207;2408.0969636386353;2299.9425014374774;2382.8927698253447;2403.0267741564694;2404.6513255577843;2405.542946840095;7326.41388688909;7575.356094731955;8385.329173666152;8448.112948140419;8469.74590762278;5102.336696229503;5288.973555132238;5290.55030322423;5410.621256512046;5431.185322201662;3249.2689144942437;3286.1948822538393;3352.430086885235;3353.0443823510427;3373.713234375081;1011.1354791653105;1011.3375738890965;1012.8227560176939;1042.1298215989657;1052.8103243335058;11834.585789497412;11903.940480297542;12011.159218854684;12017.218880772809;12043.458044388024;4457.3091170868565;4730.455997560256;4766.451858036301;4827.058723548945;4833.951660483421;9836.852447213298;9845.163161131384;9849.359791613522;9852.35959662634;9856;5391.838244852661;5394.703291319015;5395.73021348931;5399.730013499309;5403.243545903577;4776.880577985508;4856.41722993236;4885.267209918541;4984.8753781155765;4985.775640096204;3944.9408258876138;3996.2407142643387;4040.9595904040584;4059.939100913489;4087.9386809197886;1259.9496020159274;1273.0833799664226;1288.884000439965;1291.031726205346;1297.7015286484161;881.9779505512286;901.5717534171347;965.9323847330619;989.4360214677708;1018.3889666200369;5743.511801496919;5790.971045144832;5917.792877249276;5925.940740592625;5969.955257829863;909.5361365703538;956.0821611253136;968.6173961285393;969.14230905649;999.6401295533602;3976.2842688315804;4160.396742472324;4181.519125300569;4217.599328063829;4218.451601291812;9155;9516.857247141299;9745;10107.09036186732;10343.94828025855;10343.844842327371;10352.844707329396;10355.585776568852;10356.482175891175;10403.167746580255;6884.759033433806;7100.147982242164;7853.607319633996;8067.515949043076;8163.632636531371;5972.163897054329;6076.240469941257;6092.055731361646;6169.9691501544;6269.310375858743;9856.063673950963;10073.395596264247;10111.3427627204;10131.544080516247;10138.898611013796;9821.36161149523;9945.602175912882;10003.549840257352;10049.196064314983;10066.144377727975;6858.245592984668;6926.792196234121;6959.860802784017;6981.3367730065565;6982.581045137308;7702.845943080995;7740.26467485588;7857.2928436441;8235.423520353517;8237.83524329522;7206.495545311778;7311.305425984523;7374.557526548424;7394.704211831467;7498.137714162723;7154.320339567733;7245.927540724525;7246.239144889922;7261.818454538678;7351.926480735124;6839.179298484214;6839.350261725128;6876.656167191721;6891.138607674041;6938.826529336807;4902.068606964665;4909.852704418873;4956.405231372259;4999.275105109811;5019.548240658358;4712.081144176853;4789.544993225638;4851.684640498356;4853.174960256835;4899.681520701143 06:19:26 INFO - PROCESS | 5254 | |4;prototype.html;344.9034270404286;347.15814150684594;347.572485842414;351.48163409173264;352.58395093789335;5265.684058956465;5395.568354531638;5450.31871016123;5508.641938274014;5543.805966791163;5194.013137503881;5291.841244762653;5306;5313.760880760366;5376;4207.85272515462;4242.830286788525;4248.638865696419;4265.744055356673;4277.4011638370575;4132.97933510332;4237.6186143247105;4255.89346769839;4262.509811371686;4268.658507319407;4211.199872024321;4216.57834216579;4220.810063547147;4226.809793559281;4240.257954857903;4204.66362690984;4223.260929337353;4223.493180818291;4223.894402639928;4257.233697934371;3773.811309434545;3774.584795672474;3778.735488515805;3783.148791521913;3797.1076796952693;4994.375703037121;5221.6083793715625;5231.895362092775;5246.449122842085;5254.8160814371695;4800.903981920342;4827.806887724487;4830.975845120752;4832.444268909086;4836.467988521295;5400.892816972511;5665.348484924245;5681.119426488859;5684.971575142139;5692.345380281279;4087.652549533293;4096.9795151024355;4113.1568028554075;4115.8971025724595;4119;5862.50168735658;5884.941150588482;5891.882162356729;5893.116032595102;5898.705064746746;4014.1570270243574;4173.770442625624;4175.603317684815;4181.958180418218;4183;4153.501579810381;4164.6251837334785;4177.266434429677;4204.4324016257415;4208.726432781859;4753.287006948985;4761.6904901181315;4794.4486384065585;4803.886290032375;4804;5544.528715059265;5642.633228840113;5648.71756412186;5656.660600363909;5659.179418984224;1412.2867951684334;1413.4982081360968;1419.9918058178603;1420.1975883625719;1424.9928750356182;967.3228739882111;976.4727047394327;983.5279066048337;993.2004736187295;999.9100080992746;5273.973630131824;5297.907326606046;5303.310569625924;5304;5313.256144139824;5573.359063707726;5579.553635709133;5583.464547249458;5607.635503692247;5610.49505544503;5067.771950262247;5267.209918512177;5311.601629877775;5340.465953404629;5363.812266570651;2942.264433891527;2944.823310601371;2958.4911695035685;2967.9406411872073;2987.581738556604;5745.827625171251;5769;5781.843631273762;5802.448767367094;5835.737391817378;5416.9729151353995;5661.2923384576925;5665.688387138664;5684.8863022739315;5726.4252330609415;5836.548649567192;5857.690404921206;5864.941350586525;5877.9999999999145;5878.735456904364;5482.533984611353;5511.807086751945;5644.294463192101;5751.137329400456;5792.333881603669;5783.595148339576;5792.420757924174;5795.159701843293;5826.563007774349;5838.708064596838;6050.273967123797;6065.969670151798;6085.786997455068;6093.542984276286;6097.664628445478;3884.533855937306;4003.839846406111;4026.4765580475523;4063.1264278180333;4172.290710579269;5769.68266745333;5773.74018169175;5777.2200752897825;5783.681897495678;5790.305163380422;5641.294838145232;5666.356756540722;5670.744816483186;5674.631148975303;5682.516986056232;5493.642913210629;5619.297587801525;5644.266245388238;5662.405447428126;5676.829695108988;5625.774969001194;5641.8589535261945;5644.266245388073;5645.379008309001;5652.236948012131;5490.396056433709;5626.887462250814;5666.829995100154;5684.801031964027;5684.914726279027;5477.945220547744;5508.44915508446;5529.944700553104;5541.750621222135;5549.639273447213 06:19:26 INFO - PROCESS | 5254 | |5;yui.html;756.4175584799701;761.6191904047972;792.43341011177;793.3771988988644;809.0534075132094;14560.344784484698;15111.697766044672;15681.059136451806;15691.764623530657;15874.920625396857;14321.856781432183;14347.354369053392;14433.13401195929;14444.855551444509;14450.855491445081;840.4033136473112;855.1234984141258;863.2274114667368;864.7016779211193;865.5499140446964;846.0608724316004;861.7242482405633;863.3007264116055;864.4035615425337;864.7276108025983;909.0545832334365;909.6315992023241;910.5310764956052;911.1207684584375;911.4759013567225;903.0247332880473;904.7150147703452;905.5064989580694;906.4923642760042;908.7682640926588;662.4369286106819;664.9800505984829;665.6571865489277;666.2837449741498;666.796627028756;14695.92652036733;14904.403823847033;15661.216939153112;15796.368145274175;15800.367985280574;14390.352434140488;14835.545844121545;14886.553403397807;15121.319540620589;15212.239388030554;11474.254173478781;11739.530418783239;12085.697857553543;12301;12313.938430307791;3807.752496087773;3843.3658446356317;3844.1735026969336;3879.72841901067;3902.902427439308;56329.155062673686;68188.6590567049;68437.65781171112;69653.30346696518;69911.30088699098;10646.254762166574;11228.214025018333;11259.437028148559;11421.371824549564;11429.828552571718;18505.35231266899;18614.255429782657;18749.81250187508;18981.43055708331;18984.810151898582;8132.634031468599;8219.753407397788;8373.95813020931;8406.831863362699;8506.404551681322;4675.719456832601;4694.577488026094;4759.16714574948;4784.282357646381;4846.321514987904;3590.551181102362;3694.07648087978;3702.796346200931;3704.7036237100965;3707.888763337104;622.3061286665336;622.7758007117434;628.6479571440008;629.2543336146681;640.9839754006094;668.2448832818884;672.653583404547;677.502036003537;683.8461346197066;693.4972145194795;9006.954965225263;9215.723528294162;9348.392354496937;9456.8581471278;9709.6601618943;602.5450784657555;633.3856159525253;661.5303134774268;720.8666396716624;722.7578761115085;4253.298205796009;4379.64962802975;4393.538678438782;4412.646988240933;4555.2711566149255;69273.65363173252;72680.27319726735;74724.62637686777;76441;88333.55833220793;50102;67025.66487167533;67730;69397;74549;64048;72374.99999999895;72622.63688681523;74642;78216.60891695505;9360.531973401166;9955.352902061342;10078.94960525222;10151.086402223835;10164.085232329126;48101.51898480971;48876.75561622169;49045.50954490552;49163.508364917325;50149.49850501448;60087;67110;69166;69213.30786692069;69514.30485695078;12299.69250768738;12627;12663.810042849549;12908.290044047668;12983.610491685264;13009.804852927404;13051;13199;13301.66745831362;13525.729485410433;11648.068154547786;11742.412879356169;11832.645020649394;11912.40437978115;12057;11603.477843496894;11916.285022898654;12285;12287.631371058882;12502.43739031764;12801.359932003548;12850.55023074188;12853.93573032129;12877.8068328977;12998.350082496027;10941.617043403443;10967.341959482457;11163.665090047312;11469.662384937888;11518.53925842957;10891.18316126278;11052.613158539412;11134.665960021212;11242.437878105899;11285.661430157108 06:19:26 INFO - PROCESS | 5254 | __end_tp_report 06:19:26 INFO - PROCESS | 5254 | __start_cc_report 06:19:26 INFO - PROCESS | 5254 | _x_x_mozilla_cycle_collect,990 06:19:26 INFO - PROCESS | 5254 | __end_cc_report 06:19:26 INFO - PROCESS | 5254 | __startTimestamp1479305966897__endTimestamp 06:19:26 INFO - PROCESS | 5254 | 06:19:26 INFO - PROCESS | 5254 | ------- Summary: start ------- 06:19:26 INFO - PROCESS | 5254 | Number of tests: 6 06:19:26 INFO - PROCESS | 5254 | 06:19:26 INFO - PROCESS | 5254 | [#0] dojo.html Cycles:165 Average:5539.44 Median:5736.97 stddev:619.80 (10.8%) stddev-sans-first:593.09 06:19:26 INFO - PROCESS | 5254 | Values: 3166.6 3199.0 3201.9 3217.6 3236.9 5494.4 5559.6 5559.7 5562.3 5564.6 5605.8 5657.1 5661.4 5674.7 5696.3 5085.2 5111.1 5142.4 5193.8 5203.1 5021.5 5167.4 5214.5 5226.8 5229.3 4985.3 5017.2 5027.7 5029.4 5091.4 5123.2 5153.0 5155.5 5212.7 5223.0 5049.6 5128.1 5172.2 5183.4 5212.2 5338.4 5368.2 5423.4 5427.7 5466.2 5696.5 5711.1 5738.7 5793.5 5803.1 5863.4 5867.5 5875.0 5882.8 5883.1 5424.7 5481.8 5585.3 5599.7 5609.3 6138.9 6150.4 6159.8 6167.6 6170.5 5904.0 5914.1 5919.9 5926.9 5942.4 5753.0 5808.1 5826.1 5888.6 6018.0 5905.1 5910.4 5919.4 5945.6 5956.6 5864.9 5909.7 5919.3 5922.3 5922.5 4407.4 4445.5 4545.6 4565.7 4582.4 4090.3 4096.9 4123.5 4143.7 4149.9 5728.6 5729.7 5734.3 5737.7 5771.7 5758.4 5834.8 6025.7 6029.7 6046.5 5601.2 5611.6 5629.4 5683.5 5723.7 5147.0 5155.2 5157.4 5161.7 5165.1 5932.3 6109.1 6185.0 6200.2 6213.5 5844.2 5899.8 5900.6 5949.0 6032.9 6161.8 6187.2 6189.4 6198.4 6202.3 5889.4 5902.1 5902.7 5903.9 5920.8 5777.1 5780.8 5945.3 5987.6 5996.5 5934.1 5935.1 5946.8 5949.4 5972.7 5856.4 5908.0 5912.3 5915.0 5921.2 5674.7 5683.5 5734.8 5765.2 5898.7 5895.7 5897.6 5908.5 5917.2 5921.8 5600.2 5732.4 5736.5 5736.5 5737.0 06:19:26 INFO - PROCESS | 5254 | 06:19:26 INFO - PROCESS | 5254 | [#1] ext.html Cycles:180 Average:63668.02 Median:204671.71 stddev:127191.21 (62.1%) stddev-sans-first:127459.81 06:19:26 INFO - PROCESS | 5254 | Values: 578.7 609.5 643.8 651.1 670.8 33742.3 34551.8 36350.0 36441.5 36448.3 36755.0 37404.8 46696.3 47745.0 47836.5 8826.7 8977.9 8983.0 8988.9 8989.8 8911.2 8997.1 9009.5 9015.1 9015.1 8397.3 8598.8 10625.4 10870.2 10884.7 10735.9 10787.1 10812.5 10818.5 10824.6 10788.6 10839.6 10844.9 10847.0 10861.8 43018.4 43261.1 43446.6 43448.3 43458.6 3828.8 3885.6 3950.0 4052.4 4227.3 32741.8 32743.0 32815.3 33180.7 33599.8 4318.3 4386.5 4403.8 4406.6 4468.9 363238.0 364128.0 364566.0 364602.0 367138.2 38132.8 62812.0 63266.4 63570.0 63573.7 39553.8 42306.0 42454.0 42472.8 42500.4 17015.7 17197.6 17208.3 17220.5 17232.7 14355.3 14446.4 14447.7 14454.1 14454.6 8938.8 9185.9 9599.7 9618.4 9676.8 3489.5 3645.3 3672.5 3685.1 3698.3 998.4 1061.8 1083.9 1168.6 1177.4 33997.8 34025.7 34518.3 34598.8 34815.7 1146.2 1166.8 1177.5 1193.3 1255.6 17846.3 17924.4 17967.6 18007.0 18014.8 560225.0 564464.0 565120.0 566079.0 567622.0 54704.5 55451.4 60091.0 63703.0 64231.7 1414.8 1431.3 1450.5 1459.6 1462.7 33035.3 35043.3 35215.3 35266.5 35482.0 56800.0 58386.7 60297.0 60540.0 68459.7 403691.0 405291.0 528285.0 535758.0 537417.0 44517.0 48326.5 48364.0 48709.3 49426.0 52961.0 53917.5 57507.1 57785.4 57923.0 44537.0 44587.8 45980.8 46719.8 47782.8 45132.0 45297.8 45809.5 46291.3 46859.0 45130.8 45597.5 46089.0 46123.8 46456.5 37772.6 39238.8 39276.0 39920.0 40256.0 29529.4 29699.6 29721.3 30079.0 30318.5 06:19:26 INFO - PROCESS | 5254 | 06:19:26 INFO - PROCESS | 5254 | [#2] jquery.html Cycles:180 Average:29242.69 Median:2780.85 stddev:80312.43 (2888.0%) stddev-sans-first:80508.53 06:19:26 INFO - PROCESS | 5254 | Values: 400.7 425.6 426.6 429.8 434.1 15197.0 19052.8 20202.6 20465.2 20593.0 19583.2 19825.5 20293.5 20447.7 20491.0 5534.5 5762.9 5765.9 5766.5 5771.2 5464.3 5741.4 5778.4 5781.2 5791.2 5605.3 5739.3 5746.9 5752.7 5764.5 5639.5 5695.7 5697.4 5703.2 5729.9 5105.1 5142.8 5144.1 5145.5 5158.5 23925.4 24033.8 24072.5 24152.2 24233.4 2462.3 2573.4 2780.3 2781.4 2907.7 14296.4 14362.8 14682.3 14888.5 14983.7 1925.5 1973.7 1997.6 2009.1 2027.0 87416.6 87891.6 87937.0 87975.0 88944.0 10453.3 11586.4 11653.1 11694.4 11928.5 15326.6 15898.5 16178.9 16188.6 16816.7 8649.0 8683.3 8866.8 8873.5 8918.6 8329.8 8356.3 8388.1 8523.0 8536.3 4789.3 4917.1 4946.6 4995.5 5049.9 2090.8 2119.0 2147.8 2150.4 2169.4 898.1 975.1 1014.3 1054.8 1068.5 19474.7 19693.6 20394.0 20424.1 20532.0 950.9 996.5 1013.1 1061.8 1076.4 10371.3 11381.2 11392.3 11410.4 11471.8 483374.0 485181.0 485970.0 489274.0 489652.0 70243.6 88873.0 90156.5 90586.5 91341.0 984.1 988.5 993.7 1001.9 1015.8 17375.7 17511.8 17688.6 18068.9 18245.5 44176.8 44358.8 44661.0 44874.0 45517.0 59975.0 60195.7 60372.4 61078.0 61560.0 8081.8 8109.1 8140.4 8295.1 8373.6 10967.2 11751.6 12441.8 12630.2 12846.4 10311.4 10552.6 10718.0 10798.7 10864.2 10605.6 10675.1 10767.9 10835.8 11017.9 10383.8 10532.6 10713.9 10924.8 11201.8 8268.3 8289.7 8315.9 8365.0 8526.8 10279.7 10428.3 10611.3 10633.6 10820.1 06:19:26 INFO - PROCESS | 5254 | 06:19:26 INFO - PROCESS | 5254 | [#3] mootools.html Cycles:180 Average:5622.63 Median:4970.64 stddev:3088.45 (62.1%) stddev-sans-first:3080.60 06:19:26 INFO - PROCESS | 5254 | Values: 1373.8 1505.8 1531.6 1689.4 1857.7 7300.1 8212.4 8500.5 8515.7 8722.1 8584.8 8622.1 8623.3 8632.8 8639.7 2426.9 2451.6 2455.8 2457.4 2458.3 2389.8 2456.5 2471.4 2474.9 2475.5 2444.6 2453.5 2461.6 2468.0 2471.7 2327.9 2375.5 2392.8 2394.7 2408.1 2299.9 2382.9 2403.0 2404.7 2405.5 7326.4 7575.4 8385.3 8448.1 8469.7 5102.3 5289.0 5290.6 5410.6 5431.2 3249.3 3286.2 3352.4 3353.0 3373.7 1011.1 1011.3 1012.8 1042.1 1052.8 11834.6 11903.9 12011.2 12017.2 12043.5 4457.3 4730.5 4766.5 4827.1 4834.0 9836.9 9845.2 9849.4 9852.4 9856.0 5391.8 5394.7 5395.7 5399.7 5403.2 4776.9 4856.4 4885.3 4984.9 4985.8 3944.9 3996.2 4041.0 4059.9 4087.9 1259.9 1273.1 1288.9 1291.0 1297.7 882.0 901.6 965.9 989.4 1018.4 5743.5 5791.0 5917.8 5925.9 5970.0 909.5 956.1 968.6 969.1 999.6 3976.3 4160.4 4181.5 4217.6 4218.5 9155.0 9516.9 9745.0 10107.1 10343.9 10343.8 10352.8 10355.6 10356.5 10403.2 6884.8 7100.1 7853.6 8067.5 8163.6 5972.2 6076.2 6092.1 6170.0 6269.3 9856.1 10073.4 10111.3 10131.5 10138.9 9821.4 9945.6 10003.5 10049.2 10066.1 6858.2 6926.8 6959.9 6981.3 6982.6 7702.8 7740.3 7857.3 8235.4 8237.8 7206.5 7311.3 7374.6 7394.7 7498.1 7154.3 7245.9 7246.2 7261.8 7351.9 6839.2 6839.4 6876.7 6891.1 6938.8 4902.1 4909.9 4956.4 4999.3 5019.5 4712.1 4789.5 4851.7 4853.2 4899.7 06:19:26 INFO - PROCESS | 5254 | 06:19:26 INFO - PROCESS | 5254 | [#4] prototype.html Cycles:180 Average:4732.74 Median:5385.78 stddev:1380.64 (25.6%) stddev-sans-first:1344.66 06:19:26 INFO - PROCESS | 5254 | Values: 344.9 347.2 347.6 351.5 352.6 5265.7 5395.6 5450.3 5508.6 5543.8 5194.0 5291.8 5306.0 5313.8 5376.0 4207.9 4242.8 4248.6 4265.7 4277.4 4133.0 4237.6 4255.9 4262.5 4268.7 4211.2 4216.6 4220.8 4226.8 4240.3 4204.7 4223.3 4223.5 4223.9 4257.2 3773.8 3774.6 3778.7 3783.1 3797.1 4994.4 5221.6 5231.9 5246.4 5254.8 4800.9 4827.8 4831.0 4832.4 4836.5 5400.9 5665.3 5681.1 5685.0 5692.3 4087.7 4097.0 4113.2 4115.9 4119.0 5862.5 5884.9 5891.9 5893.1 5898.7 4014.2 4173.8 4175.6 4182.0 4183.0 4153.5 4164.6 4177.3 4204.4 4208.7 4753.3 4761.7 4794.4 4803.9 4804.0 5544.5 5642.6 5648.7 5656.7 5659.2 1412.3 1413.5 1420.0 1420.2 1425.0 967.3 976.5 983.5 993.2 999.9 5274.0 5297.9 5303.3 5304.0 5313.3 5573.4 5579.6 5583.5 5607.6 5610.5 5067.8 5267.2 5311.6 5340.5 5363.8 2942.3 2944.8 2958.5 2967.9 2987.6 5745.8 5769.0 5781.8 5802.4 5835.7 5417.0 5661.3 5665.7 5684.9 5726.4 5836.5 5857.7 5864.9 5878.0 5878.7 5482.5 5511.8 5644.3 5751.1 5792.3 5783.6 5792.4 5795.2 5826.6 5838.7 6050.3 6066.0 6085.8 6093.5 6097.7 3884.5 4003.8 4026.5 4063.1 4172.3 5769.7 5773.7 5777.2 5783.7 5790.3 5641.3 5666.4 5670.7 5674.6 5682.5 5493.6 5619.3 5644.3 5662.4 5676.8 5625.8 5641.9 5644.3 5645.4 5652.2 5490.4 5626.9 5666.8 5684.8 5684.9 5477.9 5508.4 5529.9 5541.8 5549.6 06:19:26 INFO - PROCESS | 5254 | 06:19:26 INFO - PROCESS | 5254 | [#5] yui.html Cycles:180 Average:17648.78 Median:4771.72 stddev:22767.72 (477.1%) stddev-sans-first:22796.25 06:19:26 INFO - PROCESS | 5254 | Values: 756.4 761.6 792.4 793.4 809.1 14560.3 15111.7 15681.1 15691.8 15874.9 14321.9 14347.4 14433.1 14444.9 14450.9 840.4 855.1 863.2 864.7 865.5 846.1 861.7 863.3 864.4 864.7 909.1 909.6 910.5 911.1 911.5 903.0 904.7 905.5 906.5 908.8 662.4 665.0 665.7 666.3 666.8 14695.9 14904.4 15661.2 15796.4 15800.4 14390.4 14835.5 14886.6 15121.3 15212.2 11474.3 11739.5 12085.7 12301.0 12313.9 3807.8 3843.4 3844.2 3879.7 3902.9 56329.2 68188.7 68437.7 69653.3 69911.3 10646.3 11228.2 11259.4 11421.4 11429.8 18505.4 18614.3 18749.8 18981.4 18984.8 8132.6 8219.8 8374.0 8406.8 8506.4 4675.7 4694.6 4759.2 4784.3 4846.3 3590.6 3694.1 3702.8 3704.7 3707.9 622.3 622.8 628.6 629.3 641.0 668.2 672.7 677.5 683.8 693.5 9007.0 9215.7 9348.4 9456.9 9709.7 602.5 633.4 661.5 720.9 722.8 4253.3 4379.6 4393.5 4412.6 4555.3 69273.7 72680.3 74724.6 76441.0 88333.6 50102.0 67025.7 67730.0 69397.0 74549.0 64048.0 72375.0 72622.6 74642.0 78216.6 9360.5 9955.4 10078.9 10151.1 10164.1 48101.5 48876.8 49045.5 49163.5 50149.5 60087.0 67110.0 69166.0 69213.3 69514.3 12299.7 12627.0 12663.8 12908.3 12983.6 13009.8 13051.0 13199.0 13301.7 13525.7 11648.1 11742.4 11832.6 11912.4 12057.0 11603.5 11916.3 12285.0 12287.6 12502.4 12801.4 12850.6 12853.9 12877.8 12998.4 10941.6 10967.3 11163.7 11469.7 11518.5 10891.2 11052.6 11134.7 11242.4 11285.7 06:19:26 INFO - PROCESS | 5254 | -------- Summary: end -------- 06:19:26 INFO - PROCESS | 5254 | 06:19:27 INFO - TEST-INFO | 5254: exit 0 06:19:27 INFO - TEST-OK | dromaeo_css | took 1115141ms 06:19:27 INFO - TEST-START | kraken 06:19:27 INFO - operating with platform_type : linux_ 06:19:27 INFO - Initialising browser for kraken test... 06:19:27 INFO - TEST-INFO | started process 5573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps42zVM/profile http://localhost:48468/getInfo.html) 06:19:30 ERROR - PROCESS | 5573 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 06:19:31 INFO - PROCESS | 5573 | __metrics Screen width/height:1600/1200 06:19:31 INFO - PROCESS | 5573 | colorDepth:24 06:19:31 INFO - PROCESS | 5573 | Browser inner width/height: 1024/697 06:19:31 INFO - PROCESS | 5573 | __metrics 06:19:32 INFO - PROCESS | 5573 | 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" 06:19:32 INFO - PROCESS | 5573 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:19:32 INFO - PROCESS | 5573 | console.error: PushService: 06:19:32 INFO - PROCESS | 5573 | stateChangeProcessEnqueue: Error transitioning state 06:19:32 INFO - PROCESS | 5573 | UnknownError 06:19:33 INFO - TEST-INFO | 5573: exit 0 06:19:33 INFO - Browser initialized. 06:19:33 INFO - Running cycle 1/1 for kraken test... 06:19:33 INFO - TEST-INFO | started process 5665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps42zVM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:45 INFO - PROCESS | 5665 | RSS: Main: 144601088 06:19:45 INFO - PROCESS | 5665 | 06:19:47 INFO - PROCESS | 5665 | Cycle 1(1): loaded http://localhost:48468/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48468/tests/kraken/driver.html?testName=audio-beat-detection) 06:19:48 INFO - PROCESS | 5665 | RSS: Main: 185626624 06:19:48 INFO - PROCESS | 5665 | 06:19:51 INFO - PROCESS | 5665 | Cycle 1(1): loaded http://localhost:48468/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48468/tests/kraken/driver.html?testName=audio-dft) 06:19:51 INFO - PROCESS | 5665 | RSS: Main: 175845376 06:19:51 INFO - PROCESS | 5665 | 06:19:54 INFO - PROCESS | 5665 | Cycle 1(1): loaded http://localhost:48468/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48468/tests/kraken/driver.html?testName=audio-fft) 06:19:55 INFO - PROCESS | 5665 | RSS: Main: 266366976 06:19:55 INFO - PROCESS | 5665 | 06:19:57 INFO - PROCESS | 5665 | Cycle 1(1): loaded http://localhost:48468/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48468/tests/kraken/driver.html?testName=audio-oscillator) 06:19:57 INFO - PROCESS | 5665 | RSS: Main: 172806144 06:19:57 INFO - PROCESS | 5665 | 06:19:59 INFO - PROCESS | 5665 | Cycle 1(1): loaded http://localhost:48468/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48468/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:20:00 INFO - PROCESS | 5665 | RSS: Main: 175366144 06:20:00 INFO - PROCESS | 5665 | 06:20:03 INFO - PROCESS | 5665 | Cycle 1(1): loaded http://localhost:48468/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48468/tests/kraken/driver.html?testName=imaging-darkroom) 06:20:03 INFO - PROCESS | 5665 | RSS: Main: 214560768 06:20:03 INFO - PROCESS | 5665 | 06:20:07 INFO - PROCESS | 5665 | Cycle 1(1): loaded http://localhost:48468/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48468/tests/kraken/driver.html?testName=imaging-desaturate) 06:20:07 INFO - PROCESS | 5665 | RSS: Main: 213151744 06:20:07 INFO - PROCESS | 5665 | 06:20:10 INFO - PROCESS | 5665 | Cycle 1(1): loaded http://localhost:48468/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48468/tests/kraken/driver.html?testName=json-parse-financial) 06:20:10 INFO - PROCESS | 5665 | RSS: Main: 211861504 06:20:10 INFO - PROCESS | 5665 | 06:20:12 INFO - PROCESS | 5665 | Cycle 1(1): loaded http://localhost:48468/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48468/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:20:13 INFO - PROCESS | 5665 | RSS: Main: 173715456 06:20:13 INFO - PROCESS | 5665 | 06:20:14 INFO - PROCESS | 5665 | Cycle 1(1): loaded http://localhost:48468/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48468/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:20:15 INFO - PROCESS | 5665 | RSS: Main: 181194752 06:20:15 INFO - PROCESS | 5665 | 06:20:17 INFO - PROCESS | 5665 | Cycle 1(1): loaded http://localhost:48468/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48468/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:20:17 INFO - PROCESS | 5665 | RSS: Main: 190038016 06:20:17 INFO - PROCESS | 5665 | 06:20:20 INFO - PROCESS | 5665 | Cycle 1(1): loaded http://localhost:48468/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48468/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:20:21 INFO - PROCESS | 5665 | RSS: Main: 198627328 06:20:21 INFO - PROCESS | 5665 | 06:20:23 INFO - PROCESS | 5665 | Cycle 1(1): loaded http://localhost:48468/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48468/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:20:24 INFO - PROCESS | 5665 | RSS: Main: 195743744 06:20:24 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | Cycle 1(1): loaded http://localhost:48468/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48468/tests/kraken/driver.html?testName=ai-astar) 06:20:26 INFO - PROCESS | 5665 | RSS: Main: 246931456 06:20:26 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | __start_tp_report 06:20:26 INFO - PROCESS | 5665 | _x_x_mozilla_page_load 06:20:26 INFO - PROCESS | 5665 | _x_x_mozilla_page_load_details 06:20:26 INFO - PROCESS | 5665 | |i|pagename|runs| 06:20:26 INFO - PROCESS | 5665 | |0;ai-astar;99;112;111;111;111;110;111;111;110;111 06:20:26 INFO - PROCESS | 5665 | |1;audio-beat-detection;149;123;124;153;126;123;122;125;154;125 06:20:26 INFO - PROCESS | 5665 | |2;audio-dft;162;163;162;164;161;163;162;163;163;163 06:20:26 INFO - PROCESS | 5665 | |3;audio-fft;75;76;76;104;77;78;75;75;99;75 06:20:26 INFO - PROCESS | 5665 | |4;audio-oscillator;82;82;106;83;84;81;105;83;83;102 06:20:26 INFO - PROCESS | 5665 | |5;imaging-gaussian-blur;117;117;117;117;116;117;119;116;117;118 06:20:26 INFO - PROCESS | 5665 | |6;imaging-darkroom;146;146;147;146;145;146;146;147;146;146 06:20:26 INFO - PROCESS | 5665 | |7;imaging-desaturate;86;85;85;85;84;85;84;84;84;86 06:20:26 INFO - PROCESS | 5665 | |8;json-parse-financial;50;51;50;50;50;51;50;50;51;50 06:20:26 INFO - PROCESS | 5665 | |9;json-stringify-tinderbox;58;58;60;59;60;59;59;63;59;59 06:20:26 INFO - PROCESS | 5665 | |10;stanford-crypto-aes;77;80;75;76;76;79;75;74;74;75 06:20:26 INFO - PROCESS | 5665 | |11;stanford-crypto-ccm;140;129;136;124;123;133;142;132;171;125 06:20:26 INFO - PROCESS | 5665 | |12;stanford-crypto-pbkdf2;161;161;154;162;155;155;157;157;156;161 06:20:26 INFO - PROCESS | 5665 | |13;stanford-crypto-sha256-iterative;62;63;62;63;61;62;62;62;61;62 06:20:26 INFO - PROCESS | 5665 | __end_tp_report 06:20:26 INFO - PROCESS | 5665 | __start_cc_report 06:20:26 INFO - PROCESS | 5665 | _x_x_mozilla_cycle_collect,1641 06:20:26 INFO - PROCESS | 5665 | __end_cc_report 06:20:26 INFO - PROCESS | 5665 | __startTimestamp1479306026343__endTimestamp 06:20:26 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | ------- Summary: start ------- 06:20:26 INFO - PROCESS | 5665 | Number of tests: 14 06:20:26 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.80 (3.4%) stddev-sans-first:0.60 06:20:26 INFO - PROCESS | 5665 | Values: 99.0 112.0 111.0 111.0 111.0 110.0 111.0 111.0 110.0 111.0 06:20:26 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:125.50 stddev:13.63 (10.9%) stddev-sans-first:13.07 06:20:26 INFO - PROCESS | 5665 | Values: 149.0 123.0 124.0 153.0 126.0 123.0 122.0 125.0 154.0 125.0 06:20:26 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 06:20:26 INFO - PROCESS | 5665 | Values: 162.0 163.0 162.0 164.0 161.0 163.0 162.0 163.0 163.0 163.0 06:20:26 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:10.91 (14.4%) stddev-sans-first:11.36 06:20:26 INFO - PROCESS | 5665 | Values: 75.0 76.0 76.0 104.0 77.0 78.0 75.0 75.0 99.0 75.0 06:20:26 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:82.50 stddev:10.59 (12.8%) stddev-sans-first:10.91 06:20:26 INFO - PROCESS | 5665 | Values: 82.0 82.0 106.0 83.0 84.0 81.0 105.0 83.0 83.0 102.0 06:20:26 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 06:20:26 INFO - PROCESS | 5665 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 119.0 116.0 117.0 118.0 06:20:26 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 06:20:26 INFO - PROCESS | 5665 | Values: 146.0 146.0 147.0 146.0 145.0 146.0 146.0 147.0 146.0 146.0 06:20:26 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.79 (0.9%) stddev-sans-first:0.71 06:20:26 INFO - PROCESS | 5665 | Values: 86.0 85.0 85.0 85.0 84.0 85.0 84.0 84.0 84.0 86.0 06:20:26 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.00 stddev:0.48 (1.0%) stddev-sans-first:0.50 06:20:26 INFO - PROCESS | 5665 | Values: 50.0 51.0 50.0 50.0 50.0 51.0 50.0 50.0 51.0 50.0 06:20:26 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.00 stddev:1.43 (2.4%) stddev-sans-first:1.42 06:20:26 INFO - PROCESS | 5665 | Values: 58.0 58.0 60.0 59.0 60.0 59.0 59.0 63.0 59.0 59.0 06:20:26 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:76.00 stddev:2.02 (2.7%) stddev-sans-first:2.12 06:20:26 INFO - PROCESS | 5665 | Values: 77.0 80.0 75.0 76.0 76.0 79.0 75.0 74.0 74.0 75.0 06:20:26 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:134.50 stddev:14.07 (10.5%) stddev-sans-first:14.83 06:20:26 INFO - PROCESS | 5665 | Values: 140.0 129.0 136.0 124.0 123.0 133.0 142.0 132.0 171.0 125.0 06:20:26 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.90 Median:159.00 stddev:3.03 (1.9%) stddev-sans-first:3.00 06:20:26 INFO - PROCESS | 5665 | Values: 161.0 161.0 154.0 162.0 155.0 155.0 157.0 157.0 156.0 161.0 06:20:26 INFO - PROCESS | 5665 | 06:20:26 INFO - PROCESS | 5665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 06:20:26 INFO - PROCESS | 5665 | Values: 62.0 63.0 62.0 63.0 61.0 62.0 62.0 62.0 61.0 62.0 06:20:26 INFO - PROCESS | 5665 | -------- Summary: end -------- 06:20:26 INFO - PROCESS | 5665 | 06:20:27 INFO - TEST-INFO | 5665: exit 0 06:20:27 INFO - TEST-OK | kraken | took 59905ms 06:20:27 INFO - SUITE-END | took 1175s 06:20:28 INFO - Completed test suite (00:19:35) 06:20:28 INFO - javascript benchmark 06:20:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3166.572512710784, 3198.9680103198966, 3201.855916483758, 3217.5817143771337, 3236.8867089651867, 5494.423085576017, 5559.638623489471, 5559.749811258493, 5562.332520097594, 5564.582656300773, 5605.831825045255, 5657.066584013633, 5661.433856614337, 5674.744636491358, 5696.316442026962, 5085.186370180762, 5111.054454925832, 5142.3829140503, 5193.766280517386, 5203.141481655542, 5021.548060674539, 5167.431582525919, 5214.530692237698, 5226.843194704146, 5229.320188375525, 4985.326980857574, 5017.247412888059, 5027.748612569375, 5029.371328583927, 5091.439941606421, 5123.1546794778815, 5153.0, 5155.510226528492, 5212.739363031833, 5222.97388513055, 5049.6212784041345, 5128.051310507568, 5172.2241663750365, 5183.352080989876, 5212.244224587452, 5338.439463856278, 5368.221607866876, 5423.403425623178, 5427.674339539641, 5466.180072989084, 5696.458836410535, 5711.143328500717, 5738.6556806591325, 5793.478586927196, 5803.071508558653, 5863.355030946593, 5867.501262392701, 5875.0, 5882.794102206445, 5883.14694369314, 5424.701641409761, 5481.75332110056, 5585.329760428734, 5599.720013999284, 5609.298837645294, 6138.891802656385, 6150.415710507495, 6159.753609855646, 6167.629942203482, 6170.50635949123, 5903.970480147572, 5914.142449344907, 5919.911201331984, 5926.851828704231, 5942.405759424109, 5753.021986262345, 5808.099744539603, 5826.067829147316, 5888.587798854039, 6018.0, 5905.055191169478, 5910.408959104141, 5919.378465261172, 5945.583809133405, 5956.55325850563, 5864.8533786654825, 5909.674967876722, 5919.260092488439, 5922.289325280908, 5922.466977971917, 4407.360932664746, 4445.51099379068, 4545.5908968193025, 4565.726056436624, 4582.358469814229, 4090.3455447128317, 4096.897577560525, 4123.484564429446, 4143.709940304149, 4149.854755083618, 5728.598998070095, 5729.742161602738, 5734.340550836707, 5737.713114344266, 5771.7114144293455, 5758.3665796762325, 5834.795782147605, 6025.66858822769, 6029.6683682397015, 6046.546509011841, 5601.187827764951, 5611.6071874969175, 5629.437056294338, 5683.54531637468, 5723.742431590588, 5147.047796157723, 5155.175171972466, 5157.432682404932, 5161.709572606848, 5165.121929271958, 5932.317783454958, 6109.053096770008, 6185.0, 6200.224971878515, 6213.471854892385, 5844.211031510862, 5899.823005309848, 5900.586958912835, 5949.0481522956115, 6032.879342413039, 6161.84595385119, 6187.195664563578, 6189.381061893775, 6198.442140207403, 6202.255729312331, 5889.411058894248, 5902.1441890926435, 5902.675352855634, 5903.91144132847, 5920.822375328747, 5777.104548794943, 5780.797672081457, 5945.286565612154, 5987.5808693391045, 5996.4603185713495, 5934.080217566284, 5935.0503919372695, 5946.821595352147, 5949.434803693643, 5972.731227094704, 5856.443637854397, 5907.9704601476715, 5912.290525137011, 5915.0, 5921.2006379138265, 5674.659520428788, 5683.5453163747625, 5734.827955161351, 5765.192872997867, 5898.705064746659, 5895.734691938959, 5897.557683173865, 5908.497777688945, 5917.1715959766525, 5921.7631294747725, 5600.243967064394, 5732.398098199796, 5736.483716465538, 5736.512396446182, 5736.971315143398], "value": 5497.875358080728, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.7482445136366, 609.5215256024021, 643.8197304754669, 651.1404945471972, 670.8289386206523, 33742.32515349692, 34551.82724086379, 36350.0, 36441.453378199345, 36448.271034579324, 36755.0, 37404.81297593515, 46696.299555506695, 47745.04509909808, 47836.52163478364, 8826.691065812682, 8977.910220897773, 8982.966958799723, 8988.865167022499, 8989.820203595924, 8911.15344042315, 8997.05530919254, 9009.549522523881, 9015.098490150998, 9015.14356136166, 8397.28623067037, 8598.78503037426, 10625.415602141878, 10870.239083264174, 10884.727881802979, 10735.946320268427, 10787.137029037658, 10812.513436895359, 10818.459077046116, 10824.621138260123, 10788.5684572617, 10839.620613278497, 10844.945775271073, 10847.0, 10861.83707244392, 43018.35472467916, 43261.13477730428, 43446.56553434457, 43448.348274775904, 43458.565414346085, 3828.7894165820867, 3885.572587015426, 3949.98025009876, 4052.4124002019544, 4227.3447615619625, 32741.836290818632, 32743.0, 32815.343693126, 33180.668193318, 33599.83200083984, 4318.265894797861, 4386.539413361583, 4403.801828917706, 4406.581374769392, 4468.8882777930485, 363238.0, 364128.0, 364566.0, 364602.0, 367138.1643091794, 38132.809335953694, 62812.0, 63266.36733632697, 63570.0, 63573.68213158905, 39553.80223098866, 42306.0, 42454.0, 42472.78763606162, 42500.36249456261, 17015.659686806193, 17197.57006074858, 17208.31166753316, 17220.483385498454, 17232.741508877378, 14355.282235888164, 14446.422143114158, 14447.711045779026, 14454.060486068372, 14454.638634034232, 8938.776530586787, 9185.862212066824, 9599.722580005917, 9618.374805637752, 9676.806463870684, 3489.4940233666484, 3645.3073915955883, 3672.5042119313553, 3685.1339935115225, 3698.260347930425, 998.4259051045677, 1061.8247989081715, 1083.918706097046, 1168.550108208329, 1177.3583397048628, 33997.830010849786, 34025.65974340225, 34518.30963380769, 34598.82700586481, 34815.65184348175, 1146.2316762268922, 1166.8249762535688, 1177.4995626858722, 1193.2721040165493, 1255.598208573266, 17846.28614855391, 17924.386805187594, 17967.64064718698, 18007.0, 18014.819851801578, 560225.0, 564464.0, 565120.0, 566079.0, 567622.0, 54704.45295547073, 55451.44548554543, 60091.0, 63703.0, 64231.67884160643, 1414.7743145627778, 1431.3415828718698, 1450.52132796177, 1459.5548357750777, 1462.6928345047447, 33035.339293214485, 35043.29913401769, 35215.295694085464, 35266.47100293549, 35482.0, 56800.0, 58386.708066459396, 60297.0, 60540.0, 68459.65770171117, 403691.0, 405291.0, 528285.0, 535758.0, 537417.0, 44517.0, 48326.5167348322, 48364.0, 48709.26936096032, 49426.0, 52961.0, 53917.460825391245, 57507.05969779539, 57785.42214577801, 57923.0, 44537.0, 44587.76416240452, 45980.7700961493, 46719.76640116914, 47782.76108619435, 45132.0, 45297.77351113223, 45809.541904580525, 46291.3056304149, 46859.0, 45130.77434612937, 45597.54402455933, 46089.0, 46123.76938115288, 46456.53543464522, 37772.62227377801, 39238.80380598079, 39276.0, 39920.01399754973, 40255.99360016023, 29529.409411812074, 29699.592161543304, 29721.25696857596, 30079.0, 30318.545221822133], "value": 20626.383698506375, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.69146756997094, 425.61056633180624, 426.62030792594584, 429.7593347725273, 434.07758513159536, 15197.0, 19052.809471905293, 20202.59594808103, 20465.18139274427, 20593.0, 19583.216671333164, 19825.504362390948, 20293.49266268344, 20447.693284600744, 20491.0, 5534.501894829465, 5762.9135562966585, 5765.913511297334, 5766.509846663039, 5771.22088518051, 5464.316960379952, 5741.397153298906, 5778.42215778423, 5781.219535362714, 5791.160281759142, 5605.27131472908, 5739.253896993385, 5746.942530574683, 5752.712364381785, 5764.452377024197, 5639.464250896179, 5695.658260504383, 5697.401772813836, 5703.201551782754, 5729.914051289234, 5105.081085404626, 5142.7685754140775, 5144.0740666679985, 5145.4597267287145, 5158.484151584849, 23925.401864953514, 24033.75966240333, 24072.518549629083, 24152.15467458648, 24233.39416514601, 2462.298245000184, 2573.3566608347915, 2780.3466185446405, 2781.3602871339704, 2907.651081870189, 14296.356663950148, 14362.784558231635, 14682.265886705622, 14888.478903238334, 14983.700325993528, 1925.4608709561346, 1973.6940774180025, 1997.6304383688919, 2009.1260301768777, 2026.9797302026939, 87416.562917185, 87891.56054219752, 87937.0, 87975.0, 88944.0, 10453.320534165256, 11586.408213453687, 11653.126015548867, 11694.356810375511, 11928.522859085713, 15326.616834579001, 15898.52304430869, 16178.919105404397, 16188.595285117966, 16816.74774878378, 8649.0, 8683.305335573265, 8866.77833054166, 8873.467591944504, 8918.598663060178, 8329.792180133847, 8356.33149348063, 8388.11924747905, 8523.0, 8536.274416674529, 4789.257665061921, 4917.139500587455, 4946.604271658259, 4995.525425084611, 5049.899002019939, 2090.811826935583, 2119.004068087996, 2147.8281737460966, 2150.4301360139575, 2169.3600387885613, 898.0615257056392, 975.11264749078, 1014.3102690170607, 1054.8206804843196, 1068.4871261794383, 19474.707879381822, 19693.606127877363, 20394.0, 20424.0809163588, 20532.0, 950.9144177024101, 996.4952921089063, 1013.1135256650431, 1061.7557961668706, 1076.4025965589017, 10371.274010819321, 11381.235908434206, 11392.316461012366, 11410.372429516456, 11471.770564588662, 483374.0, 485181.0, 485970.0, 489274.0, 489652.0, 70243.64878175576, 88873.0, 90156.54921725349, 90586.54706726556, 91341.0, 984.07988530724, 988.4958671077659, 993.7217579077869, 1001.9348742331725, 1015.8120747661707, 17375.7393639093, 17511.82488175102, 17688.646227075646, 18068.90965545164, 18245.452636420927, 44176.7791161055, 44358.778206108764, 44661.0, 44874.0, 45517.0, 59975.0, 60195.69902150461, 60372.39627603843, 61078.0, 61560.0, 8081.83836323282, 8109.148539403278, 8140.389470789596, 8295.087540370676, 8373.62318695648, 10967.177461690246, 11751.588694395656, 12441.813372799234, 12630.179038362478, 12846.42191101384, 10311.432871192157, 10552.577896884346, 10718.0, 10798.730031748955, 10864.239503234698, 10605.628802991858, 10675.145988321072, 10767.89232107669, 10835.783284334428, 11017.944910275397, 10383.792324153626, 10532.578696852346, 10713.89286107129, 10924.781504369708, 11201.831972520256, 8268.297194738514, 8289.709860154866, 8315.916840831756, 8365.0, 8526.82946341082, 10279.743006424898, 10428.322159059637, 10611.31026483276, 10633.574657013633, 10820.080293175168], "value": 9400.529631994024, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.7595920713884, 1505.759078547432, 1531.5558488038469, 1689.3918189451795, 1857.6749068912936, 7300.050993370861, 8212.425130240885, 8500.532470714108, 8515.659373625056, 8722.084181160966, 8584.785380365494, 8622.137786221374, 8623.310135189186, 8632.784180395478, 8639.740807775761, 2426.854388736677, 2451.595486744685, 2455.791257743094, 2457.410221546834, 2458.299384675368, 2389.7593002122785, 2456.520978409211, 2471.4192164841247, 2474.923408317388, 2475.517274131545, 2444.5721998650256, 2453.521563295158, 2461.6430617560445, 2468.0374653885, 2471.6910386201725, 2327.8719670418122, 2375.477394973103, 2392.808575313971, 2394.700662417207, 2408.0969636386353, 2299.9425014374774, 2382.8927698253447, 2403.0267741564694, 2404.6513255577843, 2405.542946840095, 7326.41388688909, 7575.356094731955, 8385.329173666152, 8448.112948140419, 8469.74590762278, 5102.336696229503, 5288.973555132238, 5290.55030322423, 5410.621256512046, 5431.185322201662, 3249.2689144942437, 3286.1948822538393, 3352.430086885235, 3353.0443823510427, 3373.713234375081, 1011.1354791653105, 1011.3375738890965, 1012.8227560176939, 1042.1298215989657, 1052.8103243335058, 11834.585789497412, 11903.940480297542, 12011.159218854684, 12017.218880772809, 12043.458044388024, 4457.3091170868565, 4730.455997560256, 4766.451858036301, 4827.058723548945, 4833.951660483421, 9836.852447213298, 9845.163161131384, 9849.359791613522, 9852.35959662634, 9856.0, 5391.838244852661, 5394.703291319015, 5395.73021348931, 5399.730013499309, 5403.243545903577, 4776.880577985508, 4856.41722993236, 4885.267209918541, 4984.8753781155765, 4985.775640096204, 3944.9408258876138, 3996.2407142643387, 4040.9595904040584, 4059.939100913489, 4087.9386809197886, 1259.9496020159274, 1273.0833799664226, 1288.884000439965, 1291.031726205346, 1297.7015286484161, 881.9779505512286, 901.5717534171347, 965.9323847330619, 989.4360214677708, 1018.3889666200369, 5743.511801496919, 5790.971045144832, 5917.792877249276, 5925.940740592625, 5969.955257829863, 909.5361365703538, 956.0821611253136, 968.6173961285393, 969.14230905649, 999.6401295533602, 3976.2842688315804, 4160.396742472324, 4181.519125300569, 4217.599328063829, 4218.451601291812, 9155.0, 9516.857247141299, 9745.0, 10107.09036186732, 10343.94828025855, 10343.844842327371, 10352.844707329396, 10355.585776568852, 10356.482175891175, 10403.167746580255, 6884.759033433806, 7100.147982242164, 7853.607319633996, 8067.515949043076, 8163.632636531371, 5972.163897054329, 6076.240469941257, 6092.055731361646, 6169.9691501544, 6269.310375858743, 9856.063673950963, 10073.395596264247, 10111.3427627204, 10131.544080516247, 10138.898611013796, 9821.36161149523, 9945.602175912882, 10003.549840257352, 10049.196064314983, 10066.144377727975, 6858.245592984668, 6926.792196234121, 6959.860802784017, 6981.3367730065565, 6982.581045137308, 7702.845943080995, 7740.26467485588, 7857.2928436441, 8235.423520353517, 8237.83524329522, 7206.495545311778, 7311.305425984523, 7374.557526548424, 7394.704211831467, 7498.137714162723, 7154.320339567733, 7245.927540724525, 7246.239144889922, 7261.818454538678, 7351.926480735124, 6839.179298484214, 6839.350261725128, 6876.656167191721, 6891.138607674041, 6938.826529336807, 4902.068606964665, 4909.852704418873, 4956.405231372259, 4999.275105109811, 5019.548240658358, 4712.081144176853, 4789.544993225638, 4851.684640498356, 4853.174960256835, 4899.681520701143], "value": 4561.809372960626, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.9034270404286, 347.15814150684594, 347.572485842414, 351.48163409173264, 352.58395093789335, 5265.684058956465, 5395.568354531638, 5450.31871016123, 5508.641938274014, 5543.805966791163, 5194.013137503881, 5291.841244762653, 5306.0, 5313.760880760366, 5376.0, 4207.85272515462, 4242.830286788525, 4248.638865696419, 4265.744055356673, 4277.4011638370575, 4132.97933510332, 4237.6186143247105, 4255.89346769839, 4262.509811371686, 4268.658507319407, 4211.199872024321, 4216.57834216579, 4220.810063547147, 4226.809793559281, 4240.257954857903, 4204.66362690984, 4223.260929337353, 4223.493180818291, 4223.894402639928, 4257.233697934371, 3773.811309434545, 3774.584795672474, 3778.735488515805, 3783.148791521913, 3797.1076796952693, 4994.375703037121, 5221.6083793715625, 5231.895362092775, 5246.449122842085, 5254.8160814371695, 4800.903981920342, 4827.806887724487, 4830.975845120752, 4832.444268909086, 4836.467988521295, 5400.892816972511, 5665.348484924245, 5681.119426488859, 5684.971575142139, 5692.345380281279, 4087.652549533293, 4096.9795151024355, 4113.1568028554075, 4115.8971025724595, 4119.0, 5862.50168735658, 5884.941150588482, 5891.882162356729, 5893.116032595102, 5898.705064746746, 4014.1570270243574, 4173.770442625624, 4175.603317684815, 4181.958180418218, 4183.0, 4153.501579810381, 4164.6251837334785, 4177.266434429677, 4204.4324016257415, 4208.726432781859, 4753.287006948985, 4761.6904901181315, 4794.4486384065585, 4803.886290032375, 4804.0, 5544.528715059265, 5642.633228840113, 5648.71756412186, 5656.660600363909, 5659.179418984224, 1412.2867951684334, 1413.4982081360968, 1419.9918058178603, 1420.1975883625719, 1424.9928750356182, 967.3228739882111, 976.4727047394327, 983.5279066048337, 993.2004736187295, 999.9100080992746, 5273.973630131824, 5297.907326606046, 5303.310569625924, 5304.0, 5313.256144139824, 5573.359063707726, 5579.553635709133, 5583.464547249458, 5607.635503692247, 5610.49505544503, 5067.771950262247, 5267.209918512177, 5311.601629877775, 5340.465953404629, 5363.812266570651, 2942.264433891527, 2944.823310601371, 2958.4911695035685, 2967.9406411872073, 2987.581738556604, 5745.827625171251, 5769.0, 5781.843631273762, 5802.448767367094, 5835.737391817378, 5416.9729151353995, 5661.2923384576925, 5665.688387138664, 5684.8863022739315, 5726.4252330609415, 5836.548649567192, 5857.690404921206, 5864.941350586525, 5877.9999999999145, 5878.735456904364, 5482.533984611353, 5511.807086751945, 5644.294463192101, 5751.137329400456, 5792.333881603669, 5783.595148339576, 5792.420757924174, 5795.159701843293, 5826.563007774349, 5838.708064596838, 6050.273967123797, 6065.969670151798, 6085.786997455068, 6093.542984276286, 6097.664628445478, 3884.533855937306, 4003.839846406111, 4026.4765580475523, 4063.1264278180333, 4172.290710579269, 5769.68266745333, 5773.74018169175, 5777.2200752897825, 5783.681897495678, 5790.305163380422, 5641.294838145232, 5666.356756540722, 5670.744816483186, 5674.631148975303, 5682.516986056232, 5493.642913210629, 5619.297587801525, 5644.266245388238, 5662.405447428126, 5676.829695108988, 5625.774969001194, 5641.8589535261945, 5644.266245388073, 5645.379008309001, 5652.236948012131, 5490.396056433709, 5626.887462250814, 5666.829995100154, 5684.801031964027, 5684.914726279027, 5477.945220547744, 5508.44915508446, 5529.944700553104, 5541.750621222135, 5549.639273447213], "value": 4296.436888539488, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.4175584799701, 761.6191904047972, 792.43341011177, 793.3771988988644, 809.0534075132094, 14560.344784484698, 15111.697766044672, 15681.059136451806, 15691.764623530657, 15874.920625396857, 14321.856781432183, 14347.354369053392, 14433.13401195929, 14444.855551444509, 14450.855491445081, 840.4033136473112, 855.1234984141258, 863.2274114667368, 864.7016779211193, 865.5499140446964, 846.0608724316004, 861.7242482405633, 863.3007264116055, 864.4035615425337, 864.7276108025983, 909.0545832334365, 909.6315992023241, 910.5310764956052, 911.1207684584375, 911.4759013567225, 903.0247332880473, 904.7150147703452, 905.5064989580694, 906.4923642760042, 908.7682640926588, 662.4369286106819, 664.9800505984829, 665.6571865489277, 666.2837449741498, 666.796627028756, 14695.92652036733, 14904.403823847033, 15661.216939153112, 15796.368145274175, 15800.367985280574, 14390.352434140488, 14835.545844121545, 14886.553403397807, 15121.319540620589, 15212.239388030554, 11474.254173478781, 11739.530418783239, 12085.697857553543, 12301.0, 12313.938430307791, 3807.752496087773, 3843.3658446356317, 3844.1735026969336, 3879.72841901067, 3902.902427439308, 56329.155062673686, 68188.6590567049, 68437.65781171112, 69653.30346696518, 69911.30088699098, 10646.254762166574, 11228.214025018333, 11259.437028148559, 11421.371824549564, 11429.828552571718, 18505.35231266899, 18614.255429782657, 18749.81250187508, 18981.43055708331, 18984.810151898582, 8132.634031468599, 8219.753407397788, 8373.95813020931, 8406.831863362699, 8506.404551681322, 4675.719456832601, 4694.577488026094, 4759.16714574948, 4784.282357646381, 4846.321514987904, 3590.551181102362, 3694.07648087978, 3702.796346200931, 3704.7036237100965, 3707.888763337104, 622.3061286665336, 622.7758007117434, 628.6479571440008, 629.2543336146681, 640.9839754006094, 668.2448832818884, 672.653583404547, 677.502036003537, 683.8461346197066, 693.4972145194795, 9006.954965225263, 9215.723528294162, 9348.392354496937, 9456.8581471278, 9709.6601618943, 602.5450784657555, 633.3856159525253, 661.5303134774268, 720.8666396716624, 722.7578761115085, 4253.298205796009, 4379.64962802975, 4393.538678438782, 4412.646988240933, 4555.2711566149255, 69273.65363173252, 72680.27319726735, 74724.62637686777, 76441.0, 88333.55833220793, 50102.0, 67025.66487167533, 67730.0, 69397.0, 74549.0, 64048.0, 72374.99999999895, 72622.63688681523, 74642.0, 78216.60891695505, 9360.531973401166, 9955.352902061342, 10078.94960525222, 10151.086402223835, 10164.085232329126, 48101.51898480971, 48876.75561622169, 49045.50954490552, 49163.508364917325, 50149.49850501448, 60087.0, 67110.0, 69166.0, 69213.30786692069, 69514.30485695078, 12299.69250768738, 12627.0, 12663.810042849549, 12908.290044047668, 12983.610491685264, 13009.804852927404, 13051.0, 13199.0, 13301.66745831362, 13525.729485410433, 11648.068154547786, 11742.412879356169, 11832.645020649394, 11912.40437978115, 12057.0, 11603.477843496894, 11916.285022898654, 12285.0, 12287.631371058882, 12502.43739031764, 12801.359932003548, 12850.55023074188, 12853.93573032129, 12877.8068328977, 12998.350082496027, 10941.617043403443, 10967.341959482457, 11163.665090047312, 11469.662384937888, 11518.53925842957, 10891.18316126278, 11052.613158539412, 11134.665960021212, 11242.437878105899, 11285.661430157108], "value": 7223.131832408504, "unit": "score"}], "name": "dromaeo_css", "value": 7296.778419839695, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 112.0, 111.0, 111.0, 111.0, 110.0, 111.0, 111.0, 110.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 124.0, 153.0, 126.0, 123.0, 122.0, 125.0, 154.0, 125.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 164.0, 161.0, 163.0, 162.0, 163.0, 163.0, 163.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 104.0, 77.0, 78.0, 75.0, 75.0, 99.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 106.0, 83.0, 84.0, 81.0, 105.0, 83.0, 83.0, 102.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 119.0, 116.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 86.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 50.0, 50.0, 51.0, 50.0, 50.0, 51.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 60.0, 59.0, 60.0, 59.0, 59.0, 63.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 75.0, 76.0, 76.0, 79.0, 75.0, 74.0, 74.0, 75.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 129.0, 136.0, 124.0, 123.0, 133.0, 142.0, 132.0, 171.0, 125.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 154.0, 162.0, 155.0, 155.0, 157.0, 157.0, 156.0, 161.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 61.0, 62.0, 62.0, 62.0, 61.0, 62.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1464.0, "alertThreshold": 2.0}]} 06:20:28 INFO - Return code: 0 06:20:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:20:28 ERROR - # TBPL SUCCESS # 06:20:28 INFO - Running post-action listener: _resource_record_post_action 06:20:28 INFO - [mozharness: 2016-11-16 14:20:28.163094Z] Finished run-tests step (success) 06:20:28 INFO - Running post-run listener: _resource_record_post_run 06:20:28 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 355901440; Read time: 8; Write time: 209444 06:20:28 INFO - TinderboxPrint: CPU usage
13.0% 06:20:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 06:20:28 INFO - TinderboxPrint: I/O write bytes / time
355,901,440 / 209,444 06:20:28 INFO - TinderboxPrint: CPU idle
8,280.8 (87.0%) 06:20:28 INFO - TinderboxPrint: CPU user
1,190.3 (12.5%) 06:20:28 INFO - TinderboxPrint: Swap in / out
0 / 0 06:20:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107417600; Read time: 0; Write time: 82060 06:20:28 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 248025088; Read time: 0; Write time: 127384 06:20:28 INFO - Running post-run listener: _upload_blobber_files 06:20:28 INFO - Blob upload gear active. 06:20:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:20:28 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 06:20:28 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'] 06:20:28 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 06:20:29 INFO - (blobuploader) - INFO - Open directory for files ... 06:20:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:20:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:20:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:32 INFO - (blobuploader) - INFO - Done attempting. 06:20:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:20:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:20:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:33 INFO - (blobuploader) - INFO - Done attempting. 06:20:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:20:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:20:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:33 INFO - (blobuploader) - INFO - Done attempting. 06:20:33 INFO - (blobuploader) - INFO - Iteration through files over. 06:20:33 INFO - Return code: 0 06:20:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:20:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:20:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6577a7673474d853edd6e56b40a7386ef0104106f4370fd37f64866bd6cc2facba645d0a4b3f14ee4e76e6e46e45734756ff3040d25858564d439fb9e9f65a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/453f8ca4ed383f9f8d9a7e96f92332d95999cba8a79eb6221494789e9dacc5213237528325c0571eb4f478854386617244fae0ccfa394d9f064a95ca4defec1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/089a8c33a100db591e591f01533df1b1b4902498ab99501d213decc03368d05a21244362cc447bf0d7ca2d1d5ff7bd5f8e63bd18ad74fe3edac6e391bd4a210b"} 06:20:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:20:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:20:33 INFO - Contents: 06:20:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6577a7673474d853edd6e56b40a7386ef0104106f4370fd37f64866bd6cc2facba645d0a4b3f14ee4e76e6e46e45734756ff3040d25858564d439fb9e9f65a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/453f8ca4ed383f9f8d9a7e96f92332d95999cba8a79eb6221494789e9dacc5213237528325c0571eb4f478854386617244fae0ccfa394d9f064a95ca4defec1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/089a8c33a100db591e591f01533df1b1b4902498ab99501d213decc03368d05a21244362cc447bf0d7ca2d1d5ff7bd5f8e63bd18ad74fe3edac6e391bd4a210b"} 06:20:33 INFO - Running post-run listener: copy_logs_to_upload_dir 06:20:33 INFO - Copying logs to upload dir... 06:20:33 INFO - mkdir: /builds/slave/test/build/upload/logs 06:20:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.787479 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-16 06:20:33.947524) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 06:20:33.956061) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785 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/a6577a7673474d853edd6e56b40a7386ef0104106f4370fd37f64866bd6cc2facba645d0a4b3f14ee4e76e6e46e45734756ff3040d25858564d439fb9e9f65a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/453f8ca4ed383f9f8d9a7e96f92332d95999cba8a79eb6221494789e9dacc5213237528325c0571eb4f478854386617244fae0ccfa394d9f064a95ca4defec1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/089a8c33a100db591e591f01533df1b1b4902498ab99501d213decc03368d05a21244362cc447bf0d7ca2d1d5ff7bd5f8e63bd18ad74fe3edac6e391bd4a210b"} build_url:https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/KT0w6ZHtS2-UsiJzzf2BUw/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/a6577a7673474d853edd6e56b40a7386ef0104106f4370fd37f64866bd6cc2facba645d0a4b3f14ee4e76e6e46e45734756ff3040d25858564d439fb9e9f65a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/453f8ca4ed383f9f8d9a7e96f92332d95999cba8a79eb6221494789e9dacc5213237528325c0571eb4f478854386617244fae0ccfa394d9f064a95ca4defec1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/089a8c33a100db591e591f01533df1b1b4902498ab99501d213decc03368d05a21244362cc447bf0d7ca2d1d5ff7bd5f8e63bd18ad74fe3edac6e391bd4a210b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 06:20:33.984800) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 06:20:33.985146) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1479304771.909233-963358785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004707 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 06:20:34.039401) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 06:20:34.039724) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 06:20:34.040054) ========= ========= Total master_lag: 0.46 =========