builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1477260944.63 results: success (0) buildid: 20161023123006 builduid: e56cd4dbefe34d1d82ee5740e6d07fee revision: a9a41b69f3f9be494ae0653601c08aa388d9afe4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 15:15:44.631002) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 15:15:44.631441) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 15:15:44.631718) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 15:15:44.646163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 15:15:44.646439) ========= 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=5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-23 15:15:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-10-23 15:15:45 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083247 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 15:15:44.744902) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 15:15:44.745205) ========= 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=5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019578 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 15:15:44.794861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 15:15:44.795195) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a9a41b69f3f9be494ae0653601c08aa388d9afe4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a9a41b69f3f9be494ae0653601c08aa388d9afe4 --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=5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-23 15:15:45,233 truncating revision to first 12 chars 2016-10-23 15:15:45,233 Setting DEBUG logging. 2016-10-23 15:15:45,233 attempt 1/10 2016-10-23 15:15:45,233 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a9a41b69f3f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-23 15:15:45,867 unpacking tar archive at: fx-team-a9a41b69f3f9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.965260 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 15:15:45.773710) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 15:15:45.774013) ========= script_repo_revision: a9a41b69f3f9be494ae0653601c08aa388d9afe4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 15:15:45.774401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 15:15:45.774661) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 15:15:45.782752) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-23 15:15:45.783013) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:15:46 INFO - MultiFileLogger online at 20161023 15:15:46 in /builds/slave/test 15:15:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:15:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:15:46 INFO - {'append_to_log': False, 15:15:46 INFO - 'base_work_dir': '/builds/slave/test', 15:15:46 INFO - 'blob_upload_branch': 'Fx-Team', 15:15:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:15:46 INFO - 'branch': 'Fx-Team', 15:15:46 INFO - 'buildbot_json_path': 'buildprops.json', 15:15:46 INFO - 'config_files': ('talos/linux_config.py',), 15:15:46 INFO - 'default_actions': ('clobber', 15:15:46 INFO - 'read-buildbot-config', 15:15:46 INFO - 'download-and-extract', 15:15:46 INFO - 'populate-webroot', 15:15:46 INFO - 'create-virtualenv', 15:15:46 INFO - 'install', 15:15:46 INFO - 'run-tests'), 15:15:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:15:46 INFO - 'download_minidump_stackwalk': True, 15:15:46 INFO - 'download_symbols': 'ondemand', 15:15:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:15:46 INFO - 'tooltool.py': '/tools/tooltool.py', 15:15:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:15:46 INFO - '/tools/misc-python/virtualenv.py')}, 15:15:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:15:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:15:46 INFO - 'installer_path': 'installer.exe', 15:15:46 INFO - 'log_level': 'info', 15:15:46 INFO - 'log_name': 'talos', 15:15:46 INFO - 'log_to_console': True, 15:15:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:15:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:15:46 INFO - 'opt_config_files': (), 15:15:46 INFO - 'pip_index': False, 15:15:46 INFO - 'sps_profile': False, 15:15:46 INFO - 'sps_profile_interval': 0, 15:15:46 INFO - 'suite': 'dromaeojs', 15:15:46 INFO - 'system_bits': '32', 15:15:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:15:46 INFO - 'title': 'talos-linux64-ix-011', 15:15:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:15:46 INFO - 'use_talos_json': True, 15:15:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:15:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:15:46 INFO - 'work_dir': 'build'} 15:15:46 INFO - [mozharness: 2016-10-23 22:15:46.312534Z] Running clobber step. 15:15:46 INFO - Running pre-action listener: _resource_record_pre_action 15:15:46 INFO - Running main action method: clobber 15:15:46 INFO - rmtree: /builds/slave/test/build 15:15:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:15:47 INFO - Running post-action listener: _resource_record_post_action 15:15:47 INFO - [mozharness: 2016-10-23 22:15:47.274722Z] Finished clobber step (success) 15:15:47 INFO - [mozharness: 2016-10-23 22:15:47.274821Z] Running read-buildbot-config step. 15:15:47 INFO - Running pre-action listener: _resource_record_pre_action 15:15:47 INFO - Running main action method: read_buildbot_config 15:15:47 INFO - Using buildbot properties: 15:15:47 INFO - { 15:15:47 INFO - "project": "", 15:15:47 INFO - "product": "firefox", 15:15:47 INFO - "script_repo_revision": "production", 15:15:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:15:47 INFO - "repository": "", 15:15:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 15:15:47 INFO - "buildid": "20161023123006", 15:15:47 INFO - "pgo_build": "True", 15:15:47 INFO - "basedir": "/builds/slave/test", 15:15:47 INFO - "buildnumber": 1654, 15:15:47 INFO - "slavename": "talos-linux64-ix-011", 15:15:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:15:47 INFO - "platform": "ubuntu64_hw", 15:15:47 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 15:15:47 INFO - "branch": "fx-team", 15:15:47 INFO - "repo_path": "integration/fx-team", 15:15:47 INFO - "revision": "a9a41b69f3f9be494ae0653601c08aa388d9afe4", 15:15:47 INFO - "stage_platform": "linux64-pgo", 15:15:47 INFO - "builduid": "e56cd4dbefe34d1d82ee5740e6d07fee", 15:15:47 INFO - "slavebuilddir": "test" 15:15:47 INFO - } 15:15:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:15:47 INFO - Running post-action listener: _resource_record_post_action 15:15:47 INFO - [mozharness: 2016-10-23 22:15:47.277254Z] Finished read-buildbot-config step (success) 15:15:47 INFO - [mozharness: 2016-10-23 22:15:47.277342Z] Running download-and-extract step. 15:15:47 INFO - Running pre-action listener: _resource_record_pre_action 15:15:47 INFO - Running main action method: download_and_extract 15:15:47 INFO - mkdir: /builds/slave/test/build/tests 15:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:15:47 INFO - trying https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:15:47 INFO - Downloading https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:15:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:15:47 INFO - Downloaded 1361 bytes. 15:15:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:15:47 INFO - Using the following test package requirements: 15:15:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:15:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:15:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:15:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:15:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:15:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:15:47 INFO - u'jsshell-linux-x86_64.zip'], 15:15:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:15:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:15:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:15:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:15:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:15:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:15:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:15:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:15:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:15:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:15:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:15:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:15:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:15:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:15:47 INFO - Fetch https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:15:48 INFO - Http code: 200 15:15:48 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 15:15:48 INFO - x-amz-cf-id: W3YYM09LQIfg3kxlIwxzLF5GRmdlAsfCfS62MdwkR8vYSXh8_sED3w== 15:15:48 INFO - x-amz-version-id: I17f_uqvGytZj8nggPSUEUK7yRpx6b8F 15:15:48 INFO - Expected file size: 22038538 15:15:48 INFO - Obtained file size: 22038538 15:15:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:15:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:15:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:15:53 INFO - Fetch https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:15:53 INFO - Http code: 200 15:15:53 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 15:15:53 INFO - x-amz-cf-id: aq0fKzWiwxw_gR2NlLTSnrChbkOp2lYsWBs4eQhQA9652IEwpKflqg== 15:15:53 INFO - x-amz-version-id: I17f_uqvGytZj8nggPSUEUK7yRpx6b8F 15:15:53 INFO - Expected file size: 22038538 15:15:53 INFO - Obtained file size: 22038538 15:15:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:15:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:15:58 INFO - Fetch https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:15:58 INFO - Http code: 200 15:15:58 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 15:15:58 INFO - x-amz-cf-id: 9ViuxHZz-gQypXlRGA8NcWMbAyCDugYMwuUyWr57HXPdQs57EtMGew== 15:15:58 INFO - x-amz-version-id: IFeLaA5inJj8kCm5j0s__FRM3SYYXv3t 15:15:59 INFO - Expected file size: 14409028 15:15:59 INFO - Obtained file size: 14409028 15:15:59 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')]} 15:15:59 INFO - trying https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:15:59 INFO - Downloading https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:15:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:16:02 INFO - Downloaded 59381412 bytes. 15:16:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:16:02 INFO - mkdir: /builds/slave/test/properties 15:16:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:16:02 INFO - Writing to file /builds/slave/test/properties/build_url 15:16:02 INFO - Contents: 15:16:02 INFO - build_url:https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:16:03 INFO - Running post-action listener: _resource_record_post_action 15:16:03 INFO - Running post-action listener: set_extra_try_arguments 15:16:03 INFO - [mozharness: 2016-10-23 22:16:03.102925Z] Finished download-and-extract step (success) 15:16:03 INFO - [mozharness: 2016-10-23 22:16:03.103151Z] Running populate-webroot step. 15:16:03 INFO - Running pre-action listener: _resource_record_pre_action 15:16:03 INFO - Running main action method: populate_webroot 15:16:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:16:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:16:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:16:03 INFO - '--tppagecycles', 15:16:03 INFO - '7'], 15:16:03 INFO - 'tests': ['tsvgm']}}, 15:16:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:16:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:16:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:16:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:16:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:16:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:16:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:03 INFO - 'talos_options': ['--disable-e10s'], 15:16:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:16:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:16:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:03 INFO - 'talos_options': ['--disable-e10s'], 15:16:03 INFO - 'tests': ['damp', 'tps']}, 15:16:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:03 INFO - 'tests': ['damp', 'tps']}, 15:16:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:16:03 INFO - 'tests': ['dromaeo_dom']}, 15:16:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:16:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:16:03 INFO - 'tests': ['basic_compositor_video']}, 15:16:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:16:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:16:03 INFO - 'tests': ['a11yr', 15:16:03 INFO - 'ts_paint', 15:16:03 INFO - 'tpaint', 15:16:03 INFO - 'sessionrestore', 15:16:03 INFO - 'sessionrestore_no_auto_restore', 15:16:03 INFO - 'tabpaint']}, 15:16:03 INFO - 'other-e10s': {'tests': ['a11yr', 15:16:03 INFO - 'ts_paint', 15:16:03 INFO - 'tpaint', 15:16:03 INFO - 'sessionrestore', 15:16:03 INFO - 'sessionrestore_no_auto_restore', 15:16:03 INFO - 'tabpaint']}, 15:16:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:16:03 INFO - 'ts_paint', 15:16:03 INFO - 'tpaint', 15:16:03 INFO - 'sessionrestore', 15:16:03 INFO - 'sessionrestore_no_auto_restore', 15:16:03 INFO - 'tabpaint']}, 15:16:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:16:03 INFO - 'ts_paint', 15:16:03 INFO - 'tpaint', 15:16:03 INFO - 'sessionrestore', 15:16:03 INFO - 'sessionrestore_no_auto_restore', 15:16:03 INFO - 'tabpaint']}, 15:16:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:16:03 INFO - 'tests': ['a11yr', 15:16:03 INFO - 'ts_paint', 15:16:03 INFO - 'tpaint', 15:16:03 INFO - 'sessionrestore', 15:16:03 INFO - 'sessionrestore_no_auto_restore', 15:16:03 INFO - 'tabpaint']}, 15:16:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:16:03 INFO - 'tests': ['a11yr', 15:16:03 INFO - 'ts_paint', 15:16:03 INFO - 'tpaint', 15:16:03 INFO - 'sessionrestore', 15:16:03 INFO - 'sessionrestore_no_auto_restore', 15:16:03 INFO - 'tabpaint']}, 15:16:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:16:03 INFO - 'tests': ['tsvgx', 15:16:03 INFO - 'tsvgr_opacity', 15:16:03 INFO - 'tart', 15:16:03 INFO - 'tscrollx', 15:16:03 INFO - 'cart']}, 15:16:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:16:03 INFO - 'tsvgr_opacity', 15:16:03 INFO - 'tart', 15:16:03 INFO - 'tscrollx', 15:16:03 INFO - 'cart']}, 15:16:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:03 INFO - 'talos_options': ['--disable-e10s'], 15:16:03 INFO - 'tests': ['tp5o']}, 15:16:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:03 INFO - 'tests': ['tp5o']}, 15:16:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:03 INFO - 'talos_options': ['--disable-e10s', 15:16:03 INFO - '--xperf_path', 15:16:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:16:03 INFO - 'tests': ['tp5n']}, 15:16:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:16:03 INFO - 'talos_options': ['--xperf_path', 15:16:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:16:03 INFO - 'tests': ['tp5n']}}, 15:16:03 INFO - 'talos.zip': {'path': '', 15:16:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:16:03 INFO - Running post-action listener: _resource_record_post_action 15:16:03 INFO - [mozharness: 2016-10-23 22:16:03.119562Z] Finished populate-webroot step (success) 15:16:03 INFO - [mozharness: 2016-10-23 22:16:03.119649Z] Running create-virtualenv step. 15:16:03 INFO - Running pre-action listener: _resource_record_pre_action 15:16:03 INFO - Running main action method: create_virtualenv 15:16:03 INFO - Creating virtualenv /builds/slave/test/build/venv 15:16:03 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 15:16:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:16:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:16:03 INFO - Using real prefix '/usr' 15:16:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:16:03 INFO - Installing distribute.............................................................................................................................................................................................done. 15:16:05 INFO - Installing pip.................done. 15:16:05 INFO - Return code: 0 15:16:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:16:05 INFO - Reading from file tmpfile_stdout 15:16:05 INFO - Output received: 15:16:05 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) 15:16:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:16:05 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')]} 15:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:05 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')]} 15:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:05 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 0x7f579a7fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b790>, '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 0x181c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181cb20>, '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': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', '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 15:16:05 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 15:16:05 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 15:16:05 INFO - Using env: {'DISPLAY': ':0', 15:16:05 INFO - 'HOME': '/home/cltbld', 15:16:05 INFO - 'LANG': 'en_US.UTF-8', 15:16:05 INFO - 'LANGUAGE': 'en_US:en', 15:16:05 INFO - 'LOGNAME': 'cltbld', 15:16:05 INFO - 'MAIL': '/var/mail/cltbld', 15:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:05 INFO - 'MOZ_NO_REMOTE': '1', 15:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:05 INFO - 'NO_EM_RESTART': '1', 15:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:05 INFO - 'PWD': '/builds/slave/test', 15:16:05 INFO - 'SHELL': '/bin/bash', 15:16:05 INFO - 'SHLVL': '1', 15:16:05 INFO - 'TERM': 'linux', 15:16:05 INFO - 'TMOUT': '86400', 15:16:05 INFO - 'USER': 'cltbld', 15:16:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', 15:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:05 INFO - '_': '/tools/buildbot/bin/python'} 15:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:06 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 15:16:06 INFO - Cleaning up... 15:16:06 INFO - Return code: 0 15:16:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:16:06 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')]} 15:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:06 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')]} 15:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:06 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 0x7f579a7fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b790>, '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 0x181c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181cb20>, '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': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', '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 15:16:06 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 15:16:06 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 15:16:06 INFO - Using env: {'DISPLAY': ':0', 15:16:06 INFO - 'HOME': '/home/cltbld', 15:16:06 INFO - 'LANG': 'en_US.UTF-8', 15:16:06 INFO - 'LANGUAGE': 'en_US:en', 15:16:06 INFO - 'LOGNAME': 'cltbld', 15:16:06 INFO - 'MAIL': '/var/mail/cltbld', 15:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:06 INFO - 'MOZ_NO_REMOTE': '1', 15:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:06 INFO - 'NO_EM_RESTART': '1', 15:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:06 INFO - 'PWD': '/builds/slave/test', 15:16:06 INFO - 'SHELL': '/bin/bash', 15:16:06 INFO - 'SHLVL': '1', 15:16:06 INFO - 'TERM': 'linux', 15:16:06 INFO - 'TMOUT': '86400', 15:16:06 INFO - 'USER': 'cltbld', 15:16:06 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', 15:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:06 INFO - '_': '/tools/buildbot/bin/python'} 15:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:06 INFO - Downloading/unpacking psutil>=3.1.1 15:16:06 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 15:16:06 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 15:16:06 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 15:16:06 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 15:16:06 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 15:16:06 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 15:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:16:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:08 INFO - Installing collected packages: psutil 15:16:08 INFO - Running setup.py install for psutil 15:16:08 INFO - building 'psutil._psutil_linux' extension 15:16:08 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 15:16:08 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 15:16:08 INFO - building 'psutil._psutil_posix' extension 15:16:08 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 15:16:08 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 15:16:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:16:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:16:08 INFO - Successfully installed psutil 15:16:08 INFO - Cleaning up... 15:16:08 INFO - Return code: 0 15:16:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:08 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 0x7f579a7fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b790>, '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 0x181c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181cb20>, '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': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', '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 15:16:08 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 15:16:08 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 15:16:08 INFO - Using env: {'DISPLAY': ':0', 15:16:08 INFO - 'HOME': '/home/cltbld', 15:16:08 INFO - 'LANG': 'en_US.UTF-8', 15:16:08 INFO - 'LANGUAGE': 'en_US:en', 15:16:08 INFO - 'LOGNAME': 'cltbld', 15:16:08 INFO - 'MAIL': '/var/mail/cltbld', 15:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:08 INFO - 'MOZ_NO_REMOTE': '1', 15:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:08 INFO - 'NO_EM_RESTART': '1', 15:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:08 INFO - 'PWD': '/builds/slave/test', 15:16:08 INFO - 'SHELL': '/bin/bash', 15:16:08 INFO - 'SHLVL': '1', 15:16:08 INFO - 'TERM': 'linux', 15:16:08 INFO - 'TMOUT': '86400', 15:16:08 INFO - 'USER': 'cltbld', 15:16:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', 15:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:08 INFO - '_': '/tools/buildbot/bin/python'} 15:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:16:09 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 15:16:09 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 15:16:09 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 15:16:09 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 15:16:09 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 15:16:09 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 15:16:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:16:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:16:11 INFO - Installing collected packages: mozsystemmonitor 15:16:11 INFO - Running setup.py install for mozsystemmonitor 15:16:11 INFO - Successfully installed mozsystemmonitor 15:16:11 INFO - Cleaning up... 15:16:11 INFO - Return code: 0 15:16:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:16:11 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')]} 15:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:11 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')]} 15:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:11 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 0x7f579a7fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b790>, '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 0x181c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181cb20>, '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': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', '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 15:16:11 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 15:16:11 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 15:16:11 INFO - Using env: {'DISPLAY': ':0', 15:16:11 INFO - 'HOME': '/home/cltbld', 15:16:11 INFO - 'LANG': 'en_US.UTF-8', 15:16:11 INFO - 'LANGUAGE': 'en_US:en', 15:16:11 INFO - 'LOGNAME': 'cltbld', 15:16:11 INFO - 'MAIL': '/var/mail/cltbld', 15:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:11 INFO - 'MOZ_NO_REMOTE': '1', 15:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:11 INFO - 'NO_EM_RESTART': '1', 15:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:11 INFO - 'PWD': '/builds/slave/test', 15:16:11 INFO - 'SHELL': '/bin/bash', 15:16:11 INFO - 'SHLVL': '1', 15:16:11 INFO - 'TERM': 'linux', 15:16:11 INFO - 'TMOUT': '86400', 15:16:11 INFO - 'USER': 'cltbld', 15:16:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', 15:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:11 INFO - '_': '/tools/buildbot/bin/python'} 15:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:11 INFO - Downloading/unpacking jsonschema==2.5.1 15:16:11 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 15:16:11 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 15:16:11 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 15:16:11 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 15:16:11 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 15:16:11 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 15:16:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:16:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:16:13 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 15:16:13 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 15:16:13 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 15:16:13 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 15:16:13 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 15:16:13 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 15:16:13 INFO - Downloading functools32-3.2.3-2.tar.gz 15:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:16:13 INFO - warning: no files found matching '*.txt' 15:16:13 INFO - no previously-included directories found matching 'build' 15:16:13 INFO - no previously-included directories found matching 'dist' 15:16:13 INFO - no previously-included directories found matching '.git*' 15:16:13 INFO - Installing collected packages: jsonschema, functools32 15:16:13 INFO - Running setup.py install for functools32 15:16:13 INFO - warning: no files found matching '*.txt' 15:16:13 INFO - no previously-included directories found matching 'build' 15:16:13 INFO - no previously-included directories found matching 'dist' 15:16:13 INFO - no previously-included directories found matching '.git*' 15:16:13 INFO - Successfully installed jsonschema functools32 15:16:13 INFO - Cleaning up... 15:16:13 INFO - Return code: 0 15:16:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:13 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 0x7f579a7fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b790>, '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 0x181c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181cb20>, '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': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', '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 15:16:13 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 15:16:13 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 15:16:13 INFO - Using env: {'DISPLAY': ':0', 15:16:13 INFO - 'HOME': '/home/cltbld', 15:16:13 INFO - 'LANG': 'en_US.UTF-8', 15:16:13 INFO - 'LANGUAGE': 'en_US:en', 15:16:13 INFO - 'LOGNAME': 'cltbld', 15:16:13 INFO - 'MAIL': '/var/mail/cltbld', 15:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:13 INFO - 'MOZ_NO_REMOTE': '1', 15:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:13 INFO - 'NO_EM_RESTART': '1', 15:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:13 INFO - 'PWD': '/builds/slave/test', 15:16:13 INFO - 'SHELL': '/bin/bash', 15:16:13 INFO - 'SHLVL': '1', 15:16:13 INFO - 'TERM': 'linux', 15:16:13 INFO - 'TMOUT': '86400', 15:16:13 INFO - 'USER': 'cltbld', 15:16:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', 15:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:13 INFO - '_': '/tools/buildbot/bin/python'} 15:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:16:14 INFO - Cleaning up... 15:16:14 INFO - Return code: 0 15:16:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:16:14 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')]} 15:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:14 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')]} 15:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:14 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 0x7f579a7fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b790>, '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 0x181c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181cb20>, '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': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', '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 15:16:14 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 15:16:14 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 15:16:14 INFO - Using env: {'DISPLAY': ':0', 15:16:14 INFO - 'HOME': '/home/cltbld', 15:16:14 INFO - 'LANG': 'en_US.UTF-8', 15:16:14 INFO - 'LANGUAGE': 'en_US:en', 15:16:14 INFO - 'LOGNAME': 'cltbld', 15:16:14 INFO - 'MAIL': '/var/mail/cltbld', 15:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:14 INFO - 'MOZ_NO_REMOTE': '1', 15:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:14 INFO - 'NO_EM_RESTART': '1', 15:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:14 INFO - 'PWD': '/builds/slave/test', 15:16:14 INFO - 'SHELL': '/bin/bash', 15:16:14 INFO - 'SHLVL': '1', 15:16:14 INFO - 'TERM': 'linux', 15:16:14 INFO - 'TMOUT': '86400', 15:16:14 INFO - 'USER': 'cltbld', 15:16:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', 15:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:14 INFO - '_': '/tools/buildbot/bin/python'} 15:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:14 INFO - Downloading/unpacking blobuploader==1.2.4 15:16:14 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 15:16:14 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 15:16:14 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 15:16:14 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 15:16:14 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 15:16:14 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 15:16:16 INFO - Downloading blobuploader-1.2.4.tar.gz 15:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:16:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:16:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:17 INFO - Downloading docopt-0.6.1.tar.gz 15:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:16:17 INFO - Installing collected packages: blobuploader, requests, docopt 15:16:17 INFO - Running setup.py install for blobuploader 15:16:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:16:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:16:17 INFO - Running setup.py install for requests 15:16:17 INFO - Running setup.py install for docopt 15:16:17 INFO - Successfully installed blobuploader requests docopt 15:16:17 INFO - Cleaning up... 15:16:17 INFO - Return code: 0 15:16:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:17 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 0x7f579a7fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b790>, '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 0x181c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181cb20>, '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': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', '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 15:16:17 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 15:16:17 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 15:16:17 INFO - Using env: {'DISPLAY': ':0', 15:16:17 INFO - 'HOME': '/home/cltbld', 15:16:17 INFO - 'LANG': 'en_US.UTF-8', 15:16:17 INFO - 'LANGUAGE': 'en_US:en', 15:16:17 INFO - 'LOGNAME': 'cltbld', 15:16:17 INFO - 'MAIL': '/var/mail/cltbld', 15:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:17 INFO - 'MOZ_NO_REMOTE': '1', 15:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:17 INFO - 'NO_EM_RESTART': '1', 15:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:17 INFO - 'PWD': '/builds/slave/test', 15:16:17 INFO - 'SHELL': '/bin/bash', 15:16:17 INFO - 'SHLVL': '1', 15:16:17 INFO - 'TERM': 'linux', 15:16:17 INFO - 'TMOUT': '86400', 15:16:17 INFO - 'USER': 'cltbld', 15:16:17 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', 15:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:17 INFO - '_': '/tools/buildbot/bin/python'} 15:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:17 INFO - Running setup.py (path:/tmp/pip-8Gex5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:18 INFO - Running setup.py (path:/tmp/pip-nz74Wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:18 INFO - Running setup.py (path:/tmp/pip-yXSipC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:18 INFO - Running setup.py (path:/tmp/pip-3Kqyes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:18 INFO - Running setup.py (path:/tmp/pip-pJXKZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:18 INFO - Running setup.py (path:/tmp/pip-WahYHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:18 INFO - Running setup.py (path:/tmp/pip-dFMbXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:18 INFO - Running setup.py (path:/tmp/pip-z6OMxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:18 INFO - Running setup.py (path:/tmp/pip-vuF1fP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:18 INFO - Running setup.py (path:/tmp/pip-4Q2_DI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:18 INFO - Running setup.py (path:/tmp/pip-8oL3xY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:18 INFO - Running setup.py (path:/tmp/pip-QLMz8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:18 INFO - Running setup.py (path:/tmp/pip-MRr5wR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:18 INFO - Running setup.py (path:/tmp/pip-wpsa6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:18 INFO - Running setup.py (path:/tmp/pip-DdfoBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:19 INFO - Running setup.py (path:/tmp/pip-3O6cqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:19 INFO - Running setup.py (path:/tmp/pip-1_q6YY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:16:19 INFO - Running setup.py install for manifestparser 15:16:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Running setup.py install for mozcrash 15:16:19 INFO - Running setup.py install for mozdebug 15:16:19 INFO - Running setup.py install for mozdevice 15:16:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Running setup.py install for mozfile 15:16:19 INFO - Running setup.py install for mozhttpd 15:16:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Running setup.py install for mozinfo 15:16:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Running setup.py install for mozInstall 15:16:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:16:19 INFO - Running setup.py install for mozleak 15:16:20 INFO - Running setup.py install for mozlog 15:16:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:16:20 INFO - Running setup.py install for moznetwork 15:16:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:16:20 INFO - Running setup.py install for mozprocess 15:16:20 INFO - Running setup.py install for mozprofile 15:16:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:16:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:16:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:16:20 INFO - Running setup.py install for mozrunner 15:16:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:16:20 INFO - Running setup.py install for mozscreenshot 15:16:20 INFO - Running setup.py install for moztest 15:16:20 INFO - Running setup.py install for mozversion 15:16:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:16:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:16:20 INFO - Cleaning up... 15:16:20 INFO - Return code: 0 15:16:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:20 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')]} 15:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:20 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')]} 15:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:20 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 0x7f579a7fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b790>, '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 0x181c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181cb20>, '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': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', '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 15:16:20 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 15:16:20 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 15:16:20 INFO - Using env: {'DISPLAY': ':0', 15:16:20 INFO - 'HOME': '/home/cltbld', 15:16:20 INFO - 'LANG': 'en_US.UTF-8', 15:16:20 INFO - 'LANGUAGE': 'en_US:en', 15:16:20 INFO - 'LOGNAME': 'cltbld', 15:16:20 INFO - 'MAIL': '/var/mail/cltbld', 15:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:20 INFO - 'MOZ_NO_REMOTE': '1', 15:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:20 INFO - 'NO_EM_RESTART': '1', 15:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:20 INFO - 'PWD': '/builds/slave/test', 15:16:20 INFO - 'SHELL': '/bin/bash', 15:16:20 INFO - 'SHLVL': '1', 15:16:20 INFO - 'TERM': 'linux', 15:16:20 INFO - 'TMOUT': '86400', 15:16:20 INFO - 'USER': 'cltbld', 15:16:20 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', 15:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:20 INFO - '_': '/tools/buildbot/bin/python'} 15:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:21 INFO - Running setup.py (path:/tmp/pip-HG77CV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:21 INFO - Running setup.py (path:/tmp/pip-ldYEoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:21 INFO - Running setup.py (path:/tmp/pip-M2ziBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:21 INFO - Running setup.py (path:/tmp/pip-CAFOGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:21 INFO - Running setup.py (path:/tmp/pip-TypajP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:21 INFO - Running setup.py (path:/tmp/pip-7DVMEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:21 INFO - Running setup.py (path:/tmp/pip-lC19lO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:21 INFO - Running setup.py (path:/tmp/pip-v9WC03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:21 INFO - Running setup.py (path:/tmp/pip-YSSa37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:21 INFO - Running setup.py (path:/tmp/pip-86VORJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:21 INFO - Running setup.py (path:/tmp/pip-TXWRr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:21 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)) 15:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:22 INFO - Running setup.py (path:/tmp/pip-ZtxWqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:22 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)) 15:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:22 INFO - Running setup.py (path:/tmp/pip-l0hqzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:22 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)) 15:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:22 INFO - Running setup.py (path:/tmp/pip-OBSE89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 15:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:22 INFO - Running setup.py (path:/tmp/pip-ovJWIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:22 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)) 15:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:22 INFO - Running setup.py (path:/tmp/pip-LdSkUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:22 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)) 15:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:22 INFO - Running setup.py (path:/tmp/pip-rBpwxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:22 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)) 15:16:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:16:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:16:22 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)) 15:16:22 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)) 15:16:22 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)) 15:16:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:24 INFO - Downloading blessings-1.6.tar.gz 15:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:16:24 INFO - Installing collected packages: blessings 15:16:24 INFO - Running setup.py install for blessings 15:16:24 INFO - Successfully installed blessings 15:16:24 INFO - Cleaning up... 15:16:24 INFO - Return code: 0 15:16:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:16:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:24 INFO - Reading from file tmpfile_stdout 15:16:24 INFO - Current package versions: 15:16:24 INFO - argparse == 1.2.1 15:16:24 INFO - blessings == 1.6 15:16:24 INFO - blobuploader == 1.2.4 15:16:24 INFO - docopt == 0.6.1 15:16:24 INFO - functools32 == 3.2.3-2 15:16:24 INFO - jsonschema == 2.5.1 15:16:24 INFO - manifestparser == 1.1 15:16:24 INFO - mozInstall == 1.12 15:16:24 INFO - mozcrash == 0.17 15:16:24 INFO - mozdebug == 0.1 15:16:24 INFO - mozdevice == 0.48 15:16:24 INFO - mozfile == 1.2 15:16:24 INFO - mozhttpd == 0.7 15:16:24 INFO - mozinfo == 0.9 15:16:24 INFO - mozleak == 0.1 15:16:24 INFO - mozlog == 3.4 15:16:24 INFO - moznetwork == 0.27 15:16:24 INFO - mozprocess == 0.23 15:16:24 INFO - mozprofile == 0.28 15:16:24 INFO - mozrunner == 6.12 15:16:24 INFO - mozscreenshot == 0.1 15:16:24 INFO - mozsystemmonitor == 0.3 15:16:24 INFO - moztest == 0.7 15:16:24 INFO - mozversion == 1.4 15:16:24 INFO - psutil == 3.1.1 15:16:24 INFO - requests == 1.2.3 15:16:24 INFO - wsgiref == 0.1.2 15:16:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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')]} 15:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:24 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 0x7f579a7fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b790>, '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 0x181c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181cb20>, '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': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', '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 15:16:24 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 15:16:24 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 15:16:24 INFO - Using env: {'DISPLAY': ':0', 15:16:24 INFO - 'HOME': '/home/cltbld', 15:16:24 INFO - 'LANG': 'en_US.UTF-8', 15:16:24 INFO - 'LANGUAGE': 'en_US:en', 15:16:24 INFO - 'LOGNAME': 'cltbld', 15:16:24 INFO - 'MAIL': '/var/mail/cltbld', 15:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:24 INFO - 'MOZ_NO_REMOTE': '1', 15:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:24 INFO - 'NO_EM_RESTART': '1', 15:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:24 INFO - 'PWD': '/builds/slave/test', 15:16:24 INFO - 'SHELL': '/bin/bash', 15:16:24 INFO - 'SHLVL': '1', 15:16:24 INFO - 'TERM': 'linux', 15:16:24 INFO - 'TMOUT': '86400', 15:16:24 INFO - 'USER': 'cltbld', 15:16:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', 15:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:24 INFO - '_': '/tools/buildbot/bin/python'} 15:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 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)) 15:16:25 INFO - Cleaning up... 15:16:25 INFO - Return code: 0 15:16:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:16:25 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')]} 15:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:25 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')]} 15:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:25 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 0x7f579a7fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181b790>, '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 0x181c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181cb20>, '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': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', '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 15:16:25 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 15:16:25 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 15:16:25 INFO - Using env: {'DISPLAY': ':0', 15:16:25 INFO - 'HOME': '/home/cltbld', 15:16:25 INFO - 'LANG': 'en_US.UTF-8', 15:16:25 INFO - 'LANGUAGE': 'en_US:en', 15:16:25 INFO - 'LOGNAME': 'cltbld', 15:16:25 INFO - 'MAIL': '/var/mail/cltbld', 15:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:25 INFO - 'MOZ_NO_REMOTE': '1', 15:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:25 INFO - 'NO_EM_RESTART': '1', 15:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:25 INFO - 'PWD': '/builds/slave/test', 15:16:25 INFO - 'SHELL': '/bin/bash', 15:16:25 INFO - 'SHLVL': '1', 15:16:25 INFO - 'TERM': 'linux', 15:16:25 INFO - 'TMOUT': '86400', 15:16:25 INFO - 'USER': 'cltbld', 15:16:25 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', 15:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:25 INFO - '_': '/tools/buildbot/bin/python'} 15:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:16:25 INFO - Cleaning up... 15:16:25 INFO - Return code: 0 15:16:25 INFO - Running post-action listener: _resource_record_post_action 15:16:25 INFO - Running post-action listener: _start_resource_monitoring 15:16:25 INFO - Starting resource monitoring. 15:16:25 INFO - [mozharness: 2016-10-23 22:16:25.347924Z] Finished create-virtualenv step (success) 15:16:25 INFO - [mozharness: 2016-10-23 22:16:25.348479Z] Running install step. 15:16:25 INFO - Running pre-action listener: _resource_record_pre_action 15:16:25 INFO - Running main action method: install 15:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:25 INFO - Reading from file tmpfile_stdout 15:16:25 INFO - Detecting whether we're running mozinstall >=1.0... 15:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:16:25 INFO - Reading from file tmpfile_stdout 15:16:25 INFO - Output received: 15:16:25 INFO - Usage: mozinstall [options] installer 15:16:25 INFO - Options: 15:16:25 INFO - -h, --help show this help message and exit 15:16:25 INFO - -d DEST, --destination=DEST 15:16:25 INFO - Directory to install application into. [default: 15:16:25 INFO - "/builds/slave/test"] 15:16:25 INFO - --app=APP Application being installed. [default: firefox] 15:16:25 INFO - mkdir: /builds/slave/test/build/application 15:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:16:43 INFO - Reading from file tmpfile_stdout 15:16:43 INFO - Output received: 15:16:43 INFO - /builds/slave/test/build/application/firefox/firefox 15:16:43 INFO - Running post-action listener: _resource_record_post_action 15:16:43 INFO - [mozharness: 2016-10-23 22:16:43.920717Z] Finished install step (success) 15:16:43 INFO - [mozharness: 2016-10-23 22:16:43.920964Z] Running run-tests step. 15:16:43 INFO - Running pre-action listener: _resource_record_pre_action 15:16:43 INFO - Running main action method: run_tests 15:16:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:16:43 INFO - Python 2.7.3 15:16:43 INFO - Return code: 0 15:16:43 INFO - grabbing minidump binary from tooltool 15:16:43 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')]} 15:16:43 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 0x181b790>, '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 0x181c690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:16:43 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 15:16:43 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 15:16:43 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 15:16:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:16:43 INFO - Return code: 0 15:16:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:16:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:16:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:16:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:16:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 15:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 15:16:44 INFO - Using env: {'DISPLAY': ':0', 15:16:44 INFO - 'HOME': '/home/cltbld', 15:16:44 INFO - 'LANG': 'en_US.UTF-8', 15:16:44 INFO - 'LANGUAGE': 'en_US:en', 15:16:44 INFO - 'LOGNAME': 'cltbld', 15:16:44 INFO - 'MAIL': '/var/mail/cltbld', 15:16:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:16:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:44 INFO - 'MOZ_NO_REMOTE': '1', 15:16:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:44 INFO - 'NO_EM_RESTART': '1', 15:16:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:44 INFO - 'PWD': '/builds/slave/test', 15:16:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:16:44 INFO - 'SHELL': '/bin/bash', 15:16:44 INFO - 'SHLVL': '1', 15:16:44 INFO - 'TERM': 'linux', 15:16:44 INFO - 'TMOUT': '86400', 15:16:44 INFO - 'USER': 'cltbld', 15:16:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915', 15:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:44 INFO - '_': '/tools/buildbot/bin/python'} 15:16:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 15:16:44 INFO - mozversion application_buildid: 20161023123006 15:16:44 INFO - mozversion application_changeset: a9a41b69f3f9be494ae0653601c08aa388d9afe4 15:16:44 INFO - mozversion application_display_name: Nightly 15:16:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:16:44 INFO - mozversion application_name: Firefox 15:16:44 INFO - mozversion application_remotingname: firefox 15:16:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:16:44 INFO - mozversion application_vendor: Mozilla 15:16:44 INFO - mozversion application_version: 52.0a1 15:16:44 INFO - mozversion platform_buildid: 20161023123006 15:16:44 INFO - mozversion platform_changeset: a9a41b69f3f9be494ae0653601c08aa388d9afe4 15:16:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:16:44 INFO - mozversion platform_version: 52.0a1 15:16:44 INFO - using testdate: 1477261004 15:16:44 INFO - actual date: 1477261004 15:16:44 INFO - starting webserver on 'localhost:58026' 15:16:44 INFO - SUITE-START | Running 2 tests 15:16:44 INFO - TEST-START | dromaeo_css 15:16:44 INFO - operating with platform_type : linux_ 15:16:44 INFO - Initialising browser for dromaeo_css test... 15:16:44 INFO - TEST-INFO | started process 18514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDo8XMi/profile http://localhost:58026/getInfo.html) 15:16:48 INFO - PROCESS | 18514 | __metrics Screen width/height:1600/1200 15:16:48 INFO - PROCESS | 18514 | colorDepth:24 15:16:48 INFO - PROCESS | 18514 | Browser inner width/height: 1024/697 15:16:48 INFO - PROCESS | 18514 | __metrics 15:16:49 INFO - PROCESS | 18514 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:16:49 INFO - PROCESS | 18514 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:16:50 INFO - PROCESS | 18514 | console.error: PushService: 15:16:50 INFO - PROCESS | 18514 | stateChangeProcessEnqueue: Error transitioning state 15:16:50 INFO - PROCESS | 18514 | UnknownError 15:16:51 INFO - TEST-INFO | 18514: exit 0 15:16:51 INFO - Browser initialized. 15:16:51 INFO - Running cycle 1/1 for dromaeo_css test... 15:16:51 INFO - TEST-INFO | started process 18597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDo8XMi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:17:03 INFO - PROCESS | 18597 | RSS: Main: 171905024 15:17:03 INFO - PROCESS | 18597 | 15:17:54 INFO - PROCESS | 18597 | 1477261074229 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] 15:20:05 INFO - PROCESS | 18597 | Cycle 1(1): loaded http://localhost:58026/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58026/tests/dromaeo/cssquery-ext.html) 15:20:07 INFO - PROCESS | 18597 | RSS: Main: 390049792 15:20:07 INFO - PROCESS | 18597 | 15:23:10 INFO - PROCESS | 18597 | Cycle 1(1): loaded http://localhost:58026/tests/dromaeo/cssquery-ext.html (next: http://localhost:58026/tests/dromaeo/cssquery-jquery.html) 15:23:11 INFO - PROCESS | 18597 | RSS: Main: 280076288 15:23:11 INFO - PROCESS | 18597 | 15:26:13 INFO - PROCESS | 18597 | Cycle 1(1): loaded http://localhost:58026/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58026/tests/dromaeo/cssquery-mootools.html) 15:26:14 INFO - PROCESS | 18597 | RSS: Main: 218873856 15:26:14 INFO - PROCESS | 18597 | 15:29:16 INFO - PROCESS | 18597 | Cycle 1(1): loaded http://localhost:58026/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58026/tests/dromaeo/cssquery-prototype.html) 15:29:16 INFO - PROCESS | 18597 | RSS: Main: 266964992 15:29:16 INFO - PROCESS | 18597 | 15:32:19 INFO - PROCESS | 18597 | Cycle 1(1): loaded http://localhost:58026/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58026/tests/dromaeo/cssquery-yui.html) 15:32:19 INFO - PROCESS | 18597 | RSS: Main: 219164672 15:32:19 INFO - PROCESS | 18597 | 15:35:23 INFO - PROCESS | 18597 | Cycle 1(1): loaded http://localhost:58026/tests/dromaeo/cssquery-yui.html (next: http://localhost:58026/tests/dromaeo/cssquery-dojo.html) 15:35:23 INFO - PROCESS | 18597 | RSS: Main: 306962432 15:35:23 INFO - PROCESS | 18597 | 15:35:23 INFO - PROCESS | 18597 | __start_tp_report 15:35:23 INFO - PROCESS | 18597 | _x_x_mozilla_page_load 15:35:23 INFO - PROCESS | 18597 | _x_x_mozilla_page_load_details 15:35:23 INFO - PROCESS | 18597 | |i|pagename|runs| 15:35:23 INFO - PROCESS | 18597 | |0;dojo.html;3092.876284948602;3106.238971451993;3122.781405301629;3142.214446388403;3165.208697825544;5199.948000519994;5316.20256961456;5361.7587208575615;5447.836564903055;5460.126379779231;5307.20391941209;5316.9202461963105;5331.147016477365;5332.440093790155;5340.732963351837;4818.277258411232;4865.19724245499;4891;4949.50504949504;4965.602751779849;4936.975315123437;4946.925796113062;4954.529319714621;4988.32657591226;4992.700437973715;4855.781489832948;4939.234418665094;4943.9752801235945;5030.11972904742;5071.061853557104;5014.974925125388;5030.144875371196;5038.672486288417;5073.543381095701;5095.923561146586;4700.5064468230685;4751.097291514636;4752.287156926454;4910.042541704369;4965.131102057126;5203.219517072432;5258.97370513145;5260.92108618371;5268.841934741964;5288.894222115536;5736.368999410061;5774.162746401748;5784.1902133701315;5834.241548598655;5843.298804143487;5813.157092221646;5835.328937172195;5884.588078834483;5895;5898.026825573776;5278.261043453919;5464.808731694372;5477.616566840363;5478.534324582375;5479.205515200353;5777.88444231113;5794.942050579441;5870.73581688825;5870.911936320958;5917.763289468373;5632.549396048306;5639.915401268984;5643.068893632587;5646.096624540054;5648.237487939075;5708.828735137952;5725.713714314267;5726.627769194989;5729.226554415184;5737.684427356452;5563.860903477445;5580.274564306615;5611.719414029282;5680.914786278209;5759.539236861041;5766.538676905838;5773.134029895549;5825.1844741736195;5827.504662103769;5828.329742079631;4386.649068074546;4386.64906807461;4388.780560971939;4389.056352884145;4442.933355999663;3852.3836186210074;3886.7667939923695;3920.2943470175073;3922.3920292354733;3955.3671412574427;5293.206019097166;5300.814471493479;5309.814156504503;5380.973095134499;5403.189521571796;5632.493075623213;5685.459881311352;5686.14707793826;5693.829185124453;5694.202811606296;5273.156294992783;5328.3605967284175;5345.786168553214;5353.4646535346155;5407.972960135174;4767.570918617341;4818.831340903122;4860.586850117709;4878.243872199815;4888.828890988798;5808.099744539603;5811.3026436827;5814.680192589448;5819.5635327351465;5878.970605146947;5615.803446879339;5628.071368224197;5652.68910209926;5654.745536450787;5673.914891276717;5796.62321949072;5800.796972105956;5853.707314634166;5865.501432378295;5930.021546444961;5655.179998900054;5656.208130861765;5669.639286571276;5718.085106382959;5724.398938111605;5691.203231547669;5730.512906402836;5737.139429085671;5737.139429085671;5738.799142030009;5503.422140675171;5552.7223638818705;5562.666240025612;5636.915446268391;5641.40765219646;5544.0575102231915;5545.223668686306;5550.056490396723;5557.36090349615;5566.471185237396;5545.390007099135;5589.972050139723;5593.860153496195;5597.356304025089;5603.663780173202;5663.235463212578;5683.147527870852;5688.7440065198;5688.800891968926;5692.032354499662;5528.226048353154;5530.336359636708;5531.557475402039;5539.695316757617;5552.250446189712 15:35:23 INFO - PROCESS | 18597 | |1;ext.html;589.2369381650759;592.8014115271385;602.9427204415582;615.7598536570737;616.8612062285989;31309.530357044634;41355.58644413559;42535.36196957044;42607.573924260745;45472;42936.141277174516;43288.78355608226;43315;43317.35023974635;43384.783076084575;8046.839063218732;8758.255548278388;8916.108389161096;8920.330975176888;8926.285897128246;7913.960430197841;10274.537645805956;10519.526621302022;10522.053015228628;10918.399488028155;10355.585776568929;10402;10408.06327430531;10413.479326033706;10416.63541776038;10615.46922653868;10692.679219623424;10710;10723;10727.946360268148;10428.217883658755;10489.947550262199;10494.317869338469;10496.790064198673;10497.895021049768;40326.39510407346;40696;40753;40753.796231018954;40773;3466.30673865228;3477.930441391158;3834.175652234783;4013.4381186633605;4019.718619696622;30334.393312133634;30962;31304;31330.530042049388;31365;3791.184895247535;3849.268638958617;3915.725899187058;4060.796960151981;4106.117184805281;309463.4526827374;314138;314776;315451;315491;54531.454685452634;55146.44853551413;55315.446845531835;55348.446515535135;55365.44634553603;56666.433335666115;56832.71583642055;56838.71580642153;56859;56860.715696421255;16003.679926401406;16301.918490407472;16317.428889988794;16318.75521867173;16323.836761632469;10829.566817327377;11000.559977600806;12028;12045.21706089119;12103.576374826838;14494.275286235646;15241.23793810305;15368.310545654465;15396.07623542591;15545.533633990999;6199.628022318675;6329.2721337045905;6331.145295385156;6444.935550644527;6452.225732911987;911.3074063711626;1010.7018429563296;1035.6064695415694;1040.6877936618985;1047.4762618690654;30511.38977220443;30649.84675076655;30692.168487987212;30955.81493321447;30962;1077.8221593436995;1086.5002099034532;1099.5381939585393;1104.2270410712533;1125.7917285302244;15755.68488630221;16234.675306493804;16385.262663180187;16407.343706251853;16587.751183732253;455344;457072;457662;457837;457901;56545.71727141338;56637.43362566404;56684.76467588562;56692.71653641705;56723;1257.8050402187675;1289.1684863263142;1296.682312833362;1302.615728360136;1323.3912400295972;28710.13869583916;30287;30408.239794005327;30886.055753055974;31010;48706.26940595823;48964;49028.75485622549;49099.75450122727;49109.50890491049;379000;380477;380849;382717;383159;38097.80951095227;38875.80562097171;38903.61096389113;39080;39417.21165576615;44607.55392446164;44916.326255106855;45626.54373456223;46160.07679846451;46948.7652561735;36872.63127368692;37357.62642373541;37758.43362349622;38728.031799205244;39107.6089239104;37520.62479375171;37839.43240851445;38231;38362;38867;39088.80455597704;39531.60468395394;39605.80197098996;39670.404943925285;39680.2063958725;32744;33956.83021584975;34694;35276.47085293774;35432;26826.463470730087;27612.129528810157;27704.584431233143;27765.167044988684;28065.719342807126 15:35:23 INFO - PROCESS | 18597 | |2;jquery.html;355.88255875561066;374.54305746988666;379.38603025156675;384.7710612185749;414.9792510374481;14191.57425277242;14686.779698304521;18563.814361856377;18721.251149953987;18774.873507589553;17328.480145595622;17855.19651615677;17886.73169902449;18016.819831801677;18036.368727094556;4118.917621647565;5445.074337362648;5687.374388817227;5689.516391106761;5694.430556944314;4149.522804877448;4277.679174061942;4525.886852828673;6215.223097112861;6292.402221788922;6022.307434645006;6307.747690092391;6318.399752023551;6340.714667839959;6346.714397852084;6322.114903913456;6330.366963303679;6361.522885783585;6370.968145159268;6372.5857819242065;5445.53712934401;5616.382197958222;5622.128570071645;5652.63257888236;5654.208410822488;20559.58880822375;21239.044243009103;21413.250536231157;22136.557268854533;22343.66484502734;2218.234709025384;2304.7925686688277;2334.8132149428006;2532.278300684296;2688.569828827398;10038.096571308544;10187.694369168938;13745.656358591015;13805.723885522333;14696.338664760004;1869.579344647457;1903.0960293860444;1928.5275107598727;1938.3524004596122;1947.191915355126;55543.722281388335;60644;64146;77144;81222.59388703019;9424.151826335663;9948.204143668489;10135.898641013642;10167.4916254187;11027.070262703995;14702.485413010707;14929.328180231916;14985.32566034531;15061.397544098114;15069.849301507064;7846.686132554634;7976.122626511079;8065.112837587861;8179.0594081681365;8201.13888041759;7471.402287816962;7772.45592808498;7791.142974272825;7824.178461261599;7980.042394912648;4531.520592392038;4542.454905411306;4556.612687921497;4617.561331673485;4650.37219975299;1883.9905800471183;1901.9334323298895;1912.3689182569997;1918.8656794024284;1922.3656193456127;963.2534785541121;990.2177279948904;990.2622546203124;1008.7276435362411;1012.6405126180247;17483.808516371242;18322.35871744509;18460.81539184591;18490.907545462185;18869.528261793566;954.0316578672653;967.7580604848788;968.5254225429629;991.0931497679686;1036.3419228789621;9835.803283934281;10093.798124037477;10188.949055254676;10219.13137383316;10347.948260258801;416468;424043;425312;427770;430754;55688;64971;84391;85578;85630.57184714162;961.5576834655997;968.4528241543646;993.7515621094726;1001.1690297053428;1008.0423597582326;15695;16041.35834566651;16268.837311626732;16283.267252973881;16582.419615313407;40705.79647101746;41219;41286.58713412948;41546.79226603848;41627.7918610405;55452.44547554473;56626;57072.42927570671;57834;59061.70469147627;7158.785236442915;7343.669534871051;7497.550146991198;7837.1770964047955;7973.242541958504;11251.606193783178;12749.235045897276;12758.425870835648;13152.73694526085;13275;10887.836682449612;11349.602763903555;11421.771564568828;11424.71438214018;11948.34284114382;10983.61557345521;11110.888891111308;11141.108711303239;11233.831492527783;11470.369129697947;11343;11509.13681473876;11928.522859085539;11934.58228962017;12035.277883327028;7621.428392870668;7646.120696119795;7801.29788319054;7850.528968261922;7890.092639346549;9928.404295742279;11346.262492938264;11654.592089276835;11872;11895.464704088165 15:35:23 INFO - PROCESS | 18597 | |3;mootools.html;1339.8780840641307;1471.2349578219325;1501.4894935721854;1619.5060506545506;1738.8000379956302;7708.730194443188;8698.086700896401;8955.059718729537;8965.955170224148;9210.078992100787;9038;9107.453552786837;9112.043235460264;9119.361644684876;9122.042185570519;2343.800776933963;2366.372911178539;2372.738998710149;2373.050779688121;2379.95240095198;2295.8048565871923;2322.7328857181387;2350.21267875262;2353.599888019041;2356.599378105726;2284.7029886114783;2293.20884294918;2296.517731276434;2344.2732752846587;2348.5889969255313;2292.3695983604475;2300.942476438094;2302.631578947369;2318.4088057545387;2333.381653861728;2204.570108828779;2205.735311762599;2211.1266049910355;2219.2454565447665;2221.133757834446;8808.471491710454;8860;8952.239059679934;8954.328425368058;8960;5062.873428164326;5247.685138891678;5252.474752524755;5254.15933450646;5268.6575372600655;3250;3365.495175723661;3409.2670075933793;3420.9315813683834;3430.451127819537;1097.3635291530893;1127.408110741859;1130.0446646174696;1158.4092113022334;1159.287038471334;12522.68693282666;12563.057770667145;12623.431945562379;12633.178843375243;12650.304233267167;4306.440162778818;4456.487503937024;4537.977310113494;4597.839075632403;4602.424696912886;9908.504574771232;9912.107910288109;9937.354071985297;9955.50222488887;9972.301938864355;5183.041137389595;5196.402413722395;5207.713575753294;5209.921851172236;5248.6588371755715;4223.239816832999;4294.957050429518;4356.542563030836;4752.144613969519;4852.684575502581;3609.9097522562147;3654.853805847736;3728.7762734236035;3801.6198380161763;3808.5239345081864;1145.3013661666378;1160.8374827524153;1179.4397661110904;1180.1738782852037;1188.5245901639414;847.5677404523738;888.9110839221902;948.4830767231875;957.0333962697587;961.6634178037631;5828.184054232411;5829.912551311733;5905.793297234576;6050.6672133032225;6248.4688801452385;439.68782164663446;441.41953331369785;441.79456552703147;452.4186420449706;452.48190821509843;3946.861859834892;3973.1457736586194;4119.608637179464;4129.421880936671;4168.312228482267;10932;11172.273802202832;11285.887141128647;11311.886881131248;11312.830307545393;11204.271722338022;11210.495527701272;11215.66353009411;11218.382988935688;11227.214095013434;7837.451378403571;8152.755417337489;8306.70926517569;8386.580670966427;8415.95792021036;5915.733791979285;5927.762889484372;5955.821325360246;6097.359777223328;6138.14066030765;9905.752356191153;10117.342372745748;10169.542370593193;10343.948280258852;10433.26967112295;10139.847902281324;10325.328853624791;10404.97103064895;10492.370457772558;10550.208734345108;7121.893171602326;7293.562386256842;7750.8449831001935;7848.372130229682;7898.723544675909;8171.918280817354;8542.18849209324;8548.91451085506;8562.52906090171;8734.69428569997;7849.803754906173;8024.518528888286;8138.674453021813;8205.95897020511;8264.421490495608;7903.802404939693;7933.722319719013;7975.960120199594;8003.839923201387;8154.429189956646;6985.755498557526;7098.538594991309;7106.218315985134;7118.893216601651;7119.430445564239;5271.578273738169;5318.680879147263;5414.729263536886;5423.538999185113;5631.6902570359025;5228.921566176435;5232.921506177487;5275.287836142072;5313.920291195558;5319.627626066293 15:35:23 INFO - PROCESS | 18597 | |4;prototype.html;319.9457786593177;326.7843223472508;327.08905697632093;331.64853223115796;338.5345150418175;5060.999999999991;5180.663256888304;5193.792248310073;5244.659097158687;5249.790008399665;5015.67398119122;5140.8971820563565;5146.897062058757;5159.50984656458;5175.767090480928;4070.7230679303075;4083.5508094109623;4097.323941549641;4117.21772863155;4120.134771697947;3965.1474932889423;4102.938455923164;4114.177164567083;4119.36149896765;4122.690798190133;4059.9797001014954;4063.5326937402283;4088.5298190708004;4092.815823287944;4099.405586190001;4045.271851066807;4052.2300762855257;4056.1076563156057;4062.6546743526687;4089.89775255618;3653.853845846163;3670.2475992421755;3687.6681098701247;3697.205100903319;3698.685611723007;4919.77860996256;5101.20931255656;5119;5142.742862856842;5173.249878767595;4734.384530011111;4774.832880849153;4788.832390866338;4794.232922732346;4814.229723244264;5522.30971128609;5558.166275058733;5563.8887222255735;5597.104463285855;5616.185653080281;3925.8625948091967;3986.202759448122;4014.859479918218;4022.839086436539;4074.9185016299507;5618.578606604521;5618.719064046782;5638.887222255573;5663.348714897798;5733.770649174028;4126.773027483458;4131.97934010328;4140.523839758406;4141.97929010353;4149.190907773016;4096.160287141129;4178.12259425518;4183.560726123774;4193.119444916601;4216.978915105405;4695.154872123051;4708.340832283483;4713.198756211452;4713.34013238147;4722.763861806965;5437.782488700408;5457.372402173801;5460.481254280837;5496.615236933376;5528.258598541446;1331.9866801331862;1335.8063080853221;1380.751464736357;1416.8937329700314;1431.1627697796698;916.5371487398954;930.4463844012802;942.58997336159;945.4421891084294;953.2612225525273;4652.906941861143;4658.765427161805;4661.976690116528;4687.39063921688;4708.223143181405;4825.638077144228;4828.493008234155;4882.340883980617;4911.7544122793715;4921.926171107436;4616.6537509686905;4622.335959054738;4628.305754136839;4662.953370466252;4685.719996002812;2785.846778427206;2992.5959995400344;3002.7297543221216;3005.7595392368557;3007.7443417309337;5858.736356863951;5862.530997520188;5863.736131874076;5866.6480011199465;5886.3230728465915;5414.675119492765;5589.636673616202;5594.300712410949;5770.913436298459;5786.164779258133;5740;5762.855928601734;5763.337216220105;5772.39389864075;5792.82621521355;5603.159526071122;5633.746481408264;5637.5892584985495;5668.744906479136;5671.8865622688145;5343.973280133574;5456.590755693418;5500.669959802424;5513.669179849222;5539.501444869981;5725.627834190765;5732.455416735404;5733.856653583527;5748.597598168088;5833.708314584339;3898.961010389973;3981.3629819228786;3984.2629113614075;3987.6809855212095;3997.2605068062503;5267.3152490176035;5509.449055094458;5529.585281104014;5535.667859928417;5560.805371811967;5320.494553017457;5320.733963301896;5483.588730845282;5492.533134683436;5501.972490137524;5482.5613950884635;5488.368837583569;5502.834914952397;5537.501624853782;5553.250311207935;5258.763355649082;5468;5497.917531236954;5502.184279187938;5512.940318123319;5486.286782718221;5503.339599247955;5516.834494965157;5517.834464966058;5518.972405138109;5346.278252436027;5407.161889907071;5408.783648654167;5433.728313584226;5447.455254474521 15:35:23 INFO - PROCESS | 18597 | |5;yui.html;699.3181647893304;768.1895600141852;771.8031901865023;821.0885916632539;823.5058964621225;15733.292001859914;16456.753148702777;16468.835311646893;16473.258703358348;16496.587585310357;14843.257837108154;14949.701005979901;14955.925220373883;14976.700465990674;14992.325345359457;641.5573254454434;657.5955787190867;762.1920763990161;763.8968739220204;778.3578547698144;787.122358570193;787.3779714025912;793.6587267474983;794.0154208781099;794.3208556684039;833.8165603567205;837.9120192379804;838.3921656798833;839.1524560194187;839.3033781960988;678.1963373402484;833.2667252817542;833.8415701016787;834.0866750907777;834.64110432514;507.64972169203503;588.9676067816268;602.2892986276192;603.3031848215319;606.3269770554681;15077.924610376987;15121.243937803067;15123.168225747579;15123.395064197419;15141.318640661197;13856.307184640727;14037.859621403757;14767.483138090116;14779.482718104815;14906.776398354034;11529.135314851419;11700.414979251003;11748.412579370997;11809.23239989398;11868.05055595559;4342.652587792969;4364.759938203398;4421.9336709949375;4435.223835828717;4506.346579745951;82186;82205.58897205535;82289.29698163597;83030.58484707598;83288;10898.509567069501;10938.398388088572;11033.889661103447;11220.66338009861;11454.54181832734;18848.62302753965;18866.528336791416;18908.71636925447;18943.33698320552;18961.241550337832;8501.628013823125;8656.394052416397;8762.693305734269;8935.553222338856;8942.50816205115;4565.771711414416;4578.061497393093;4674.345591617176;4696.319033740157;4835.202191638411;3353.480210567366;3777.6411240932066;3975.860844870416;3976.264391087658;4018.0959284161413;641.7625478572958;647.795944277551;660.0363469334825;663.9203295604461;678.9219239787388;671.1208317104608;671.7313074770034;688.7382794538044;694.8193469697915;708.7200555780438;9206.723798285928;9325.953370233105;9335.159835614828;9605.327627066177;9616.423014619146;547.2584647802171;654.9541532092803;679.6771533521538;715.7172916697979;716.7101111947383;4327.729210928315;4405.603495685404;4588.197065513522;4789.234905065037;4866.343043689057;68592.97110543346;69141.65429172822;69176.30823691799;70031.64984175148;85004;103505;105401;105905;109009;109648.4517577407;93903.53048234715;94111.52944235234;94193;96119.51940240254;96958;8585.270252028648;8691.217790398894;9004.234640055407;9009.36934414611;9327.533623318943;47104.29343559781;47217.527824721314;47733.284000739324;50904.78640248124;51281.743591281804;59197;71877.64061179661;73491.26508735058;75098;75104.24895750973;12108.273503589813;12212.694682633006;12676.809847852106;12697;13005.21968681882;12937.288449135387;13506.189628621922;13871.583852484442;14102.78845817293;14730.926345368205;12293.323867187391;12330.63008109758;12467.438965246767;12582.622521324374;12973.935130324666;11630.847029077184;11839.28964262147;12012.879871201176;12415.255084694947;12463.314517701614;11570.85865218033;11694.854264123758;11735.295882246752;11971.64085077449;12180.976216524059;9772.911799719937;10289.5908669793;10344.637937672145;10402.427866467417;10579;10092.596296148073;10103.696889093339;10110.848337275094;10238.948805255926;10349.896501034893 15:35:23 INFO - PROCESS | 18597 | __end_tp_report 15:35:23 INFO - PROCESS | 18597 | __start_cc_report 15:35:23 INFO - PROCESS | 18597 | _x_x_mozilla_cycle_collect,2304 15:35:23 INFO - PROCESS | 18597 | __end_cc_report 15:35:23 INFO - PROCESS | 18597 | __startTimestamp1477262123310__endTimestamp 15:35:23 INFO - PROCESS | 18597 | 15:35:23 INFO - PROCESS | 18597 | ------- Summary: start ------- 15:35:23 INFO - PROCESS | 18597 | Number of tests: 6 15:35:23 INFO - PROCESS | 18597 | 15:35:23 INFO - PROCESS | 18597 | [#0] dojo.html Cycles:165 Average:5323.97 Median:5545.39 stddev:593.94 (10.7%) stddev-sans-first:569.39 15:35:23 INFO - PROCESS | 18597 | Values: 3092.9 3106.2 3122.8 3142.2 3165.2 5199.9 5316.2 5361.8 5447.8 5460.1 5307.2 5316.9 5331.1 5332.4 5340.7 4818.3 4865.2 4891.0 4949.5 4965.6 4937.0 4946.9 4954.5 4988.3 4992.7 4855.8 4939.2 4944.0 5030.1 5071.1 5015.0 5030.1 5038.7 5073.5 5095.9 4700.5 4751.1 4752.3 4910.0 4965.1 5203.2 5259.0 5260.9 5268.8 5288.9 5736.4 5774.2 5784.2 5834.2 5843.3 5813.2 5835.3 5884.6 5895.0 5898.0 5278.3 5464.8 5477.6 5478.5 5479.2 5777.9 5794.9 5870.7 5870.9 5917.8 5632.5 5639.9 5643.1 5646.1 5648.2 5708.8 5725.7 5726.6 5729.2 5737.7 5563.9 5580.3 5611.7 5680.9 5759.5 5766.5 5773.1 5825.2 5827.5 5828.3 4386.6 4386.6 4388.8 4389.1 4442.9 3852.4 3886.8 3920.3 3922.4 3955.4 5293.2 5300.8 5309.8 5381.0 5403.2 5632.5 5685.5 5686.1 5693.8 5694.2 5273.2 5328.4 5345.8 5353.5 5408.0 4767.6 4818.8 4860.6 4878.2 4888.8 5808.1 5811.3 5814.7 5819.6 5879.0 5615.8 5628.1 5652.7 5654.7 5673.9 5796.6 5800.8 5853.7 5865.5 5930.0 5655.2 5656.2 5669.6 5718.1 5724.4 5691.2 5730.5 5737.1 5737.1 5738.8 5503.4 5552.7 5562.7 5636.9 5641.4 5544.1 5545.2 5550.1 5557.4 5566.5 5545.4 5590.0 5593.9 5597.4 5603.7 5663.2 5683.1 5688.7 5688.8 5692.0 5528.2 5530.3 5531.6 5539.7 5552.3 15:35:23 INFO - PROCESS | 18597 | 15:35:23 INFO - PROCESS | 18597 | [#1] ext.html Cycles:180 Average:54900.08 Median:208419.72 stddev:102448.43 (49.2%) stddev-sans-first:102654.67 15:35:23 INFO - PROCESS | 18597 | Values: 589.2 592.8 602.9 615.8 616.9 31309.5 41355.6 42535.4 42607.6 45472.0 42936.1 43288.8 43315.0 43317.4 43384.8 8046.8 8758.3 8916.1 8920.3 8926.3 7914.0 10274.5 10519.5 10522.1 10918.4 10355.6 10402.0 10408.1 10413.5 10416.6 10615.5 10692.7 10710.0 10723.0 10727.9 10428.2 10489.9 10494.3 10496.8 10497.9 40326.4 40696.0 40753.0 40753.8 40773.0 3466.3 3477.9 3834.2 4013.4 4019.7 30334.4 30962.0 31304.0 31330.5 31365.0 3791.2 3849.3 3915.7 4060.8 4106.1 309463.5 314138.0 314776.0 315451.0 315491.0 54531.5 55146.4 55315.4 55348.4 55365.4 56666.4 56832.7 56838.7 56859.0 56860.7 16003.7 16301.9 16317.4 16318.8 16323.8 10829.6 11000.6 12028.0 12045.2 12103.6 14494.3 15241.2 15368.3 15396.1 15545.5 6199.6 6329.3 6331.1 6444.9 6452.2 911.3 1010.7 1035.6 1040.7 1047.5 30511.4 30649.8 30692.2 30955.8 30962.0 1077.8 1086.5 1099.5 1104.2 1125.8 15755.7 16234.7 16385.3 16407.3 16587.8 455344.0 457072.0 457662.0 457837.0 457901.0 56545.7 56637.4 56684.8 56692.7 56723.0 1257.8 1289.2 1296.7 1302.6 1323.4 28710.1 30287.0 30408.2 30886.1 31010.0 48706.3 48964.0 49028.8 49099.8 49109.5 379000.0 380477.0 380849.0 382717.0 383159.0 38097.8 38875.8 38903.6 39080.0 39417.2 44607.6 44916.3 45626.5 46160.1 46948.8 36872.6 37357.6 37758.4 38728.0 39107.6 37520.6 37839.4 38231.0 38362.0 38867.0 39088.8 39531.6 39605.8 39670.4 39680.2 32744.0 33956.8 34694.0 35276.5 35432.0 26826.5 27612.1 27704.6 27765.2 28065.7 15:35:23 INFO - PROCESS | 18597 | 15:35:23 INFO - PROCESS | 18597 | [#2] jquery.html Cycles:180 Average:26033.02 Median:22412.36 stddev:69919.00 (312.0%) stddev-sans-first:70088.56 15:35:23 INFO - PROCESS | 18597 | Values: 355.9 374.5 379.4 384.8 415.0 14191.6 14686.8 18563.8 18721.3 18774.9 17328.5 17855.2 17886.7 18016.8 18036.4 4118.9 5445.1 5687.4 5689.5 5694.4 4149.5 4277.7 4525.9 6215.2 6292.4 6022.3 6307.7 6318.4 6340.7 6346.7 6322.1 6330.4 6361.5 6371.0 6372.6 5445.5 5616.4 5622.1 5652.6 5654.2 20559.6 21239.0 21413.3 22136.6 22343.7 2218.2 2304.8 2334.8 2532.3 2688.6 10038.1 10187.7 13745.7 13805.7 14696.3 1869.6 1903.1 1928.5 1938.4 1947.2 55543.7 60644.0 64146.0 77144.0 81222.6 9424.2 9948.2 10135.9 10167.5 11027.1 14702.5 14929.3 14985.3 15061.4 15069.8 7846.7 7976.1 8065.1 8179.1 8201.1 7471.4 7772.5 7791.1 7824.2 7980.0 4531.5 4542.5 4556.6 4617.6 4650.4 1884.0 1901.9 1912.4 1918.9 1922.4 963.3 990.2 990.3 1008.7 1012.6 17483.8 18322.4 18460.8 18490.9 18869.5 954.0 967.8 968.5 991.1 1036.3 9835.8 10093.8 10188.9 10219.1 10347.9 416468.0 424043.0 425312.0 427770.0 430754.0 55688.0 64971.0 84391.0 85578.0 85630.6 961.6 968.5 993.8 1001.2 1008.0 15695.0 16041.4 16268.8 16283.3 16582.4 40705.8 41219.0 41286.6 41546.8 41627.8 55452.4 56626.0 57072.4 57834.0 59061.7 7158.8 7343.7 7497.6 7837.2 7973.2 11251.6 12749.2 12758.4 13152.7 13275.0 10887.8 11349.6 11421.8 11424.7 11948.3 10983.6 11110.9 11141.1 11233.8 11470.4 11343.0 11509.1 11928.5 11934.6 12035.3 7621.4 7646.1 7801.3 7850.5 7890.1 9928.4 11346.3 11654.6 11872.0 11895.5 15:35:23 INFO - PROCESS | 18597 | 15:35:23 INFO - PROCESS | 18597 | [#3] mootools.html Cycles:180 Average:5825.89 Median:4600.13 stddev:3395.10 (73.8%) stddev-sans-first:3387.89 15:35:23 INFO - PROCESS | 18597 | Values: 1339.9 1471.2 1501.5 1619.5 1738.8 7708.7 8698.1 8955.1 8966.0 9210.1 9038.0 9107.5 9112.0 9119.4 9122.0 2343.8 2366.4 2372.7 2373.1 2380.0 2295.8 2322.7 2350.2 2353.6 2356.6 2284.7 2293.2 2296.5 2344.3 2348.6 2292.4 2300.9 2302.6 2318.4 2333.4 2204.6 2205.7 2211.1 2219.2 2221.1 8808.5 8860.0 8952.2 8954.3 8960.0 5062.9 5247.7 5252.5 5254.2 5268.7 3250.0 3365.5 3409.3 3420.9 3430.5 1097.4 1127.4 1130.0 1158.4 1159.3 12522.7 12563.1 12623.4 12633.2 12650.3 4306.4 4456.5 4538.0 4597.8 4602.4 9908.5 9912.1 9937.4 9955.5 9972.3 5183.0 5196.4 5207.7 5209.9 5248.7 4223.2 4295.0 4356.5 4752.1 4852.7 3609.9 3654.9 3728.8 3801.6 3808.5 1145.3 1160.8 1179.4 1180.2 1188.5 847.6 888.9 948.5 957.0 961.7 5828.2 5829.9 5905.8 6050.7 6248.5 439.7 441.4 441.8 452.4 452.5 3946.9 3973.1 4119.6 4129.4 4168.3 10932.0 11172.3 11285.9 11311.9 11312.8 11204.3 11210.5 11215.7 11218.4 11227.2 7837.5 8152.8 8306.7 8386.6 8416.0 5915.7 5927.8 5955.8 6097.4 6138.1 9905.8 10117.3 10169.5 10343.9 10433.3 10139.8 10325.3 10405.0 10492.4 10550.2 7121.9 7293.6 7750.8 7848.4 7898.7 8171.9 8542.2 8548.9 8562.5 8734.7 7849.8 8024.5 8138.7 8206.0 8264.4 7903.8 7933.7 7976.0 8003.8 8154.4 6985.8 7098.5 7106.2 7118.9 7119.4 5271.6 5318.7 5414.7 5423.5 5631.7 5228.9 5232.9 5275.3 5313.9 5319.6 15:35:23 INFO - PROCESS | 18597 | 15:35:23 INFO - PROCESS | 18597 | [#4] prototype.html Cycles:180 Average:4572.34 Median:5141.82 stddev:1330.47 (25.9%) stddev-sans-first:1295.35 15:35:23 INFO - PROCESS | 18597 | Values: 319.9 326.8 327.1 331.6 338.5 5061.0 5180.7 5193.8 5244.7 5249.8 5015.7 5140.9 5146.9 5159.5 5175.8 4070.7 4083.6 4097.3 4117.2 4120.1 3965.1 4102.9 4114.2 4119.4 4122.7 4060.0 4063.5 4088.5 4092.8 4099.4 4045.3 4052.2 4056.1 4062.7 4089.9 3653.9 3670.2 3687.7 3697.2 3698.7 4919.8 5101.2 5119.0 5142.7 5173.2 4734.4 4774.8 4788.8 4794.2 4814.2 5522.3 5558.2 5563.9 5597.1 5616.2 3925.9 3986.2 4014.9 4022.8 4074.9 5618.6 5618.7 5638.9 5663.3 5733.8 4126.8 4132.0 4140.5 4142.0 4149.2 4096.2 4178.1 4183.6 4193.1 4217.0 4695.2 4708.3 4713.2 4713.3 4722.8 5437.8 5457.4 5460.5 5496.6 5528.3 1332.0 1335.8 1380.8 1416.9 1431.2 916.5 930.4 942.6 945.4 953.3 4652.9 4658.8 4662.0 4687.4 4708.2 4825.6 4828.5 4882.3 4911.8 4921.9 4616.7 4622.3 4628.3 4663.0 4685.7 2785.8 2992.6 3002.7 3005.8 3007.7 5858.7 5862.5 5863.7 5866.6 5886.3 5414.7 5589.6 5594.3 5770.9 5786.2 5740.0 5762.9 5763.3 5772.4 5792.8 5603.2 5633.7 5637.6 5668.7 5671.9 5344.0 5456.6 5500.7 5513.7 5539.5 5725.6 5732.5 5733.9 5748.6 5833.7 3899.0 3981.4 3984.3 3987.7 3997.3 5267.3 5509.4 5529.6 5535.7 5560.8 5320.5 5320.7 5483.6 5492.5 5502.0 5482.6 5488.4 5502.8 5537.5 5553.3 5258.8 5468.0 5497.9 5502.2 5512.9 5486.3 5503.3 5516.8 5517.8 5519.0 5346.3 5407.2 5408.8 5433.7 5447.5 15:35:23 INFO - PROCESS | 18597 | 15:35:23 INFO - PROCESS | 18597 | [#5] yui.html Cycles:180 Average:19820.11 Median:25900.31 stddev:28324.80 (109.4%) stddev-sans-first:28367.87 15:35:23 INFO - PROCESS | 18597 | Values: 699.3 768.2 771.8 821.1 823.5 15733.3 16456.8 16468.8 16473.3 16496.6 14843.3 14949.7 14955.9 14976.7 14992.3 641.6 657.6 762.2 763.9 778.4 787.1 787.4 793.7 794.0 794.3 833.8 837.9 838.4 839.2 839.3 678.2 833.3 833.8 834.1 834.6 507.6 589.0 602.3 603.3 606.3 15077.9 15121.2 15123.2 15123.4 15141.3 13856.3 14037.9 14767.5 14779.5 14906.8 11529.1 11700.4 11748.4 11809.2 11868.1 4342.7 4364.8 4421.9 4435.2 4506.3 82186.0 82205.6 82289.3 83030.6 83288.0 10898.5 10938.4 11033.9 11220.7 11454.5 18848.6 18866.5 18908.7 18943.3 18961.2 8501.6 8656.4 8762.7 8935.6 8942.5 4565.8 4578.1 4674.3 4696.3 4835.2 3353.5 3777.6 3975.9 3976.3 4018.1 641.8 647.8 660.0 663.9 678.9 671.1 671.7 688.7 694.8 708.7 9206.7 9326.0 9335.2 9605.3 9616.4 547.3 655.0 679.7 715.7 716.7 4327.7 4405.6 4588.2 4789.2 4866.3 68593.0 69141.7 69176.3 70031.6 85004.0 103505.0 105401.0 105905.0 109009.0 109648.5 93903.5 94111.5 94193.0 96119.5 96958.0 8585.3 8691.2 9004.2 9009.4 9327.5 47104.3 47217.5 47733.3 50904.8 51281.7 59197.0 71877.6 73491.3 75098.0 75104.2 12108.3 12212.7 12676.8 12697.0 13005.2 12937.3 13506.2 13871.6 14102.8 14730.9 12293.3 12330.6 12467.4 12582.6 12973.9 11630.8 11839.3 12012.9 12415.3 12463.3 11570.9 11694.9 11735.3 11971.6 12181.0 9772.9 10289.6 10344.6 10402.4 10579.0 10092.6 10103.7 10110.8 10238.9 10349.9 15:35:23 INFO - PROCESS | 18597 | -------- Summary: end -------- 15:35:23 INFO - PROCESS | 18597 | 15:35:24 INFO - TEST-INFO | 18597: exit 0 15:35:24 INFO - TEST-OK | dromaeo_css | took 1120144ms 15:35:24 INFO - TEST-START | kraken 15:35:24 INFO - operating with platform_type : linux_ 15:35:24 INFO - Initialising browser for kraken test... 15:35:24 INFO - TEST-INFO | started process 18908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYxJT78/profile http://localhost:58026/getInfo.html) 15:35:28 INFO - PROCESS | 18908 | __metrics Screen width/height:1600/1200 15:35:28 INFO - PROCESS | 18908 | colorDepth:24 15:35:28 INFO - PROCESS | 18908 | Browser inner width/height: 1024/697 15:35:28 INFO - PROCESS | 18908 | __metrics 15:35:29 INFO - PROCESS | 18908 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:35:29 INFO - PROCESS | 18908 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:35:30 INFO - PROCESS | 18908 | console.error: PushService: 15:35:30 INFO - PROCESS | 18908 | stateChangeProcessEnqueue: Error transitioning state 15:35:30 INFO - PROCESS | 18908 | UnknownError 15:35:30 INFO - TEST-INFO | 18908: exit 0 15:35:30 INFO - Browser initialized. 15:35:30 INFO - Running cycle 1/1 for kraken test... 15:35:30 INFO - TEST-INFO | started process 18993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYxJT78/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:35:42 INFO - PROCESS | 18993 | RSS: Main: 171954176 15:35:42 INFO - PROCESS | 18993 | 15:35:45 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:58026/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58026/tests/kraken/driver.html?testName=audio-beat-detection) 15:35:46 INFO - PROCESS | 18993 | RSS: Main: 229515264 15:35:46 INFO - PROCESS | 18993 | 15:35:49 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:58026/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58026/tests/kraken/driver.html?testName=audio-dft) 15:35:49 INFO - PROCESS | 18993 | RSS: Main: 215613440 15:35:49 INFO - PROCESS | 18993 | 15:35:52 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:58026/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58026/tests/kraken/driver.html?testName=audio-fft) 15:35:53 INFO - PROCESS | 18993 | RSS: Main: 297070592 15:35:53 INFO - PROCESS | 18993 | 15:35:55 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:58026/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58026/tests/kraken/driver.html?testName=audio-oscillator) 15:35:56 INFO - PROCESS | 18993 | RSS: Main: 206221312 15:35:56 INFO - PROCESS | 18993 | 15:35:58 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:58026/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58026/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:35:58 INFO - PROCESS | 18993 | RSS: Main: 211517440 15:35:58 INFO - PROCESS | 18993 | 15:36:01 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:58026/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58026/tests/kraken/driver.html?testName=imaging-darkroom) 15:36:02 INFO - PROCESS | 18993 | RSS: Main: 247312384 15:36:02 INFO - PROCESS | 18993 | 15:36:05 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:58026/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58026/tests/kraken/driver.html?testName=imaging-desaturate) 15:36:06 INFO - PROCESS | 18993 | RSS: Main: 246210560 15:36:06 INFO - PROCESS | 18993 | 15:36:08 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:58026/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58026/tests/kraken/driver.html?testName=json-parse-financial) 15:36:09 INFO - PROCESS | 18993 | RSS: Main: 246116352 15:36:09 INFO - PROCESS | 18993 | 15:36:10 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:58026/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58026/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:36:11 INFO - PROCESS | 18993 | RSS: Main: 209014784 15:36:11 INFO - PROCESS | 18993 | 15:36:13 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:58026/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58026/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:36:13 INFO - PROCESS | 18993 | RSS: Main: 215629824 15:36:13 INFO - PROCESS | 18993 | 15:36:15 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:58026/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58026/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:36:16 INFO - PROCESS | 18993 | RSS: Main: 225325056 15:36:16 INFO - PROCESS | 18993 | 15:36:19 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:58026/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58026/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:36:19 INFO - PROCESS | 18993 | RSS: Main: 233525248 15:36:19 INFO - PROCESS | 18993 | 15:36:22 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:58026/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58026/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:36:23 INFO - PROCESS | 18993 | RSS: Main: 230678528 15:36:23 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:58026/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58026/tests/kraken/driver.html?testName=ai-astar) 15:36:25 INFO - PROCESS | 18993 | RSS: Main: 282234880 15:36:25 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | __start_tp_report 15:36:25 INFO - PROCESS | 18993 | _x_x_mozilla_page_load 15:36:25 INFO - PROCESS | 18993 | _x_x_mozilla_page_load_details 15:36:25 INFO - PROCESS | 18993 | |i|pagename|runs| 15:36:25 INFO - PROCESS | 18993 | |0;ai-astar;103;110;111;112;112;110;110;111;111;111 15:36:25 INFO - PROCESS | 18993 | |1;audio-beat-detection;145;128;120;164;123;124;127;119;153;124 15:36:25 INFO - PROCESS | 18993 | |2;audio-dft;159;159;161;160;161;163;161;163;160;160 15:36:25 INFO - PROCESS | 18993 | |3;audio-fft;76;76;76;108;76;76;75;76;101;76 15:36:25 INFO - PROCESS | 18993 | |4;audio-oscillator;82;82;110;82;81;82;118;82;82;125 15:36:25 INFO - PROCESS | 18993 | |5;imaging-gaussian-blur;116;116;116;117;116;117;116;117;117;117 15:36:25 INFO - PROCESS | 18993 | |6;imaging-darkroom;147;146;146;146;147;147;146;146;146;147 15:36:25 INFO - PROCESS | 18993 | |7;imaging-desaturate;85;84;84;84;84;84;84;84;84;84 15:36:25 INFO - PROCESS | 18993 | |8;json-parse-financial;54;52;53;53;53;54;54;53;53;53 15:36:25 INFO - PROCESS | 18993 | |9;json-stringify-tinderbox;59;60;60;59;59;59;60;59;67;59 15:36:25 INFO - PROCESS | 18993 | |10;stanford-crypto-aes;81;80;81;80;80;85;80;79;80;80 15:36:25 INFO - PROCESS | 18993 | |11;stanford-crypto-ccm;143;139;132;141;129;130;142;134;172;137 15:36:25 INFO - PROCESS | 18993 | |12;stanford-crypto-pbkdf2;173;171;170;173;169;171;187;167;166;167 15:36:25 INFO - PROCESS | 18993 | |13;stanford-crypto-sha256-iterative;66;66;75;71;67;74;65;70;65;65 15:36:25 INFO - PROCESS | 18993 | __end_tp_report 15:36:25 INFO - PROCESS | 18993 | __start_cc_report 15:36:25 INFO - PROCESS | 18993 | _x_x_mozilla_cycle_collect,1649 15:36:25 INFO - PROCESS | 18993 | __end_cc_report 15:36:25 INFO - PROCESS | 18993 | __startTimestamp1477262185373__endTimestamp 15:36:25 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | ------- Summary: start ------- 15:36:25 INFO - PROCESS | 18993 | Number of tests: 14 15:36:25 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.60 (2.3%) stddev-sans-first:0.78 15:36:25 INFO - PROCESS | 18993 | Values: 103.0 110.0 111.0 112.0 112.0 110.0 110.0 111.0 111.0 111.0 15:36:25 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:127.50 stddev:15.61 (12.2%) stddev-sans-first:15.91 15:36:25 INFO - PROCESS | 18993 | Values: 145.0 128.0 120.0 164.0 123.0 124.0 127.0 119.0 153.0 124.0 15:36:25 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.42 (0.9%) stddev-sans-first:1.36 15:36:25 INFO - PROCESS | 18993 | Values: 159.0 159.0 161.0 160.0 161.0 163.0 161.0 163.0 160.0 160.0 15:36:25 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:12.19 (16.0%) stddev-sans-first:12.76 15:36:25 INFO - PROCESS | 18993 | Values: 76.0 76.0 76.0 108.0 76.0 76.0 75.0 76.0 101.0 76.0 15:36:25 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:82.00 stddev:17.66 (21.5%) stddev-sans-first:18.31 15:36:25 INFO - PROCESS | 18993 | Values: 82.0 82.0 110.0 82.0 81.0 82.0 118.0 82.0 82.0 125.0 15:36:25 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:36:25 INFO - PROCESS | 18993 | Values: 116.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 15:36:25 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 15:36:25 INFO - PROCESS | 18993 | Values: 147.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 147.0 15:36:25 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:0.32 (0.4%) stddev-sans-first:0.00 15:36:25 INFO - PROCESS | 18993 | Values: 85.0 84.0 84.0 84.0 84.0 84.0 84.0 84.0 84.0 84.0 15:36:25 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:0.63 (1.2%) stddev-sans-first:0.60 15:36:25 INFO - PROCESS | 18993 | Values: 54.0 52.0 53.0 53.0 53.0 54.0 54.0 53.0 53.0 53.0 15:36:25 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:59.50 stddev:2.47 (4.2%) stddev-sans-first:2.59 15:36:25 INFO - PROCESS | 18993 | Values: 59.0 60.0 60.0 59.0 59.0 59.0 60.0 59.0 67.0 59.0 15:36:25 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:1.65 (2.1%) stddev-sans-first:1.74 15:36:25 INFO - PROCESS | 18993 | Values: 81.0 80.0 81.0 80.0 80.0 85.0 80.0 79.0 80.0 80.0 15:36:25 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:140.00 stddev:12.33 (8.8%) stddev-sans-first:13.03 15:36:25 INFO - PROCESS | 18993 | Values: 143.0 139.0 132.0 141.0 129.0 130.0 142.0 134.0 172.0 137.0 15:36:25 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:171.00 stddev:6.00 (3.5%) stddev-sans-first:6.34 15:36:25 INFO - PROCESS | 18993 | Values: 173.0 171.0 170.0 173.0 169.0 171.0 187.0 167.0 166.0 167.0 15:36:25 INFO - PROCESS | 18993 | 15:36:25 INFO - PROCESS | 18993 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:3.84 (5.6%) stddev-sans-first:3.97 15:36:25 INFO - PROCESS | 18993 | Values: 66.0 66.0 75.0 71.0 67.0 74.0 65.0 70.0 65.0 65.0 15:36:25 INFO - PROCESS | 18993 | -------- Summary: end -------- 15:36:25 INFO - PROCESS | 18993 | 15:36:26 INFO - TEST-INFO | 18993: exit 0 15:36:26 INFO - TEST-OK | kraken | took 62264ms 15:36:26 INFO - SUITE-END | took 1182s 15:36:27 INFO - Completed test suite (00:19:42) 15:36:27 INFO - javascript benchmark 15:36:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.876284948602, 3106.238971451993, 3122.781405301629, 3142.214446388403, 3165.208697825544, 5199.948000519994, 5316.20256961456, 5361.7587208575615, 5447.836564903055, 5460.126379779231, 5307.20391941209, 5316.9202461963105, 5331.147016477365, 5332.440093790155, 5340.732963351837, 4818.277258411232, 4865.19724245499, 4891.0, 4949.50504949504, 4965.602751779849, 4936.975315123437, 4946.925796113062, 4954.529319714621, 4988.32657591226, 4992.700437973715, 4855.781489832948, 4939.234418665094, 4943.9752801235945, 5030.11972904742, 5071.061853557104, 5014.974925125388, 5030.144875371196, 5038.672486288417, 5073.543381095701, 5095.923561146586, 4700.5064468230685, 4751.097291514636, 4752.287156926454, 4910.042541704369, 4965.131102057126, 5203.219517072432, 5258.97370513145, 5260.92108618371, 5268.841934741964, 5288.894222115536, 5736.368999410061, 5774.162746401748, 5784.1902133701315, 5834.241548598655, 5843.298804143487, 5813.157092221646, 5835.328937172195, 5884.588078834483, 5895.0, 5898.026825573776, 5278.261043453919, 5464.808731694372, 5477.616566840363, 5478.534324582375, 5479.205515200353, 5777.88444231113, 5794.942050579441, 5870.73581688825, 5870.911936320958, 5917.763289468373, 5632.549396048306, 5639.915401268984, 5643.068893632587, 5646.096624540054, 5648.237487939075, 5708.828735137952, 5725.713714314267, 5726.627769194989, 5729.226554415184, 5737.684427356452, 5563.860903477445, 5580.274564306615, 5611.719414029282, 5680.914786278209, 5759.539236861041, 5766.538676905838, 5773.134029895549, 5825.1844741736195, 5827.504662103769, 5828.329742079631, 4386.649068074546, 4386.64906807461, 4388.780560971939, 4389.056352884145, 4442.933355999663, 3852.3836186210074, 3886.7667939923695, 3920.2943470175073, 3922.3920292354733, 3955.3671412574427, 5293.206019097166, 5300.814471493479, 5309.814156504503, 5380.973095134499, 5403.189521571796, 5632.493075623213, 5685.459881311352, 5686.14707793826, 5693.829185124453, 5694.202811606296, 5273.156294992783, 5328.3605967284175, 5345.786168553214, 5353.4646535346155, 5407.972960135174, 4767.570918617341, 4818.831340903122, 4860.586850117709, 4878.243872199815, 4888.828890988798, 5808.099744539603, 5811.3026436827, 5814.680192589448, 5819.5635327351465, 5878.970605146947, 5615.803446879339, 5628.071368224197, 5652.68910209926, 5654.745536450787, 5673.914891276717, 5796.62321949072, 5800.796972105956, 5853.707314634166, 5865.501432378295, 5930.021546444961, 5655.179998900054, 5656.208130861765, 5669.639286571276, 5718.085106382959, 5724.398938111605, 5691.203231547669, 5730.512906402836, 5737.139429085671, 5737.139429085671, 5738.799142030009, 5503.422140675171, 5552.7223638818705, 5562.666240025612, 5636.915446268391, 5641.40765219646, 5544.0575102231915, 5545.223668686306, 5550.056490396723, 5557.36090349615, 5566.471185237396, 5545.390007099135, 5589.972050139723, 5593.860153496195, 5597.356304025089, 5603.663780173202, 5663.235463212578, 5683.147527870852, 5688.7440065198, 5688.800891968926, 5692.032354499662, 5528.226048353154, 5530.336359636708, 5531.557475402039, 5539.695316757617, 5552.250446189712], "value": 5284.481910828548, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.2369381650759, 592.8014115271385, 602.9427204415582, 615.7598536570737, 616.8612062285989, 31309.530357044634, 41355.58644413559, 42535.36196957044, 42607.573924260745, 45472.0, 42936.141277174516, 43288.78355608226, 43315.0, 43317.35023974635, 43384.783076084575, 8046.839063218732, 8758.255548278388, 8916.108389161096, 8920.330975176888, 8926.285897128246, 7913.960430197841, 10274.537645805956, 10519.526621302022, 10522.053015228628, 10918.399488028155, 10355.585776568929, 10402.0, 10408.06327430531, 10413.479326033706, 10416.63541776038, 10615.46922653868, 10692.679219623424, 10710.0, 10723.0, 10727.946360268148, 10428.217883658755, 10489.947550262199, 10494.317869338469, 10496.790064198673, 10497.895021049768, 40326.39510407346, 40696.0, 40753.0, 40753.796231018954, 40773.0, 3466.30673865228, 3477.930441391158, 3834.175652234783, 4013.4381186633605, 4019.718619696622, 30334.393312133634, 30962.0, 31304.0, 31330.530042049388, 31365.0, 3791.184895247535, 3849.268638958617, 3915.725899187058, 4060.796960151981, 4106.117184805281, 309463.4526827374, 314138.0, 314776.0, 315451.0, 315491.0, 54531.454685452634, 55146.44853551413, 55315.446845531835, 55348.446515535135, 55365.44634553603, 56666.433335666115, 56832.71583642055, 56838.71580642153, 56859.0, 56860.715696421255, 16003.679926401406, 16301.918490407472, 16317.428889988794, 16318.75521867173, 16323.836761632469, 10829.566817327377, 11000.559977600806, 12028.0, 12045.21706089119, 12103.576374826838, 14494.275286235646, 15241.23793810305, 15368.310545654465, 15396.07623542591, 15545.533633990999, 6199.628022318675, 6329.2721337045905, 6331.145295385156, 6444.935550644527, 6452.225732911987, 911.3074063711626, 1010.7018429563296, 1035.6064695415694, 1040.6877936618985, 1047.4762618690654, 30511.38977220443, 30649.84675076655, 30692.168487987212, 30955.81493321447, 30962.0, 1077.8221593436995, 1086.5002099034532, 1099.5381939585393, 1104.2270410712533, 1125.7917285302244, 15755.68488630221, 16234.675306493804, 16385.262663180187, 16407.343706251853, 16587.751183732253, 455344.0, 457072.0, 457662.0, 457837.0, 457901.0, 56545.71727141338, 56637.43362566404, 56684.76467588562, 56692.71653641705, 56723.0, 1257.8050402187675, 1289.1684863263142, 1296.682312833362, 1302.615728360136, 1323.3912400295972, 28710.13869583916, 30287.0, 30408.239794005327, 30886.055753055974, 31010.0, 48706.26940595823, 48964.0, 49028.75485622549, 49099.75450122727, 49109.50890491049, 379000.0, 380477.0, 380849.0, 382717.0, 383159.0, 38097.80951095227, 38875.80562097171, 38903.61096389113, 39080.0, 39417.21165576615, 44607.55392446164, 44916.326255106855, 45626.54373456223, 46160.07679846451, 46948.7652561735, 36872.63127368692, 37357.62642373541, 37758.43362349622, 38728.031799205244, 39107.6089239104, 37520.62479375171, 37839.43240851445, 38231.0, 38362.0, 38867.0, 39088.80455597704, 39531.60468395394, 39605.80197098996, 39670.404943925285, 39680.2063958725, 32744.0, 33956.83021584975, 34694.0, 35276.47085293774, 35432.0, 26826.463470730087, 27612.129528810157, 27704.584431233143, 27765.167044988684, 28065.719342807126], "value": 19658.502400555528, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.88255875561066, 374.54305746988666, 379.38603025156675, 384.7710612185749, 414.9792510374481, 14191.57425277242, 14686.779698304521, 18563.814361856377, 18721.251149953987, 18774.873507589553, 17328.480145595622, 17855.19651615677, 17886.73169902449, 18016.819831801677, 18036.368727094556, 4118.917621647565, 5445.074337362648, 5687.374388817227, 5689.516391106761, 5694.430556944314, 4149.522804877448, 4277.679174061942, 4525.886852828673, 6215.223097112861, 6292.402221788922, 6022.307434645006, 6307.747690092391, 6318.399752023551, 6340.714667839959, 6346.714397852084, 6322.114903913456, 6330.366963303679, 6361.522885783585, 6370.968145159268, 6372.5857819242065, 5445.53712934401, 5616.382197958222, 5622.128570071645, 5652.63257888236, 5654.208410822488, 20559.58880822375, 21239.044243009103, 21413.250536231157, 22136.557268854533, 22343.66484502734, 2218.234709025384, 2304.7925686688277, 2334.8132149428006, 2532.278300684296, 2688.569828827398, 10038.096571308544, 10187.694369168938, 13745.656358591015, 13805.723885522333, 14696.338664760004, 1869.579344647457, 1903.0960293860444, 1928.5275107598727, 1938.3524004596122, 1947.191915355126, 55543.722281388335, 60644.0, 64146.0, 77144.0, 81222.59388703019, 9424.151826335663, 9948.204143668489, 10135.898641013642, 10167.4916254187, 11027.070262703995, 14702.485413010707, 14929.328180231916, 14985.32566034531, 15061.397544098114, 15069.849301507064, 7846.686132554634, 7976.122626511079, 8065.112837587861, 8179.0594081681365, 8201.13888041759, 7471.402287816962, 7772.45592808498, 7791.142974272825, 7824.178461261599, 7980.042394912648, 4531.520592392038, 4542.454905411306, 4556.612687921497, 4617.561331673485, 4650.37219975299, 1883.9905800471183, 1901.9334323298895, 1912.3689182569997, 1918.8656794024284, 1922.3656193456127, 963.2534785541121, 990.2177279948904, 990.2622546203124, 1008.7276435362411, 1012.6405126180247, 17483.808516371242, 18322.35871744509, 18460.81539184591, 18490.907545462185, 18869.528261793566, 954.0316578672653, 967.7580604848788, 968.5254225429629, 991.0931497679686, 1036.3419228789621, 9835.803283934281, 10093.798124037477, 10188.949055254676, 10219.13137383316, 10347.948260258801, 416468.0, 424043.0, 425312.0, 427770.0, 430754.0, 55688.0, 64971.0, 84391.0, 85578.0, 85630.57184714162, 961.5576834655997, 968.4528241543646, 993.7515621094726, 1001.1690297053428, 1008.0423597582326, 15695.0, 16041.35834566651, 16268.837311626732, 16283.267252973881, 16582.419615313407, 40705.79647101746, 41219.0, 41286.58713412948, 41546.79226603848, 41627.7918610405, 55452.44547554473, 56626.0, 57072.42927570671, 57834.0, 59061.70469147627, 7158.785236442915, 7343.669534871051, 7497.550146991198, 7837.1770964047955, 7973.242541958504, 11251.606193783178, 12749.235045897276, 12758.425870835648, 13152.73694526085, 13275.0, 10887.836682449612, 11349.602763903555, 11421.771564568828, 11424.71438214018, 11948.34284114382, 10983.61557345521, 11110.888891111308, 11141.108711303239, 11233.831492527783, 11470.369129697947, 11343.0, 11509.13681473876, 11928.522859085539, 11934.58228962017, 12035.277883327028, 7621.428392870668, 7646.120696119795, 7801.29788319054, 7850.528968261922, 7890.092639346549, 9928.404295742279, 11346.262492938264, 11654.592089276835, 11872.0, 11895.464704088165], "value": 8874.038708754208, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.8780840641307, 1471.2349578219325, 1501.4894935721854, 1619.5060506545506, 1738.8000379956302, 7708.730194443188, 8698.086700896401, 8955.059718729537, 8965.955170224148, 9210.078992100787, 9038.0, 9107.453552786837, 9112.043235460264, 9119.361644684876, 9122.042185570519, 2343.800776933963, 2366.372911178539, 2372.738998710149, 2373.050779688121, 2379.95240095198, 2295.8048565871923, 2322.7328857181387, 2350.21267875262, 2353.599888019041, 2356.599378105726, 2284.7029886114783, 2293.20884294918, 2296.517731276434, 2344.2732752846587, 2348.5889969255313, 2292.3695983604475, 2300.942476438094, 2302.631578947369, 2318.4088057545387, 2333.381653861728, 2204.570108828779, 2205.735311762599, 2211.1266049910355, 2219.2454565447665, 2221.133757834446, 8808.471491710454, 8860.0, 8952.239059679934, 8954.328425368058, 8960.0, 5062.873428164326, 5247.685138891678, 5252.474752524755, 5254.15933450646, 5268.6575372600655, 3250.0, 3365.495175723661, 3409.2670075933793, 3420.9315813683834, 3430.451127819537, 1097.3635291530893, 1127.408110741859, 1130.0446646174696, 1158.4092113022334, 1159.287038471334, 12522.68693282666, 12563.057770667145, 12623.431945562379, 12633.178843375243, 12650.304233267167, 4306.440162778818, 4456.487503937024, 4537.977310113494, 4597.839075632403, 4602.424696912886, 9908.504574771232, 9912.107910288109, 9937.354071985297, 9955.50222488887, 9972.301938864355, 5183.041137389595, 5196.402413722395, 5207.713575753294, 5209.921851172236, 5248.6588371755715, 4223.239816832999, 4294.957050429518, 4356.542563030836, 4752.144613969519, 4852.684575502581, 3609.9097522562147, 3654.853805847736, 3728.7762734236035, 3801.6198380161763, 3808.5239345081864, 1145.3013661666378, 1160.8374827524153, 1179.4397661110904, 1180.1738782852037, 1188.5245901639414, 847.5677404523738, 888.9110839221902, 948.4830767231875, 957.0333962697587, 961.6634178037631, 5828.184054232411, 5829.912551311733, 5905.793297234576, 6050.6672133032225, 6248.4688801452385, 439.68782164663446, 441.41953331369785, 441.79456552703147, 452.4186420449706, 452.48190821509843, 3946.861859834892, 3973.1457736586194, 4119.608637179464, 4129.421880936671, 4168.312228482267, 10932.0, 11172.273802202832, 11285.887141128647, 11311.886881131248, 11312.830307545393, 11204.271722338022, 11210.495527701272, 11215.66353009411, 11218.382988935688, 11227.214095013434, 7837.451378403571, 8152.755417337489, 8306.70926517569, 8386.580670966427, 8415.95792021036, 5915.733791979285, 5927.762889484372, 5955.821325360246, 6097.359777223328, 6138.14066030765, 9905.752356191153, 10117.342372745748, 10169.542370593193, 10343.948280258852, 10433.26967112295, 10139.847902281324, 10325.328853624791, 10404.97103064895, 10492.370457772558, 10550.208734345108, 7121.893171602326, 7293.562386256842, 7750.8449831001935, 7848.372130229682, 7898.723544675909, 8171.918280817354, 8542.18849209324, 8548.91451085506, 8562.52906090171, 8734.69428569997, 7849.803754906173, 8024.518528888286, 8138.674453021813, 8205.95897020511, 8264.421490495608, 7903.802404939693, 7933.722319719013, 7975.960120199594, 8003.839923201387, 8154.429189956646, 6985.755498557526, 7098.538594991309, 7106.218315985134, 7118.893216601651, 7119.430445564239, 5271.578273738169, 5318.680879147263, 5414.729263536886, 5423.538999185113, 5631.6902570359025, 5228.921566176435, 5232.921506177487, 5275.287836142072, 5313.920291195558, 5319.627626066293], "value": 4540.090890827279, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.9457786593177, 326.7843223472508, 327.08905697632093, 331.64853223115796, 338.5345150418175, 5060.999999999991, 5180.663256888304, 5193.792248310073, 5244.659097158687, 5249.790008399665, 5015.67398119122, 5140.8971820563565, 5146.897062058757, 5159.50984656458, 5175.767090480928, 4070.7230679303075, 4083.5508094109623, 4097.323941549641, 4117.21772863155, 4120.134771697947, 3965.1474932889423, 4102.938455923164, 4114.177164567083, 4119.36149896765, 4122.690798190133, 4059.9797001014954, 4063.5326937402283, 4088.5298190708004, 4092.815823287944, 4099.405586190001, 4045.271851066807, 4052.2300762855257, 4056.1076563156057, 4062.6546743526687, 4089.89775255618, 3653.853845846163, 3670.2475992421755, 3687.6681098701247, 3697.205100903319, 3698.685611723007, 4919.77860996256, 5101.20931255656, 5119.0, 5142.742862856842, 5173.249878767595, 4734.384530011111, 4774.832880849153, 4788.832390866338, 4794.232922732346, 4814.229723244264, 5522.30971128609, 5558.166275058733, 5563.8887222255735, 5597.104463285855, 5616.185653080281, 3925.8625948091967, 3986.202759448122, 4014.859479918218, 4022.839086436539, 4074.9185016299507, 5618.578606604521, 5618.719064046782, 5638.887222255573, 5663.348714897798, 5733.770649174028, 4126.773027483458, 4131.97934010328, 4140.523839758406, 4141.97929010353, 4149.190907773016, 4096.160287141129, 4178.12259425518, 4183.560726123774, 4193.119444916601, 4216.978915105405, 4695.154872123051, 4708.340832283483, 4713.198756211452, 4713.34013238147, 4722.763861806965, 5437.782488700408, 5457.372402173801, 5460.481254280837, 5496.615236933376, 5528.258598541446, 1331.9866801331862, 1335.8063080853221, 1380.751464736357, 1416.8937329700314, 1431.1627697796698, 916.5371487398954, 930.4463844012802, 942.58997336159, 945.4421891084294, 953.2612225525273, 4652.906941861143, 4658.765427161805, 4661.976690116528, 4687.39063921688, 4708.223143181405, 4825.638077144228, 4828.493008234155, 4882.340883980617, 4911.7544122793715, 4921.926171107436, 4616.6537509686905, 4622.335959054738, 4628.305754136839, 4662.953370466252, 4685.719996002812, 2785.846778427206, 2992.5959995400344, 3002.7297543221216, 3005.7595392368557, 3007.7443417309337, 5858.736356863951, 5862.530997520188, 5863.736131874076, 5866.6480011199465, 5886.3230728465915, 5414.675119492765, 5589.636673616202, 5594.300712410949, 5770.913436298459, 5786.164779258133, 5740.0, 5762.855928601734, 5763.337216220105, 5772.39389864075, 5792.82621521355, 5603.159526071122, 5633.746481408264, 5637.5892584985495, 5668.744906479136, 5671.8865622688145, 5343.973280133574, 5456.590755693418, 5500.669959802424, 5513.669179849222, 5539.501444869981, 5725.627834190765, 5732.455416735404, 5733.856653583527, 5748.597598168088, 5833.708314584339, 3898.961010389973, 3981.3629819228786, 3984.2629113614075, 3987.6809855212095, 3997.2605068062503, 5267.3152490176035, 5509.449055094458, 5529.585281104014, 5535.667859928417, 5560.805371811967, 5320.494553017457, 5320.733963301896, 5483.588730845282, 5492.533134683436, 5501.972490137524, 5482.5613950884635, 5488.368837583569, 5502.834914952397, 5537.501624853782, 5553.250311207935, 5258.763355649082, 5468.0, 5497.917531236954, 5502.184279187938, 5512.940318123319, 5486.286782718221, 5503.339599247955, 5516.834494965157, 5517.834464966058, 5518.972405138109, 5346.278252436027, 5407.161889907071, 5408.783648654167, 5433.728313584226, 5447.455254474521], "value": 4149.759049005412, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.3181647893304, 768.1895600141852, 771.8031901865023, 821.0885916632539, 823.5058964621225, 15733.292001859914, 16456.753148702777, 16468.835311646893, 16473.258703358348, 16496.587585310357, 14843.257837108154, 14949.701005979901, 14955.925220373883, 14976.700465990674, 14992.325345359457, 641.5573254454434, 657.5955787190867, 762.1920763990161, 763.8968739220204, 778.3578547698144, 787.122358570193, 787.3779714025912, 793.6587267474983, 794.0154208781099, 794.3208556684039, 833.8165603567205, 837.9120192379804, 838.3921656798833, 839.1524560194187, 839.3033781960988, 678.1963373402484, 833.2667252817542, 833.8415701016787, 834.0866750907777, 834.64110432514, 507.64972169203503, 588.9676067816268, 602.2892986276192, 603.3031848215319, 606.3269770554681, 15077.924610376987, 15121.243937803067, 15123.168225747579, 15123.395064197419, 15141.318640661197, 13856.307184640727, 14037.859621403757, 14767.483138090116, 14779.482718104815, 14906.776398354034, 11529.135314851419, 11700.414979251003, 11748.412579370997, 11809.23239989398, 11868.05055595559, 4342.652587792969, 4364.759938203398, 4421.9336709949375, 4435.223835828717, 4506.346579745951, 82186.0, 82205.58897205535, 82289.29698163597, 83030.58484707598, 83288.0, 10898.509567069501, 10938.398388088572, 11033.889661103447, 11220.66338009861, 11454.54181832734, 18848.62302753965, 18866.528336791416, 18908.71636925447, 18943.33698320552, 18961.241550337832, 8501.628013823125, 8656.394052416397, 8762.693305734269, 8935.553222338856, 8942.50816205115, 4565.771711414416, 4578.061497393093, 4674.345591617176, 4696.319033740157, 4835.202191638411, 3353.480210567366, 3777.6411240932066, 3975.860844870416, 3976.264391087658, 4018.0959284161413, 641.7625478572958, 647.795944277551, 660.0363469334825, 663.9203295604461, 678.9219239787388, 671.1208317104608, 671.7313074770034, 688.7382794538044, 694.8193469697915, 708.7200555780438, 9206.723798285928, 9325.953370233105, 9335.159835614828, 9605.327627066177, 9616.423014619146, 547.2584647802171, 654.9541532092803, 679.6771533521538, 715.7172916697979, 716.7101111947383, 4327.729210928315, 4405.603495685404, 4588.197065513522, 4789.234905065037, 4866.343043689057, 68592.97110543346, 69141.65429172822, 69176.30823691799, 70031.64984175148, 85004.0, 103505.0, 105401.0, 105905.0, 109009.0, 109648.4517577407, 93903.53048234715, 94111.52944235234, 94193.0, 96119.51940240254, 96958.0, 8585.270252028648, 8691.217790398894, 9004.234640055407, 9009.36934414611, 9327.533623318943, 47104.29343559781, 47217.527824721314, 47733.284000739324, 50904.78640248124, 51281.743591281804, 59197.0, 71877.64061179661, 73491.26508735058, 75098.0, 75104.24895750973, 12108.273503589813, 12212.694682633006, 12676.809847852106, 12697.0, 13005.21968681882, 12937.288449135387, 13506.189628621922, 13871.583852484442, 14102.78845817293, 14730.926345368205, 12293.323867187391, 12330.63008109758, 12467.438965246767, 12582.622521324374, 12973.935130324666, 11630.847029077184, 11839.28964262147, 12012.879871201176, 12415.255084694947, 12463.314517701614, 11570.85865218033, 11694.854264123758, 11735.295882246752, 11971.64085077449, 12180.976216524059, 9772.911799719937, 10289.5908669793, 10344.637937672145, 10402.427866467417, 10579.0, 10092.596296148073, 10103.696889093339, 10110.848337275094, 10238.948805255926, 10349.896501034893], "value": 7308.881701717831, "unit": "score"}], "name": "dromaeo_css", "value": 7089.402766637559, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 111.0, 112.0, 112.0, 110.0, 110.0, 111.0, 111.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 128.0, 120.0, 164.0, 123.0, 124.0, 127.0, 119.0, 153.0, 124.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 161.0, 160.0, 161.0, 163.0, 161.0, 163.0, 160.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 108.0, 76.0, 76.0, 75.0, 76.0, 101.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 110.0, 82.0, 81.0, 82.0, 118.0, 82.0, 82.0, 125.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 53.0, 53.0, 54.0, 54.0, 53.0, 53.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 59.0, 59.0, 60.0, 59.0, 67.0, 59.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 81.0, 80.0, 80.0, 85.0, 80.0, 79.0, 80.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 139.0, 132.0, 141.0, 129.0, 130.0, 142.0, 134.0, 172.0, 137.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 170.0, 173.0, 169.0, 171.0, 187.0, 167.0, 166.0, 167.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 75.0, 71.0, 67.0, 74.0, 65.0, 70.0, 65.0, 65.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1498.3000000000002, "alertThreshold": 2.0}]} 15:36:27 INFO - Return code: 0 15:36:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:36:27 INFO - # TBPL SUCCESS # 15:36:27 INFO - Running post-action listener: _resource_record_post_action 15:36:27 INFO - [mozharness: 2016-10-23 22:36:27.159178Z] Finished run-tests step (success) 15:36:27 INFO - Running post-run listener: _resource_record_post_run 15:36:27 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392163328; Read time: 12; Write time: 608080 15:36:27 INFO - TinderboxPrint: CPU usage
13.1% 15:36:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:36:27 INFO - TinderboxPrint: I/O write bytes / time
392,163,328 / 608,080 15:36:27 INFO - TinderboxPrint: CPU idle
8,325.2 (86.9%) 15:36:27 INFO - TinderboxPrint: CPU user
1,201.5 (12.5%) 15:36:27 INFO - TinderboxPrint: Swap in / out
0 / 0 15:36:27 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 103596032; Read time: 0; Write time: 192680 15:36:27 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 288567296; Read time: 0; Write time: 415400 15:36:27 INFO - Running post-run listener: _upload_blobber_files 15:36:27 INFO - Blob upload gear active. 15:36:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:36:27 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 15:36:27 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:36:27 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:36:28 INFO - (blobuploader) - INFO - Open directory for files ... 15:36:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:36:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:36:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:29 INFO - (blobuploader) - INFO - Done attempting. 15:36:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:36:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:36:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:29 INFO - (blobuploader) - INFO - Done attempting. 15:36:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:36:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:36:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:32 INFO - (blobuploader) - INFO - Done attempting. 15:36:32 INFO - (blobuploader) - INFO - Iteration through files over. 15:36:32 INFO - Return code: 0 15:36:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:36:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:36:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f87a93304ae277ea38935826eb83c3fc8e78ccae72806f34a1b9f40e3a35d85c9293cb727203a4d6b020f682ec716347edacc0661c2ba0946237437f71a7c6a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b45b0545292fb10876c493e0fac3493fbf684d45296ea1b0d68c4cfd17cf66922c0e79b0946f6bdf8b0dc0202f2ae54ec915019faeabf270924f97fef355776", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4f9cd65c18b352d5308d8a3c28041ce98de376cec35ddeb915a19be62c38e583af49b46e3d843fc04d6bdda03d99c4397ad0629aa2baf5a49ce56f3bf33abb7"} 15:36:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:36:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:36:32 INFO - Contents: 15:36:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f87a93304ae277ea38935826eb83c3fc8e78ccae72806f34a1b9f40e3a35d85c9293cb727203a4d6b020f682ec716347edacc0661c2ba0946237437f71a7c6a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b45b0545292fb10876c493e0fac3493fbf684d45296ea1b0d68c4cfd17cf66922c0e79b0946f6bdf8b0dc0202f2ae54ec915019faeabf270924f97fef355776", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4f9cd65c18b352d5308d8a3c28041ce98de376cec35ddeb915a19be62c38e583af49b46e3d843fc04d6bdda03d99c4397ad0629aa2baf5a49ce56f3bf33abb7"} 15:36:32 INFO - Running post-run listener: copy_logs_to_upload_dir 15:36:32 INFO - Copying logs to upload dir... 15:36:32 INFO - mkdir: /builds/slave/test/build/upload/logs 15:36:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.637389 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-23 15:36:32.436101) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 15:36:32.441739) ========= 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=5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f87a93304ae277ea38935826eb83c3fc8e78ccae72806f34a1b9f40e3a35d85c9293cb727203a4d6b020f682ec716347edacc0661c2ba0946237437f71a7c6a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b45b0545292fb10876c493e0fac3493fbf684d45296ea1b0d68c4cfd17cf66922c0e79b0946f6bdf8b0dc0202f2ae54ec915019faeabf270924f97fef355776", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4f9cd65c18b352d5308d8a3c28041ce98de376cec35ddeb915a19be62c38e583af49b46e3d843fc04d6bdda03d99c4397ad0629aa2baf5a49ce56f3bf33abb7"} build_url:https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011421 build_url: 'https://queue.taskcluster.net/v1/task/QOhxRgrQSZyS5-zvATfybw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f87a93304ae277ea38935826eb83c3fc8e78ccae72806f34a1b9f40e3a35d85c9293cb727203a4d6b020f682ec716347edacc0661c2ba0946237437f71a7c6a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b45b0545292fb10876c493e0fac3493fbf684d45296ea1b0d68c4cfd17cf66922c0e79b0946f6bdf8b0dc0202f2ae54ec915019faeabf270924f97fef355776", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4f9cd65c18b352d5308d8a3c28041ce98de376cec35ddeb915a19be62c38e583af49b46e3d843fc04d6bdda03d99c4397ad0629aa2baf5a49ce56f3bf33abb7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 15:36:32.467498) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 15:36:32.467824) ========= 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=5cf47e208febbcd81da23b2e0000026f-1477258492.581470-1470263915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 15:36:32.550651) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-23 15:36:32.554345) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-23 15:36:32.554653) ========= ========= Total master_lag: 0.17 =========