builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1491208790.69 results: success (0) revision: 6f295b1cb01fea18d05429610363c735e6c1f671 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 01:39:50.686205) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 01:39:50.686717) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 01:39:50.687039) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 01:39:50.759373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 01:39:50.759687) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-03 01:39:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2017-04-03 01:39:51 (218 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092373 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 01:39:50.871753) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 01:39:50.872079) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023146 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 01:39:50.924615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 01:39:50.925002) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6f295b1cb01fea18d05429610363c735e6c1f671 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6f295b1cb01fea18d05429610363c735e6c1f671 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-03 01:39:51,626 truncating revision to first 12 chars 2017-04-03 01:39:51,626 Setting DEBUG logging. 2017-04-03 01:39:51,627 attempt 1/10 2017-04-03 01:39:51,627 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6f295b1cb01f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-03 01:39:51,933 unpacking tar archive at: mozilla-aurora-6f295b1cb01f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637410 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 01:39:51.576703) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 01:39:51.577077) ========= script_repo_revision: 6f295b1cb01fea18d05429610363c735e6c1f671 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 01:39:51.577519) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 01:39:51.577828) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 01:39:51.590048) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-04-03 01:39:51.590388) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:39:52 INFO - MultiFileLogger online at 20170403 01:39:52 in /builds/slave/test 01:39:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:39:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:39:52 INFO - {'append_to_log': False, 01:39:52 INFO - 'base_work_dir': '/builds/slave/test', 01:39:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:39:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:39:52 INFO - 'branch': 'Mozilla-Aurora', 01:39:52 INFO - 'buildbot_json_path': 'buildprops.json', 01:39:52 INFO - 'config_files': ('talos/linux_config.py',), 01:39:52 INFO - 'default_actions': ('clobber', 01:39:52 INFO - 'read-buildbot-config', 01:39:52 INFO - 'download-and-extract', 01:39:52 INFO - 'populate-webroot', 01:39:52 INFO - 'create-virtualenv', 01:39:52 INFO - 'install', 01:39:52 INFO - 'run-tests'), 01:39:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:39:52 INFO - 'download_minidump_stackwalk': True, 01:39:52 INFO - 'download_symbols': 'ondemand', 01:39:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:39:52 INFO - 'tooltool.py': '/tools/tooltool.py', 01:39:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:39:52 INFO - '/tools/misc-python/virtualenv.py')}, 01:39:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:39:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:39:52 INFO - 'gecko_profile': False, 01:39:52 INFO - 'gecko_profile_interval': 0, 01:39:52 INFO - 'installer_path': 'installer.exe', 01:39:52 INFO - 'log_level': 'info', 01:39:52 INFO - 'log_name': 'talos', 01:39:52 INFO - 'log_to_console': True, 01:39:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:39:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:39:52 INFO - 'opt_config_files': (), 01:39:52 INFO - 'pip_index': False, 01:39:52 INFO - 'suite': 'dromaeojs', 01:39:52 INFO - 'system_bits': '32', 01:39:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:39:52 INFO - 'title': 'talos-linux64-ix-013', 01:39:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:39:52 INFO - 'use_talos_json': True, 01:39:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:39:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:39:52 INFO - 'work_dir': 'build'} 01:39:52 INFO - [mozharness: 2017-04-03 08:39:52.396689Z] Running clobber step. 01:39:52 INFO - Running pre-action listener: _resource_record_pre_action 01:39:52 INFO - Running main action method: clobber 01:39:52 INFO - rmtree: /builds/slave/test/build 01:39:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:39:53 INFO - Running post-action listener: _resource_record_post_action 01:39:53 INFO - [mozharness: 2017-04-03 08:39:53.322545Z] Finished clobber step (success) 01:39:53 INFO - [mozharness: 2017-04-03 08:39:53.322644Z] Running read-buildbot-config step. 01:39:53 INFO - Running pre-action listener: _resource_record_pre_action 01:39:53 INFO - Running main action method: read_buildbot_config 01:39:53 INFO - Using buildbot properties: 01:39:53 INFO - { 01:39:53 INFO - "project": "", 01:39:53 INFO - "product": "firefox", 01:39:53 INFO - "who": "cbook@mozilla.com", 01:39:53 INFO - "installer_path": "public/build/target.tar.bz2", 01:39:53 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:39:53 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 01:39:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:39:53 INFO - "stage_platform": "linux64-pgo", 01:39:53 INFO - "basedir": "/builds/slave/test", 01:39:53 INFO - "buildnumber": 819, 01:39:53 INFO - "platform": "ubuntu64_hw", 01:39:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:39:53 INFO - "slavebuilddir": "test", 01:39:53 INFO - "taskId": "Y8giWMLjR1uSmf25itSUqQ", 01:39:53 INFO - "branch": "mozilla-aurora", 01:39:53 INFO - "script_repo_revision": "production", 01:39:53 INFO - "revision": "6f295b1cb01fea18d05429610363c735e6c1f671", 01:39:53 INFO - "slavename": "talos-linux64-ix-013", 01:39:53 INFO - "repo_path": "releases/mozilla-aurora" 01:39:53 INFO - } 01:39:53 INFO - Finding installer, test and symbols from parent task. 01:39:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y8giWMLjR1uSmf25itSUqQ'}, attempt #1 01:39:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y8giWMLjR1uSmf25itSUqQ'}, attempt #1 01:39:54 INFO - Task dependencies: AdtRDzOcSK29fxASgXfYDQ 01:39:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ'}, attempt #1 01:39:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.tar.bz2 01:39:54 INFO - Set test_url: https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/test_packages.json 01:39:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.crashreporter-symbols.zip 01:39:54 INFO - Running post-action listener: _resource_record_post_action 01:39:54 INFO - [mozharness: 2017-04-03 08:39:54.640450Z] Finished read-buildbot-config step (success) 01:39:54 INFO - [mozharness: 2017-04-03 08:39:54.640667Z] Running download-and-extract step. 01:39:54 INFO - Running pre-action listener: _resource_record_pre_action 01:39:54 INFO - Running main action method: download_and_extract 01:39:54 INFO - mkdir: /builds/slave/test/build/tests 01:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:39:54 INFO - trying https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.test_packages.json 01:39:54 INFO - Downloading https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:39:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:39:55 INFO - Downloaded 896 bytes. 01:39:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:39:55 INFO - Using the following test package requirements: 01:39:55 INFO - {u'common': [u'target.common.tests.zip'], 01:39:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:39:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:39:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:39:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:39:55 INFO - u'mozbase': [u'target.common.tests.zip'], 01:39:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:39:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:39:55 INFO - u'web-platform': [u'target.common.tests.zip', 01:39:55 INFO - u'target.web-platform.tests.zip'], 01:39:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:39:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:39:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.common.tests.zip 01:39:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:39:55 INFO - Fetch https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.common.tests.zip into memory 01:39:56 INFO - Expected file size: 59540532 01:39:56 INFO - Obtained file size: 59540532 01:40:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:40:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.common.tests.zip 01:40:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:40:05 INFO - Fetch https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.common.tests.zip into memory 01:40:07 INFO - Expected file size: 59540532 01:40:07 INFO - Obtained file size: 59540532 01:40:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.talos.tests.zip 01:40:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:40:18 INFO - Fetch https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.talos.tests.zip into memory 01:40:18 INFO - Expected file size: 14404438 01:40:18 INFO - Obtained file size: 14404438 01:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:19 INFO - trying https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.tar.bz2 01:40:19 INFO - Downloading https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:40:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:40:20 INFO - Downloaded 66647704 bytes. 01:40:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.tar.bz2 01:40:20 INFO - mkdir: /builds/slave/test/properties 01:40:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:40:20 INFO - Writing to file /builds/slave/test/properties/build_url 01:40:20 INFO - Contents: 01:40:20 INFO - build_url:https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.tar.bz2 01:40:20 INFO - Running post-action listener: _resource_record_post_action 01:40:20 INFO - Running post-action listener: set_extra_try_arguments 01:40:20 INFO - [mozharness: 2017-04-03 08:40:20.359711Z] Finished download-and-extract step (success) 01:40:20 INFO - [mozharness: 2017-04-03 08:40:20.359845Z] Running populate-webroot step. 01:40:20 INFO - Running pre-action listener: _resource_record_pre_action 01:40:20 INFO - Running main action method: populate_webroot 01:40:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:40:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:40:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:40:20 INFO - '--tppagecycles', 01:40:20 INFO - '7'], 01:40:20 INFO - 'tests': ['tsvgm']}}, 01:40:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:40:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:40:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:40:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:40:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:40:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:40:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:40:20 INFO - 'talos_options': ['--disable-e10s'], 01:40:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:40:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:40:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:40:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:40:20 INFO - 'talos_options': ['--disable-e10s'], 01:40:20 INFO - 'tests': ['damp', 'tps']}, 01:40:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:40:20 INFO - 'tests': ['damp', 'tps']}, 01:40:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:40:20 INFO - 'tests': ['dromaeo_dom']}, 01:40:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:40:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:40:20 INFO - 'tests': ['basic_compositor_video']}, 01:40:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:40:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:40:20 INFO - 'tests': ['a11yr', 01:40:20 INFO - 'ts_paint', 01:40:20 INFO - 'tpaint', 01:40:20 INFO - 'sessionrestore', 01:40:20 INFO - 'sessionrestore_no_auto_restore', 01:40:20 INFO - 'tabpaint']}, 01:40:20 INFO - 'other-e10s': {'tests': ['a11yr', 01:40:20 INFO - 'ts_paint', 01:40:20 INFO - 'tpaint', 01:40:20 INFO - 'sessionrestore', 01:40:20 INFO - 'sessionrestore_no_auto_restore', 01:40:20 INFO - 'tabpaint']}, 01:40:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:40:20 INFO - 'ts_paint', 01:40:20 INFO - 'tpaint', 01:40:20 INFO - 'sessionrestore', 01:40:20 INFO - 'sessionrestore_no_auto_restore', 01:40:20 INFO - 'tabpaint']}, 01:40:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:40:20 INFO - 'ts_paint', 01:40:20 INFO - 'tpaint', 01:40:20 INFO - 'sessionrestore', 01:40:20 INFO - 'sessionrestore_no_auto_restore', 01:40:20 INFO - 'tabpaint']}, 01:40:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:40:20 INFO - 'tests': ['a11yr', 01:40:20 INFO - 'ts_paint', 01:40:20 INFO - 'tpaint', 01:40:20 INFO - 'sessionrestore', 01:40:20 INFO - 'sessionrestore_no_auto_restore', 01:40:20 INFO - 'tabpaint']}, 01:40:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:40:20 INFO - 'tests': ['a11yr', 01:40:20 INFO - 'ts_paint', 01:40:20 INFO - 'tpaint', 01:40:20 INFO - 'sessionrestore', 01:40:20 INFO - 'sessionrestore_no_auto_restore', 01:40:20 INFO - 'tabpaint']}, 01:40:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:40:20 INFO - 'tests': ['tsvgx', 01:40:20 INFO - 'tsvgr_opacity', 01:40:20 INFO - 'tart', 01:40:20 INFO - 'tscrollx', 01:40:20 INFO - 'cart', 01:40:20 INFO - 'tsvg_static']}, 01:40:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:40:20 INFO - 'tsvgr_opacity', 01:40:20 INFO - 'tart', 01:40:20 INFO - 'tscrollx', 01:40:20 INFO - 'cart', 01:40:20 INFO - 'tsvg_static']}, 01:40:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:40:20 INFO - 'talos_options': ['--disable-e10s'], 01:40:20 INFO - 'tests': ['tp5o']}, 01:40:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:40:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:40:20 INFO - 'talos_options': ['--disable-e10s', 01:40:20 INFO - '--xperf_path', 01:40:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:40:20 INFO - 'tests': ['tp5n']}, 01:40:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:40:20 INFO - 'talos_options': ['--xperf_path', 01:40:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:40:20 INFO - 'tests': ['tp5n']}}, 01:40:20 INFO - 'talos.zip': {'path': '', 01:40:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:40:20 INFO - Running post-action listener: _resource_record_post_action 01:40:20 INFO - [mozharness: 2017-04-03 08:40:20.374854Z] Finished populate-webroot step (success) 01:40:20 INFO - [mozharness: 2017-04-03 08:40:20.374945Z] Running create-virtualenv step. 01:40:20 INFO - Running pre-action listener: _resource_record_pre_action 01:40:20 INFO - Running main action method: create_virtualenv 01:40:20 INFO - Creating virtualenv /builds/slave/test/build/venv 01:40:20 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 01:40:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:40:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:40:20 INFO - Using real prefix '/usr' 01:40:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:40:20 INFO - Installing distribute.............................................................................................................................................................................................done. 01:40:22 INFO - Installing pip.................done. 01:40:22 INFO - Return code: 0 01:40:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:40:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:40:23 INFO - Reading from file tmpfile_stdout 01:40:23 INFO - Output received: 01:40:23 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) 01:40:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:40:23 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')]} 01:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:23 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')]} 01:40:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:23 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 0x1d511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feeb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec290>, '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 0x1fecb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', '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 01:40:23 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 01:40:23 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 01:40:23 INFO - Using env: {'DISPLAY': ':0', 01:40:23 INFO - 'HOME': '/home/cltbld', 01:40:23 INFO - 'LANG': 'en_US.UTF-8', 01:40:23 INFO - 'LANGUAGE': 'en_US:en', 01:40:23 INFO - 'LOGNAME': 'cltbld', 01:40:23 INFO - 'MAIL': '/var/mail/cltbld', 01:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:23 INFO - 'MOZ_NO_REMOTE': '1', 01:40:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:23 INFO - 'NO_EM_RESTART': '1', 01:40:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:23 INFO - 'PWD': '/builds/slave/test', 01:40:23 INFO - 'SHELL': '/bin/bash', 01:40:23 INFO - 'SHLVL': '1', 01:40:23 INFO - 'TERM': 'linux', 01:40:23 INFO - 'TMOUT': '86400', 01:40:23 INFO - 'USER': 'cltbld', 01:40:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', 01:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:23 INFO - '_': '/tools/buildbot/bin/python'} 01:40:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:23 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 01:40:23 INFO - Cleaning up... 01:40:23 INFO - Return code: 0 01:40:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:40:23 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')]} 01:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:23 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')]} 01:40:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:23 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 0x1d511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feeb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec290>, '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 0x1fecb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', '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 01:40:23 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 01:40:23 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 01:40:23 INFO - Using env: {'DISPLAY': ':0', 01:40:23 INFO - 'HOME': '/home/cltbld', 01:40:23 INFO - 'LANG': 'en_US.UTF-8', 01:40:23 INFO - 'LANGUAGE': 'en_US:en', 01:40:23 INFO - 'LOGNAME': 'cltbld', 01:40:23 INFO - 'MAIL': '/var/mail/cltbld', 01:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:23 INFO - 'MOZ_NO_REMOTE': '1', 01:40:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:23 INFO - 'NO_EM_RESTART': '1', 01:40:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:23 INFO - 'PWD': '/builds/slave/test', 01:40:23 INFO - 'SHELL': '/bin/bash', 01:40:23 INFO - 'SHLVL': '1', 01:40:23 INFO - 'TERM': 'linux', 01:40:23 INFO - 'TMOUT': '86400', 01:40:23 INFO - 'USER': 'cltbld', 01:40:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', 01:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:23 INFO - '_': '/tools/buildbot/bin/python'} 01:40:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:23 INFO - Downloading/unpacking psutil>=3.1.1 01:40:23 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 01:40:23 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 01:40:23 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 01:40:23 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 01:40:23 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 01:40:23 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 01:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:40:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:40:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:40:25 INFO - Installing collected packages: psutil 01:40:25 INFO - Running setup.py install for psutil 01:40:25 INFO - building 'psutil._psutil_linux' extension 01:40:25 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 01:40:25 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 01:40:26 INFO - building 'psutil._psutil_posix' extension 01:40:26 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 01:40:26 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 01:40:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:40:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:40:26 INFO - Successfully installed psutil 01:40:26 INFO - Cleaning up... 01:40:26 INFO - Return code: 0 01:40:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:26 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 0x1d511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feeb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec290>, '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 0x1fecb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', '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 01:40:26 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 01:40:26 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 01:40:26 INFO - Using env: {'DISPLAY': ':0', 01:40:26 INFO - 'HOME': '/home/cltbld', 01:40:26 INFO - 'LANG': 'en_US.UTF-8', 01:40:26 INFO - 'LANGUAGE': 'en_US:en', 01:40:26 INFO - 'LOGNAME': 'cltbld', 01:40:26 INFO - 'MAIL': '/var/mail/cltbld', 01:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:26 INFO - 'MOZ_NO_REMOTE': '1', 01:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:26 INFO - 'NO_EM_RESTART': '1', 01:40:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:26 INFO - 'PWD': '/builds/slave/test', 01:40:26 INFO - 'SHELL': '/bin/bash', 01:40:26 INFO - 'SHLVL': '1', 01:40:26 INFO - 'TERM': 'linux', 01:40:26 INFO - 'TMOUT': '86400', 01:40:26 INFO - 'USER': 'cltbld', 01:40:26 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', 01:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:26 INFO - '_': '/tools/buildbot/bin/python'} 01:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:40:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:40:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:40:28 INFO - Installing collected packages: mozsystemmonitor 01:40:28 INFO - Running setup.py install for mozsystemmonitor 01:40:28 INFO - Successfully installed mozsystemmonitor 01:40:28 INFO - Cleaning up... 01:40:28 INFO - Return code: 0 01:40:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:28 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 0x1d511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feeb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec290>, '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 0x1fecb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', '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 01:40:28 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 01:40:28 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 01:40:28 INFO - Using env: {'DISPLAY': ':0', 01:40:28 INFO - 'HOME': '/home/cltbld', 01:40:28 INFO - 'LANG': 'en_US.UTF-8', 01:40:28 INFO - 'LANGUAGE': 'en_US:en', 01:40:28 INFO - 'LOGNAME': 'cltbld', 01:40:28 INFO - 'MAIL': '/var/mail/cltbld', 01:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:28 INFO - 'MOZ_NO_REMOTE': '1', 01:40:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:28 INFO - 'NO_EM_RESTART': '1', 01:40:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:28 INFO - 'PWD': '/builds/slave/test', 01:40:28 INFO - 'SHELL': '/bin/bash', 01:40:28 INFO - 'SHLVL': '1', 01:40:28 INFO - 'TERM': 'linux', 01:40:28 INFO - 'TMOUT': '86400', 01:40:28 INFO - 'USER': 'cltbld', 01:40:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', 01:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:28 INFO - '_': '/tools/buildbot/bin/python'} 01:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:28 INFO - Downloading/unpacking jsonschema==2.5.1 01:40:28 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 01:40:28 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 01:40:28 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 01:40:28 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 01:40:28 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 01:40:28 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 01:40:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:40:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:40:30 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 01:40:30 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 01:40:30 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 01:40:30 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 01:40:30 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 01:40:30 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 01:40:31 INFO - Downloading functools32-3.2.3-2.tar.gz 01:40:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:40:31 INFO - warning: no files found matching '*.txt' 01:40:31 INFO - no previously-included directories found matching 'build' 01:40:31 INFO - no previously-included directories found matching 'dist' 01:40:31 INFO - no previously-included directories found matching '.git*' 01:40:31 INFO - Installing collected packages: jsonschema, functools32 01:40:31 INFO - Running setup.py install for functools32 01:40:31 INFO - warning: no files found matching '*.txt' 01:40:31 INFO - no previously-included directories found matching 'build' 01:40:31 INFO - no previously-included directories found matching 'dist' 01:40:31 INFO - no previously-included directories found matching '.git*' 01:40:31 INFO - Successfully installed jsonschema functools32 01:40:31 INFO - Cleaning up... 01:40:31 INFO - Return code: 0 01:40:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:31 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 0x1d511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feeb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec290>, '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 0x1fecb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', '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 01:40:31 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 01:40:31 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 01:40:31 INFO - Using env: {'DISPLAY': ':0', 01:40:31 INFO - 'HOME': '/home/cltbld', 01:40:31 INFO - 'LANG': 'en_US.UTF-8', 01:40:31 INFO - 'LANGUAGE': 'en_US:en', 01:40:31 INFO - 'LOGNAME': 'cltbld', 01:40:31 INFO - 'MAIL': '/var/mail/cltbld', 01:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:31 INFO - 'MOZ_NO_REMOTE': '1', 01:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:31 INFO - 'NO_EM_RESTART': '1', 01:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:31 INFO - 'PWD': '/builds/slave/test', 01:40:31 INFO - 'SHELL': '/bin/bash', 01:40:31 INFO - 'SHLVL': '1', 01:40:31 INFO - 'TERM': 'linux', 01:40:31 INFO - 'TMOUT': '86400', 01:40:31 INFO - 'USER': 'cltbld', 01:40:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', 01:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:31 INFO - '_': '/tools/buildbot/bin/python'} 01:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:40:31 INFO - Cleaning up... 01:40:31 INFO - Return code: 0 01:40:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:31 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 0x1d511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feeb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec290>, '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 0x1fecb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', '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 01:40:31 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 01:40:31 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 01:40:31 INFO - Using env: {'DISPLAY': ':0', 01:40:31 INFO - 'HOME': '/home/cltbld', 01:40:31 INFO - 'LANG': 'en_US.UTF-8', 01:40:31 INFO - 'LANGUAGE': 'en_US:en', 01:40:31 INFO - 'LOGNAME': 'cltbld', 01:40:31 INFO - 'MAIL': '/var/mail/cltbld', 01:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:31 INFO - 'MOZ_NO_REMOTE': '1', 01:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:31 INFO - 'NO_EM_RESTART': '1', 01:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:31 INFO - 'PWD': '/builds/slave/test', 01:40:31 INFO - 'SHELL': '/bin/bash', 01:40:31 INFO - 'SHLVL': '1', 01:40:31 INFO - 'TERM': 'linux', 01:40:31 INFO - 'TMOUT': '86400', 01:40:31 INFO - 'USER': 'cltbld', 01:40:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', 01:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:31 INFO - '_': '/tools/buildbot/bin/python'} 01:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:31 INFO - Downloading/unpacking blobuploader==1.2.4 01:40:31 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 01:40:31 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 01:40:31 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 01:40:31 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 01:40:31 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 01:40:31 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 01:40:33 INFO - Downloading blobuploader-1.2.4.tar.gz 01:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:40:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:40:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:34 INFO - Downloading docopt-0.6.1.tar.gz 01:40:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:40:34 INFO - Installing collected packages: blobuploader, requests, docopt 01:40:34 INFO - Running setup.py install for blobuploader 01:40:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:40:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:40:34 INFO - Running setup.py install for requests 01:40:35 INFO - Running setup.py install for docopt 01:40:35 INFO - Successfully installed blobuploader requests docopt 01:40:35 INFO - Cleaning up... 01:40:35 INFO - Return code: 0 01:40:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:35 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 0x1d511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feeb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec290>, '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 0x1fecb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', '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 01:40:35 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 01:40:35 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 01:40:35 INFO - Using env: {'DISPLAY': ':0', 01:40:35 INFO - 'HOME': '/home/cltbld', 01:40:35 INFO - 'LANG': 'en_US.UTF-8', 01:40:35 INFO - 'LANGUAGE': 'en_US:en', 01:40:35 INFO - 'LOGNAME': 'cltbld', 01:40:35 INFO - 'MAIL': '/var/mail/cltbld', 01:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:35 INFO - 'MOZ_NO_REMOTE': '1', 01:40:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:35 INFO - 'NO_EM_RESTART': '1', 01:40:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:35 INFO - 'PWD': '/builds/slave/test', 01:40:35 INFO - 'SHELL': '/bin/bash', 01:40:35 INFO - 'SHLVL': '1', 01:40:35 INFO - 'TERM': 'linux', 01:40:35 INFO - 'TMOUT': '86400', 01:40:35 INFO - 'USER': 'cltbld', 01:40:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', 01:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:35 INFO - '_': '/tools/buildbot/bin/python'} 01:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:40:35 INFO - Running setup.py (path:/tmp/pip-Gw7CXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:40:35 INFO - Running setup.py (path:/tmp/pip-8AcaXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:40:35 INFO - Running setup.py (path:/tmp/pip-Gagd0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:40:35 INFO - Running setup.py (path:/tmp/pip-xVV2K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:40:35 INFO - Running setup.py (path:/tmp/pip-3n2TqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:40:35 INFO - Running setup.py (path:/tmp/pip-jg7Bi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:40:35 INFO - Running setup.py (path:/tmp/pip-pSZVp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:40:35 INFO - Running setup.py (path:/tmp/pip-6njQKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:40:36 INFO - Running setup.py (path:/tmp/pip-qujFOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:40:36 INFO - Running setup.py (path:/tmp/pip-CJv8NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:40:36 INFO - Running setup.py (path:/tmp/pip-v1RYfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:40:36 INFO - Running setup.py (path:/tmp/pip-PngLGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:40:36 INFO - Running setup.py (path:/tmp/pip-Qbj2u3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:40:36 INFO - Running setup.py (path:/tmp/pip-2OW0tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:40:36 INFO - Running setup.py (path:/tmp/pip-kqHteb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:40:36 INFO - Running setup.py (path:/tmp/pip-erxlrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:40:36 INFO - Running setup.py (path:/tmp/pip-Tlr8RN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:40:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:40:36 INFO - Running setup.py install for manifestparser 01:40:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:40:36 INFO - Running setup.py install for mozcrash 01:40:36 INFO - Running setup.py install for mozdebug 01:40:36 INFO - Running setup.py install for mozdevice 01:40:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:40:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:40:37 INFO - Running setup.py install for mozfile 01:40:37 INFO - Running setup.py install for mozhttpd 01:40:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:40:37 INFO - Running setup.py install for mozinfo 01:40:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:40:37 INFO - Running setup.py install for mozInstall 01:40:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:40:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:40:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:40:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:40:37 INFO - Running setup.py install for mozleak 01:40:37 INFO - Running setup.py install for mozlog 01:40:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:40:37 INFO - Running setup.py install for moznetwork 01:40:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:40:37 INFO - Running setup.py install for mozprocess 01:40:37 INFO - Running setup.py install for mozprofile 01:40:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:40:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:40:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:40:38 INFO - Running setup.py install for mozrunner 01:40:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:40:38 INFO - Running setup.py install for mozscreenshot 01:40:38 INFO - Running setup.py install for moztest 01:40:38 INFO - Running setup.py install for mozversion 01:40:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:40:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:40:38 INFO - Cleaning up... 01:40:38 INFO - Return code: 0 01:40:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:38 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 0x1d511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feeb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec290>, '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 0x1fecb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', '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 01:40:38 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 01:40:38 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 01:40:38 INFO - Using env: {'DISPLAY': ':0', 01:40:38 INFO - 'HOME': '/home/cltbld', 01:40:38 INFO - 'LANG': 'en_US.UTF-8', 01:40:38 INFO - 'LANGUAGE': 'en_US:en', 01:40:38 INFO - 'LOGNAME': 'cltbld', 01:40:38 INFO - 'MAIL': '/var/mail/cltbld', 01:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:38 INFO - 'MOZ_NO_REMOTE': '1', 01:40:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:38 INFO - 'NO_EM_RESTART': '1', 01:40:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:38 INFO - 'PWD': '/builds/slave/test', 01:40:38 INFO - 'SHELL': '/bin/bash', 01:40:38 INFO - 'SHLVL': '1', 01:40:38 INFO - 'TERM': 'linux', 01:40:38 INFO - 'TMOUT': '86400', 01:40:38 INFO - 'USER': 'cltbld', 01:40:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', 01:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:38 INFO - '_': '/tools/buildbot/bin/python'} 01:40:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:40:38 INFO - Running setup.py (path:/tmp/pip-ANwhub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:40:38 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)) 01:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:40:38 INFO - Running setup.py (path:/tmp/pip-vrZ61X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:40:38 INFO - Running setup.py (path:/tmp/pip-IrQ1Fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:40:38 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)) 01:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:40:38 INFO - Running setup.py (path:/tmp/pip-KiKHo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:40:39 INFO - Running setup.py (path:/tmp/pip-XUjsL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:40:39 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)) 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:40:39 INFO - Running setup.py (path:/tmp/pip-9rhR2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:40:39 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)) 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:40:39 INFO - Running setup.py (path:/tmp/pip-VsR3zA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:40:39 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)) 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:40:39 INFO - Running setup.py (path:/tmp/pip-4T8C_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:40:39 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)) 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:40:39 INFO - Running setup.py (path:/tmp/pip-odj_mI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:40:39 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)) 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:40:39 INFO - Running setup.py (path:/tmp/pip-OJ_DlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:40:39 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)) 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:40:39 INFO - Running setup.py (path:/tmp/pip-rD028N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:40:39 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)) 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:40:39 INFO - Running setup.py (path:/tmp/pip-BTS_VJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:40:39 INFO - Running setup.py (path:/tmp/pip-RVd1zU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:40:39 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)) 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:40:39 INFO - Running setup.py (path:/tmp/pip-yVYFZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:40:39 INFO - Running setup.py (path:/tmp/pip-dPCIFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:40:39 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)) 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:40:39 INFO - Running setup.py (path:/tmp/pip-RqaJ58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 01:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:40:39 INFO - Running setup.py (path:/tmp/pip-xTsESV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:40:39 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)) 01:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:40:39 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)) 01:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:40:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:40:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:40:41 INFO - Downloading blessings-1.6.tar.gz 01:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:40:42 INFO - Installing collected packages: blessings 01:40:42 INFO - Running setup.py install for blessings 01:40:42 INFO - Successfully installed blessings 01:40:42 INFO - Cleaning up... 01:40:42 INFO - Return code: 0 01:40:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:40:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:40:42 INFO - Reading from file tmpfile_stdout 01:40:42 INFO - Current package versions: 01:40:42 INFO - argparse == 1.2.1 01:40:42 INFO - blessings == 1.6 01:40:42 INFO - blobuploader == 1.2.4 01:40:42 INFO - docopt == 0.6.1 01:40:42 INFO - functools32 == 3.2.3-2 01:40:42 INFO - jsonschema == 2.5.1 01:40:42 INFO - manifestparser == 1.1 01:40:42 INFO - mozInstall == 1.12 01:40:42 INFO - mozcrash == 1.0 01:40:42 INFO - mozdebug == 0.1 01:40:42 INFO - mozdevice == 0.49 01:40:42 INFO - mozfile == 1.2 01:40:42 INFO - mozhttpd == 0.7 01:40:42 INFO - mozinfo == 0.9 01:40:42 INFO - mozleak == 0.1 01:40:42 INFO - mozlog == 3.4 01:40:42 INFO - moznetwork == 0.27 01:40:42 INFO - mozprocess == 0.25 01:40:42 INFO - mozprofile == 0.28 01:40:42 INFO - mozrunner == 6.13 01:40:42 INFO - mozscreenshot == 0.1 01:40:42 INFO - mozsystemmonitor == 0.3 01:40:42 INFO - moztest == 0.8 01:40:42 INFO - mozversion == 1.4 01:40:42 INFO - psutil == 3.1.1 01:40:42 INFO - requests == 1.2.3 01:40:42 INFO - wsgiref == 0.1.2 01:40:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:42 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 0x1d511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feeb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec290>, '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 0x1fecb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', '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 01:40:42 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 01:40:42 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 01:40:42 INFO - Using env: {'DISPLAY': ':0', 01:40:42 INFO - 'HOME': '/home/cltbld', 01:40:42 INFO - 'LANG': 'en_US.UTF-8', 01:40:42 INFO - 'LANGUAGE': 'en_US:en', 01:40:42 INFO - 'LOGNAME': 'cltbld', 01:40:42 INFO - 'MAIL': '/var/mail/cltbld', 01:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:42 INFO - 'MOZ_NO_REMOTE': '1', 01:40:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:42 INFO - 'NO_EM_RESTART': '1', 01:40:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:42 INFO - 'PWD': '/builds/slave/test', 01:40:42 INFO - 'SHELL': '/bin/bash', 01:40:42 INFO - 'SHLVL': '1', 01:40:42 INFO - 'TERM': 'linux', 01:40:42 INFO - 'TMOUT': '86400', 01:40:42 INFO - 'USER': 'cltbld', 01:40:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', 01:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:42 INFO - '_': '/tools/buildbot/bin/python'} 01:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:42 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)) 01:40:42 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)) 01:40:42 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)) 01:40:42 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)) 01:40:42 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)) 01:40:42 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)) 01:40:42 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)) 01:40:42 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)) 01:40:42 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)) 01:40:42 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)) 01:40:42 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)) 01:40:42 INFO - Cleaning up... 01:40:42 INFO - Return code: 0 01:40:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d511f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e49a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1feeb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec290>, '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 0x1fecb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', '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 01:40:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:40:42 INFO - Using env: {'DISPLAY': ':0', 01:40:42 INFO - 'HOME': '/home/cltbld', 01:40:42 INFO - 'LANG': 'en_US.UTF-8', 01:40:42 INFO - 'LANGUAGE': 'en_US:en', 01:40:42 INFO - 'LOGNAME': 'cltbld', 01:40:42 INFO - 'MAIL': '/var/mail/cltbld', 01:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:42 INFO - 'MOZ_NO_REMOTE': '1', 01:40:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:42 INFO - 'NO_EM_RESTART': '1', 01:40:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:42 INFO - 'PWD': '/builds/slave/test', 01:40:42 INFO - 'SHELL': '/bin/bash', 01:40:42 INFO - 'SHLVL': '1', 01:40:42 INFO - 'TERM': 'linux', 01:40:42 INFO - 'TMOUT': '86400', 01:40:42 INFO - 'USER': 'cltbld', 01:40:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', 01:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:42 INFO - '_': '/tools/buildbot/bin/python'} 01:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:40:42 INFO - Cleaning up... 01:40:42 INFO - Return code: 0 01:40:42 INFO - Running post-action listener: _resource_record_post_action 01:40:42 INFO - Running post-action listener: _start_resource_monitoring 01:40:42 INFO - Starting resource monitoring. 01:40:42 INFO - [mozharness: 2017-04-03 08:40:42.946591Z] Finished create-virtualenv step (success) 01:40:42 INFO - [mozharness: 2017-04-03 08:40:42.947099Z] Running install step. 01:40:42 INFO - Running pre-action listener: _resource_record_pre_action 01:40:42 INFO - Running main action method: install 01:40:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:40:43 INFO - Reading from file tmpfile_stdout 01:40:43 INFO - Detecting whether we're running mozinstall >=1.0... 01:40:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:40:43 INFO - Reading from file tmpfile_stdout 01:40:43 INFO - Output received: 01:40:43 INFO - Usage: mozinstall [options] installer 01:40:43 INFO - Options: 01:40:43 INFO - -h, --help show this help message and exit 01:40:43 INFO - -d DEST, --destination=DEST 01:40:43 INFO - Directory to install application into. [default: 01:40:43 INFO - "/builds/slave/test"] 01:40:43 INFO - --app=APP Application being installed. [default: firefox] 01:40:43 INFO - mkdir: /builds/slave/test/build/application 01:40:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:40:59 INFO - Reading from file tmpfile_stdout 01:40:59 INFO - Output received: 01:40:59 INFO - /builds/slave/test/build/application/firefox/firefox 01:40:59 INFO - Running post-action listener: _resource_record_post_action 01:40:59 INFO - [mozharness: 2017-04-03 08:40:59.854491Z] Finished install step (success) 01:40:59 INFO - [mozharness: 2017-04-03 08:40:59.854764Z] Running run-tests step. 01:40:59 INFO - Running pre-action listener: _resource_record_pre_action 01:40:59 INFO - Running main action method: run_tests 01:40:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:40:59 INFO - Python 2.7.3 01:40:59 INFO - Return code: 0 01:40:59 INFO - grabbing minidump binary from tooltool 01:40: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')]} 01:40:59 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 0x1fec290>, '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 0x1fecb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fed040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:40:59 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 01:40:59 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 01:40:59 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 01:40:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:40:59 INFO - Return code: 0 01:40:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:40:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:40:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:40:59 INFO - ENV: RUST_BACKTRACE is now 1 01:40:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:40:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:40:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:40:59 INFO - Using env: {'DISPLAY': ':0', 01:40:59 INFO - 'HOME': '/home/cltbld', 01:40:59 INFO - 'LANG': 'en_US.UTF-8', 01:40:59 INFO - 'LANGUAGE': 'en_US:en', 01:40:59 INFO - 'LOGNAME': 'cltbld', 01:40:59 INFO - 'MAIL': '/var/mail/cltbld', 01:40:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:40:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:59 INFO - 'MOZ_NO_REMOTE': '1', 01:40:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:59 INFO - 'NO_EM_RESTART': '1', 01:40:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:59 INFO - 'PWD': '/builds/slave/test', 01:40:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:40:59 INFO - 'RUST_BACKTRACE': '1', 01:40:59 INFO - 'SHELL': '/bin/bash', 01:40:59 INFO - 'SHLVL': '1', 01:40:59 INFO - 'TERM': 'linux', 01:40:59 INFO - 'TMOUT': '86400', 01:40:59 INFO - 'USER': 'cltbld', 01:40:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554', 01:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:59 INFO - '_': '/tools/buildbot/bin/python'} 01:40:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:41:00 INFO - mozversion application_buildid: 20170403075048 01:41:00 INFO - mozversion application_changeset: 6f295b1cb01fea18d05429610363c735e6c1f671 01:41:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:41:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:41:00 INFO - mozversion application_name: Firefox 01:41:00 INFO - mozversion application_remotingname: firefox-dev 01:41:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:41:00 INFO - mozversion application_vendor: Mozilla 01:41:00 INFO - mozversion application_version: 54.0a2 01:41:00 INFO - mozversion platform_buildid: 20170403075048 01:41:00 INFO - mozversion platform_changeset: 6f295b1cb01fea18d05429610363c735e6c1f671 01:41:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:41:00 INFO - mozversion platform_version: 54.0a2 01:41:00 INFO - using testdate: 1491208860 01:41:00 INFO - actual date: 1491208860 01:41:00 INFO - starting webserver on 'localhost:58179' 01:41:00 INFO - SUITE-START | Running 2 tests 01:41:00 INFO - TEST-START | dromaeo_css 01:41:00 INFO - operating with platform_type : linux_ 01:41:00 INFO - Initialising browser for dromaeo_css test... 01:41:00 INFO - TEST-INFO | started process 8596 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWAnH6Q/profile http://localhost:58179/getInfo.html) 01:41:04 INFO - PROCESS | 8596 | __metrics Screen width/height:1600/1200 01:41:04 INFO - PROCESS | 8596 | colorDepth:24 01:41:04 INFO - PROCESS | 8596 | Browser inner width/height: 1024/697 01:41:04 INFO - PROCESS | 8596 | __metrics 01:41:05 INFO - PROCESS | 8596 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:41:05 INFO - PROCESS | 8596 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:41:06 INFO - TEST-INFO | 8596: exit 0 01:41:06 INFO - Browser initialized. 01:41:06 INFO - Running cycle 1/1 for dromaeo_css test... 01:41:06 INFO - TEST-INFO | started process 8685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWAnH6Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:41:17 INFO - PROCESS | 8685 | RSS: Main: 140111872 01:41:17 INFO - PROCESS | 8685 | 01:44:19 INFO - PROCESS | 8685 | Cycle 1(1): loaded http://localhost:58179/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58179/tests/dromaeo/cssquery-ext.html) 01:44:20 INFO - PROCESS | 8685 | RSS: Main: 272125952 01:44:20 INFO - PROCESS | 8685 | 01:46:07 INFO - PROCESS | 8685 | ************************* 01:46:07 INFO - PROCESS | 8685 | A coding exception was thrown and uncaught in a Task. 01:46:07 INFO - PROCESS | 8685 | 01:46:07 ERROR - PROCESS | 8685 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:46:07 INFO - PROCESS | 8685 | Full stack: 01:46:07 INFO - PROCESS | 8685 | ************************* 01:47:22 INFO - PROCESS | 8685 | Cycle 1(1): loaded http://localhost:58179/tests/dromaeo/cssquery-ext.html (next: http://localhost:58179/tests/dromaeo/cssquery-jquery.html) 01:47:23 INFO - PROCESS | 8685 | RSS: Main: 221745152 01:47:23 INFO - PROCESS | 8685 | 01:50:25 INFO - PROCESS | 8685 | Cycle 1(1): loaded http://localhost:58179/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58179/tests/dromaeo/cssquery-mootools.html) 01:50:26 INFO - PROCESS | 8685 | RSS: Main: 169779200 01:50:26 INFO - PROCESS | 8685 | 01:53:28 INFO - PROCESS | 8685 | Cycle 1(1): loaded http://localhost:58179/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58179/tests/dromaeo/cssquery-prototype.html) 01:53:28 INFO - PROCESS | 8685 | RSS: Main: 170987520 01:53:28 INFO - PROCESS | 8685 | 01:56:31 INFO - PROCESS | 8685 | Cycle 1(1): loaded http://localhost:58179/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58179/tests/dromaeo/cssquery-yui.html) 01:56:31 INFO - PROCESS | 8685 | RSS: Main: 178057216 01:56:31 INFO - PROCESS | 8685 | 01:59:34 INFO - PROCESS | 8685 | Cycle 1(1): loaded http://localhost:58179/tests/dromaeo/cssquery-yui.html (next: http://localhost:58179/tests/dromaeo/cssquery-dojo.html) 01:59:34 INFO - PROCESS | 8685 | RSS: Main: 265723904 01:59:34 INFO - PROCESS | 8685 | 01:59:34 INFO - PROCESS | 8685 | __start_tp_report 01:59:34 INFO - PROCESS | 8685 | _x_x_mozilla_page_load 01:59:34 INFO - PROCESS | 8685 | _x_x_mozilla_page_load_details 01:59:34 INFO - PROCESS | 8685 | |i|pagename|runs| 01:59:34 INFO - PROCESS | 8685 | |0;dojo.html;3381.1378098584855;3434.605020422652;3443.1736383268017;3450.2236996675765;3488.2325888304563;5758.5393168546525;5820.621659592123;5832.300123985127;5833.095870140124;5838.153467747179;5791.913121303184;5795.710214489269;5810.360860305363;5828.883422331562;5837.941620583793;5265.815696450615;5298.7350632468415;5309.044372013036;5383.057964856154;5385.246065550826;5172.379314482268;5391.676499410048;5395.757190926398;5401.810936617219;5402.243685883979;5229.633925625208;5251.947480525203;5258.973705131488;5325.7869685212545;5399.514043736063;5397.919031214535;5401.621886467949;5407.053765591006;5417;5423.972880135574;5283.894322113536;5336.226247194174;5396.892062158735;5401.378841433247;5435.619506634537;5554.527865131468;5604.131359639263;5620.91568626471;5729.828105156852;5820.388859169769;6164.599301045418;6183.319834818167;6186.783462578788;6189.597676151036;6204.6587437690905;6228.532860035515;6239.313675495692;6247.4377306042215;6247.468965137923;6249.156363890862;5595.832125036255;5618.213450116987;5733.197352370671;5828.06750919855;5832.387599302097;6381.074744162071;6430.7749228776765;6442.033694945796;6447.967760161263;6454.741810327534;6193.287771906198;6196;6203.875922481616;6208;6212.316645169028;5969.671668058299;6234.937650623436;6304.148939893147;6305.148804911279;6317.1156038154695;6057.939420605826;6064.06007068905;6109.526129009804;6127.325994140641;6134.294556126102;5941.257342832146;5964.910526342108;6178.351273116258;6181.876362472725;6181.876362472815;4671.1358398695675;4678.087772884255;4687.10944920464;4719.551642593948;4735.573798358096;4198.5591512891315;4242.66058715302;4273.572642735764;4283.0363168286885;4295.24833154203;5763.366029736726;5807.709614519342;5926.111083337534;5935.228420305332;6040.969795150996;6316.147320111818;6327.905081423783;6346.841328966812;6351.650659213788;6356.014817703263;6039.909401358983;6050.848728781815;6051.515878729779;6055.878882422327;6057.212562366953;5064.949350506447;5093.745312734422;5186.455422180617;5310;5336.706481143575;6583.506237032242;6591.769288074895;6595.604263744191;6607.57050791697;6608.537402381787;6301.4328710416285;6302;6302.527310451643;6306.337834527309;6317.210348706411;6294.496440284858;6336.398042185985;6474.805755827333;6607.372299631527;6610.4711623071;6030.216071910623;6098.725557349841;6151.6001459904965;6165.660888651168;6169.660668663267;6199.752009919733;6261.467775239155;6267.96866015667;6268.686565671789;6269.62382257066;5850.94149058504;6022.879542409215;6069.119977603311;6083.300420451705;6083.939160608337;5961.91057134152;6024.3674414187635;6051.243594550681;6136.969315153396;6142.959235178615;6050.515958723379;6100.572959892765;6104.32852386246;6114.602550834182;6116.816495505142;5936.1095835625;5986.730597123053;5988.700564971821;6143.877122457437;6173.475254603409;5910.881782364415;5949.494292984971;6022.126791615279;6023.126646636126;6040.154378386941 01:59:34 INFO - PROCESS | 8685 | |1;ext.html;732.362844325437;802.2458888644675;820.712750537312;896.8071864549121;914.556440126539;32220.03339899804;44936;45858.08283834325;49850.50149498513;50180;47078;47331;47394;47458.28812567814;47464.525354746525;7639.274268944441;7794.961025194866;9187.127222913812;9324.766880827965;9330.626774928995;10592.894071059267;10811.513481893295;10814.621488247913;10823.296485728442;11192.888071119307;10948.3978381189;10977.560897564128;10981.231313808037;10983.670489885317;10998;10926.562937482491;10968.122550196005;10996.12031037515;11000.559977600966;11001;10635.680929572125;10662.413567253798;10721.19591030668;10722;10729.356238625707;44109.558904410864;44137.558624413665;44181.77909110466;44355.55644443547;44386.778066109786;4066.369712694537;4155.958440415588;4201.4538110045805;4277.636400905927;4316.330968699856;30639.846800766078;31399.529007064913;31573.8421307892;31804.20489487758;32919.17702057444;4271.423357846682;4383.101464199832;4429.291313389842;4462.085272519158;4484.035932274576;258326;259458;259896;260313;260741;48316;48552.75723621359;48588;48626.756866215444;48653.270200947016;49801;49820;49908.750456247486;49977.25034124491;50015.24977125346;15557.688846223238;15942.521724348288;15948.601284967968;15950.282237299118;15960.281787319598;11895.821562676567;12102.213356131822;13051.804222936664;13790.310484475736;13794.172349659053;13465.596032119052;13547.119437236548;13579.185248885098;13681.452741890213;13683.521076762465;5599.860003499945;5631.099024156116;5707.971460142756;5785.797497087582;5825.88941746079;991.7471044883508;995.6415690351467;1009.6869970309227;1012.6556970629874;1025.5282570017876;28995.275118121794;29202.561961570595;29352.330958630173;29625;29817.850910745743;1070.9303895246785;1080.5515710980012;1094.0372472224392;1094.0591091661165;1111.1610733895857;14632.487862924747;15611.3755449783;15886.682266354608;16209.35162593483;16220.51338459848;368362;370425;370476;371450;372328;53281.46718532765;53363.733181333846;53445.7327713359;53461.465385346426;53500.197497037574;1462.531989763287;1480;1526.6183454136467;1529.5411376586978;1532.5478983699836;27938.301542461602;29341.413171736873;29445.26386840346;29682.851585741933;29778.255543611584;38777.806110969264;39094.609053909095;39247;39364.60635393609;39438;346661;347553;348679;349062;349303;25364.619530707423;25875.482490350463;28016.159515214575;28310.292242694097;30746.692533074383;39058.218835623695;39061.2187756249;39284;39344.60655393409;39368.21263574655;30038.3992320148;30699.846500767355;30830.537541937338;30847.84576077105;31160.688393116685;30084.398312033198;30327;30725.078247652607;30773.692263077977;31167.220819479695;33435.83282083574;33893.83053084719;34364;39371.60628393794;40030.39954400628;31388.843055784575;32014.67985320117;32094.19764505906;32099;32330.191745206557;26270.4745905077;26408.471830563667;26715.465690686466;26719.599206011535;26984.190474285802 01:59:34 INFO - PROCESS | 8685 | |2;jquery.html;437.5652759284649;459.60933206774246;466.6570070997817;467.39005597695035;473.95023522530136;19437.125329360177;20692.793072069293;21089.15643374263;21254;21377.679334809953;21692.56614867702;22248;22364.8881755591;22862.31413057611;23120.190793322236;6188.566800323979;6683.030960510723;6800.625965571916;6829.419499342537;6911.585304881698;6717.731290748364;6835.7607483738075;6838.589684618914;6844.691988860513;6845.349691779273;6578.736850525973;6758.290379510155;6797.2523022467485;6798.93201067988;6826.897596536056;6676.399124078807;6694.129763130811;6777.559458635197;6828.624425656587;6838.692258848364;6536.54244202906;6564.212294524687;6572.737090516373;6586.37429444202;6592.86814263712;25839.35401614956;25934.74065259342;25953.870230648914;26141;26178;2840;2870.138958312498;2873.3822228221034;2877.438899414615;2880.1791489425623;15963.84036159635;16932.238049287687;17205.139743012798;17216.880902741283;17635.911820440942;2069.9172033118657;2105.673620588811;2130.7656157822626;2150.666646669769;2186.3768825884545;71477;73679;85031.57484212663;86320;95032.52483737537;18115.456536303933;19552.90223548873;19703.60592788165;19728.60542789136;19812.801871981384;34344.48483272753;34472.31055378878;34545;34546.82726586351;34587.48118778221;10935.945320273348;11164.944175279072;11212.719682007852;11224.607138750105;11282.887171128348;9223.907760922439;9281.489518076436;9290.581923813445;9434.339596228336;9445.669401570913;9978.850317245247;10057.14514266281;10272.640457583948;10323.896761032294;10375.221858360654;3746.456763769238;3916.9020774480864;3938.2714197873483;3940.9802950985063;4019.196160767858;998.7503124218945;999.0808456220295;1001.0940099210227;1023.7594165371132;1038.2524582300882;22346.44133896633;22459.887700561394;22610.886945565497;22730;22740.772592273865;1018.5111146649501;1028.7942411517727;1048.3081166430272;1048.7011201807447;1049.5801679328329;11826.467808948619;12648.936755316165;12907.935460322638;12929.806052909214;13048;304084;309211;524025;693012;723505;91681;93419;94033.5298323504;95756;95836.52081739546;1199.682084247675;1277.3677029870273;1300.2393599744066;1346.4681450826868;1361.9921258269007;18709.532261693566;19049.14278857427;19388.030598469737;19407.417777466697;19434.125464353856;51342;52205.7389713049;52466.213006804166;52543.737281314876;54469;73494.26505734875;73544.26455735374;73679.63160184165;74447.62776186084;74793.2520674808;11993.160478766402;12094.45574949147;12252.203606765532;12267.263964162179;12450.750984980068;13248.337583120998;13905.652358691113;13942.302884855919;14143.43426262938;14258.786118208027;11083.944580277048;11236;11406.429678515875;11602.76794464123;11720.88279117198;10750.946245268724;10912.61805836792;10915.727106822393;11382.829257560978;11468.369239691898;11052.778944421227;11367;11419.486123124314;11965.700857478632;12320.815187772012;12034.63896083119;12234.694132646755;12264;12290.815637765261;12487.75122487744;10737.89262107369;10938.124950003821;10963.725906852393;11024.5038973248;11091.44542772842 01:59:34 INFO - PROCESS | 8685 | |3;mootools.html;1541.5606552132645;1560.0795530636922;1572.1667516216405;1574.3466461418511;1574.511901310593;10697.518611662474;11465.656030319084;11465.885341146586;11469.770604587904;11474.139439542036;10805.297655652397;11200.887991120086;11211.271267367636;11213.327200367963;11222.102231821455;2256.616375216209;2292.5414917016665;2297.3911913342895;2298.5173113646156;2299.632058870581;2140.8501404901663;2218.5341078373563;2289.896954637037;2301.8964146613357;2310.2838120182714;2203.1187524989973;2214.3356992902145;2220.8667479951173;2232.218723446797;2327.7323107842644;2148.2803260907613;2155.374941267031;2162.902669379882;2165.4694599822988;2172.196287373674;2228.342638921522;2290.6564015397657;2295.3458264394567;2304.3432621702736;2308.4805918668335;11465.140114491363;11512.424378781112;11540;11544.422778861108;11546.94226528862;5444.428335024844;5539.556835453154;5570.637908535973;5585.106382978704;5589.580781441408;3245.1562593725566;3264.281857991238;3419.760616756828;3459.567554055743;3482.564679415073;1330.2750001249342;1347.0772520823268;1429.371076726237;1452.6586252230718;1454.7236025155187;14413.927930360282;14740.852591474055;15618.843811561967;16870.409535666317;17106.572335691584;4477.171723231213;4556.70381425213;4676.111538807616;4679.836205732783;4682.836100736526;13035;13039.152455090389;13047.282399467931;13088.476460941647;13097.934510327388;4876.268559716;5021.246812978009;5513.283273174462;5621.550275977912;5634.6337488063145;5193.584513238932;5216.765245563959;5296.841094767163;5297.152455607084;5298.178782288752;3841.2125514269505;3874.089588946595;3925.1953349563273;3951.2887680217264;3968.543617483969;953.990460095404;958.8561715742555;964.7395203295071;966.8453047512364;970.4129001953858;1056.10758908722;1062.0919114157439;1062.2139616683753;1068.273573969708;1079.266099052636;7079.646017699094;7179.928200717926;7202.099737532809;7296.197418283985;7356.816079598053;1031.376017509411;1057.9894201058046;1065.8561094252177;1066.8079745645703;1070.9089727373105;4627.722336659811;4678.3216433616935;4679.508651591534;4686.95313046872;4743.146233677902;14334.856651433352;14720.116792992454;14724.779128313085;14730.263486825615;14827.629309267139;14447.205403702897;14514.637134071521;14516.782248266285;14585;14603.561893143222;8797.868031979526;10436.217283703601;10672.146228301717;10804.13566914645;10817.188710846718;6508.414242718178;7205.603691796792;7315.963420182865;7413.629318534159;7419.22098179705;12300.077494187793;12316.261024338568;12319.63041108768;12406.131570789958;12570.1200915935;12556.30434023546;12575.245485270547;12591.87408125907;12848;12954.28751418681;9152.222061124612;9216.216621586971;9341.2994025447;9356.391834530734;9358.953205234202;10724.946375268073;10780.029797318279;10852.131829453783;10863.837042444527;10865.239433239598;9066.365354425126;9130.269578433843;9144.862827057732;9216.539173041456;9301.72094837156;8778.385513014284;8809.163129502687;8922.152395522415;9015.549222538715;9078.727638170865;8382.077971423018;8416.957915210385;8548.230659240699;8569.571521423779;8570.185832345916;6292.559520833498;6399.616023038632;6448.935510644834;6496.967515162394;6543.214814222324;6445.871082578416;6530.349220512133;6534.085228068169;6584.308647591934;6645.501587380869 01:59:34 INFO - PROCESS | 8685 | |4;prototype.html;416.5875782974855;417.753535313538;425.3322284014099;432.40544251653955;432.532864506333;5282.999999999995;5294.523492885649;5318.414974352818;5326.520613144816;5329.413764485904;4919.680220785646;5105.3873535175735;5158.406783219931;5210.921836172451;5234.92147617786;4379.715318504287;4430.623397011258;4466.017476155241;4473.865784026476;4495.6628252881;4428.892776805798;4446.2219111655495;4468.061707041526;4475.328700694889;4478;4432.734035957837;4470.307102399117;4471.597556219939;4507.256302710049;4546.613537849286;4372.23485889968;4413.58070983256;4443.111377724435;4447.888027993002;4498.617617502517;4144.761828612545;4169.353750168729;4184.995601055755;4191;4207.148854504008;5160.432352441228;5173.120569503156;5177.938522602857;5181.740912954375;5228.503292187236;4913.361263035782;5107.1828507439;5120.231965205212;5150.871228219287;5253.159494480865;5542.140968149944;5565.163496046295;5569.470900264469;5595.916061259084;5598.300212473441;4695.980728286835;4716.764161791931;4718.551737584924;4720.59874910633;4738.881527961794;5631.63394379364;5731.389224788357;5740.851829634048;5837.227317024422;5862.046570647796;4700.2949557566635;4726.881827954328;4726.983698504838;4770.785314660849;4797;4844.370231869834;4858.684185527929;4861.222204447342;4883.658143929891;4911.8280860170435;4863.221884498464;5090.847274581768;5103.540681338697;5104.259882317117;5129.333186685782;5425.697832520167;5442.6462279951675;5475.6440831345835;5477.233187353773;5501.697406642593;1671.0558534428253;1681.7225157849064;1682.7307630779017;1684.7111959351107;1688.2318545061967;1231.6243545718462;1276.4766445757195;1301.8828305452555;1307.5162189989765;1321.7554752370843;5137.794488220504;5328.374845672107;5392.379876314196;5401.243825864382;5401.810936617199;5620.690862002547;5663.773449062074;5664.348599911063;5673.77304907799;5676.829695109153;5397.325334333208;5404.216828333411;5409.864753381197;5414.3232095988005;5438.673679579238;2916.314666053476;2965.792394532405;2986.343004538998;2991.7157870002316;3020.199647093522;5874.970625146847;5878;5899.292084949748;5903.26209223847;5906.839840685298;5433.8369848904595;5741.511971482387;5781.4507621775865;5795.464201986477;5836.9124463133085;5144.067881307618;5737.848306884918;5934.1692163097205;5977.790777322686;5982.222311099529;5648.519875810603;5660.462256085665;5682.886342273048;5706.572007099568;5734.512566431733;5340;5577.776888924398;5691.292612216236;5701.543876489954;5710.4004079572705;5934.703264836655;5947.9702601486715;5948.970255148696;5967.91048134287;5993.460588547052;4751.311059896365;4761.714297142183;4797.472278049342;4801.759912004456;4814.398200224972;5470.288862447856;5628.521575666115;5631.239782629293;5670.716464176857;5789.6394347327505;5549.112142057252;5551.278333816578;5551.833444996657;5581.5255703265675;5584.972075139598;5354.330708661418;5595.608307418442;5600.663960162403;5625.296837895263;5639.182318563703;5492.1212605982855;5497.972510137423;5528.695921724344;5539.833804985696;5566.383799614175;5593.608447408642;5595.412481689526;5600.4959553640365;5607;5622.24099746529;5200.297959775382;5411.350637923474;5439.062906030857;5463.699496527729;5469.726513674221 01:59:34 INFO - PROCESS | 8685 | |5;yui.html;806.238104990784;842.2882664148796;904.6788390121508;916.5234078279296;931.4364809290375;14494.855051449482;16985.235664395103;17431.389901353454;17549.385771498;17663.558411039714;14543.854561454382;15559;15911.204439778023;16269.349226030945;16445.83554164458;862.1163307609687;878.4641368765048;880.3705350674267;880.8238352329528;881.4755220643707;861.7113267055544;878.5695009445358;891.4294851295176;892.7366426904047;896.4621227263623;918.9862152067724;924.2190349154987;926.379325851681;928.22029495224;931.0642803981989;924.0343840686498;928.0348437624862;929.7024952015357;930.1953809954374;930.7393929699695;677.018323431022;682.9282925292872;683.0369179456992;683.4942142814332;683.6684208159039;16472.67054658912;16515.256813443422;16605.750913736305;17009.319627214896;17036.318547258095;15864.841351586452;16209.432669856616;16317.59206019847;16443.671126577403;16549.91725041379;13453.125546839425;13673.726525469534;13729.588112356645;13858.099223550538;13884.722305553832;3897.4738410314812;3943.7633741975574;3983.063979964706;4038.172174704179;4118.094019315746;91144;92561;94386.05613943841;95644;96595.51702241444;12318.75362492763;12319.384030798425;12325.50697972089;12346.629601111981;12651;24482.510349792905;24594.139205127736;24947.5010499789;24963.87518062398;24983.500329993298;8180.9181908181345;8236.299914507214;8237.382196335298;8359.8328033439;8492.787680307918;4612.215923293048;4663.976680116578;4739.312799644033;4841;4880.6095512358925;3655.7989310588173;3703.037210325335;3730.0674831292176;3748.775073495599;3757.8496860125833;574.5231457889942;576.4840467781396;579.7999690106907;580.1153241306956;580.135597959038;608.850831546274;624.2384291164772;638.5625846295303;641.5701480008405;663.280340830195;10491.475426228659;10999.61501347449;11077.778444431066;11130.721731956766;11170.832437513443;732.143392231091;748.6144635512716;756.71623141322;761.0524896503778;763.5266134996338;4643.442786865598;4994.2508623706735;4998.450170481244;4999.3000979862845;5040.445550989388;82865;83072;84071.73892391619;85758.5712071448;87603.56198218968;59540.404595953485;72499;73873.63063184757;75671;76698;66286.33713662802;67222.66388668025;67505.66247168831;68404.31595684079;70174.2982570178;9337.953310233406;9652.350519661746;9672.08115229052;9682.094599642322;9683.069598933926;44787.77606111948;45263;45363.31955020611;45929.77035114803;46244.306335404326;45042;45238.09523809439;54227.186592201935;55063.72468137794;55156;13799.172049677052;13888;14020.649483762987;14096.577102686935;14318.212498312276;16018.599535011717;16150;16320.347186112898;16564.088975106002;16633.916830415772;13833.792493112813;13942.512012079529;14213.786793198316;14334;14699.55901322962;13721.862781372058;13894.166350019032;14278.357473913491;14704.928421378521;15416.229188540305;14736.2631868404;14761.483348082766;15004.249787510798;15212.391504339703;15876.920615397312;10239.232057595562;10344.741381465523;10574;11138.721531961766;11209.383483908463;11848.585299514476;12119.333436660716;12183.817242741188;12203.69490762738;12284.938575307066 01:59:34 INFO - PROCESS | 8685 | __end_tp_report 01:59:34 INFO - PROCESS | 8685 | __start_cc_report 01:59:34 INFO - PROCESS | 8685 | _x_x_mozilla_cycle_collect,1285 01:59:34 INFO - PROCESS | 8685 | __end_cc_report 01:59:34 INFO - PROCESS | 8685 | __startTimestamp1491209974597__endTimestamp 01:59:34 INFO - PROCESS | 8685 | 01:59:34 INFO - PROCESS | 8685 | ------- Summary: start ------- 01:59:34 INFO - PROCESS | 8685 | Number of tests: 6 01:59:34 INFO - PROCESS | 8685 | 01:59:34 INFO - PROCESS | 8685 | [#0] dojo.html Cycles:165 Average:5790.64 Median:6024.37 stddev:659.64 (10.9%) stddev-sans-first:634.00 01:59:34 INFO - PROCESS | 8685 | Values: 3381.1 3434.6 3443.2 3450.2 3488.2 5758.5 5820.6 5832.3 5833.1 5838.2 5791.9 5795.7 5810.4 5828.9 5837.9 5265.8 5298.7 5309.0 5383.1 5385.2 5172.4 5391.7 5395.8 5401.8 5402.2 5229.6 5251.9 5259.0 5325.8 5399.5 5397.9 5401.6 5407.1 5417.0 5424.0 5283.9 5336.2 5396.9 5401.4 5435.6 5554.5 5604.1 5620.9 5729.8 5820.4 6164.6 6183.3 6186.8 6189.6 6204.7 6228.5 6239.3 6247.4 6247.5 6249.2 5595.8 5618.2 5733.2 5828.1 5832.4 6381.1 6430.8 6442.0 6448.0 6454.7 6193.3 6196.0 6203.9 6208.0 6212.3 5969.7 6234.9 6304.1 6305.1 6317.1 6057.9 6064.1 6109.5 6127.3 6134.3 5941.3 5964.9 6178.4 6181.9 6181.9 4671.1 4678.1 4687.1 4719.6 4735.6 4198.6 4242.7 4273.6 4283.0 4295.2 5763.4 5807.7 5926.1 5935.2 6041.0 6316.1 6327.9 6346.8 6351.7 6356.0 6039.9 6050.8 6051.5 6055.9 6057.2 5064.9 5093.7 5186.5 5310.0 5336.7 6583.5 6591.8 6595.6 6607.6 6608.5 6301.4 6302.0 6302.5 6306.3 6317.2 6294.5 6336.4 6474.8 6607.4 6610.5 6030.2 6098.7 6151.6 6165.7 6169.7 6199.8 6261.5 6268.0 6268.7 6269.6 5850.9 6022.9 6069.1 6083.3 6083.9 5961.9 6024.4 6051.2 6137.0 6143.0 6050.5 6100.6 6104.3 6114.6 6116.8 5936.1 5986.7 5988.7 6143.9 6173.5 5910.9 5949.5 6022.1 6023.1 6040.2 01:59:34 INFO - PROCESS | 8685 | 01:59:34 INFO - PROCESS | 8685 | [#1] ext.html Cycles:180 Average:48561.03 Median:31486.69 stddev:86539.95 (274.8%) stddev-sans-first:86708.21 01:59:34 INFO - PROCESS | 8685 | Values: 732.4 802.2 820.7 896.8 914.6 32220.0 44936.0 45858.1 49850.5 50180.0 47078.0 47331.0 47394.0 47458.3 47464.5 7639.3 7795.0 9187.1 9324.8 9330.6 10592.9 10811.5 10814.6 10823.3 11192.9 10948.4 10977.6 10981.2 10983.7 10998.0 10926.6 10968.1 10996.1 11000.6 11001.0 10635.7 10662.4 10721.2 10722.0 10729.4 44109.6 44137.6 44181.8 44355.6 44386.8 4066.4 4156.0 4201.5 4277.6 4316.3 30639.8 31399.5 31573.8 31804.2 32919.2 4271.4 4383.1 4429.3 4462.1 4484.0 258326.0 259458.0 259896.0 260313.0 260741.0 48316.0 48552.8 48588.0 48626.8 48653.3 49801.0 49820.0 49908.8 49977.3 50015.2 15557.7 15942.5 15948.6 15950.3 15960.3 11895.8 12102.2 13051.8 13790.3 13794.2 13465.6 13547.1 13579.2 13681.5 13683.5 5599.9 5631.1 5708.0 5785.8 5825.9 991.7 995.6 1009.7 1012.7 1025.5 28995.3 29202.6 29352.3 29625.0 29817.9 1070.9 1080.6 1094.0 1094.1 1111.2 14632.5 15611.4 15886.7 16209.4 16220.5 368362.0 370425.0 370476.0 371450.0 372328.0 53281.5 53363.7 53445.7 53461.5 53500.2 1462.5 1480.0 1526.6 1529.5 1532.5 27938.3 29341.4 29445.3 29682.9 29778.3 38777.8 39094.6 39247.0 39364.6 39438.0 346661.0 347553.0 348679.0 349062.0 349303.0 25364.6 25875.5 28016.2 28310.3 30746.7 39058.2 39061.2 39284.0 39344.6 39368.2 30038.4 30699.8 30830.5 30847.8 31160.7 30084.4 30327.0 30725.1 30773.7 31167.2 33435.8 33893.8 34364.0 39371.6 40030.4 31388.8 32014.7 32094.2 32099.0 32330.2 26270.5 26408.5 26715.5 26719.6 26984.2 01:59:34 INFO - PROCESS | 8685 | 01:59:34 INFO - PROCESS | 8685 | [#2] jquery.html Cycles:180 Average:32467.37 Median:22412.39 stddev:89282.40 (398.4%) stddev-sans-first:89500.47 01:59:34 INFO - PROCESS | 8685 | Values: 437.6 459.6 466.7 467.4 474.0 19437.1 20692.8 21089.2 21254.0 21377.7 21692.6 22248.0 22364.9 22862.3 23120.2 6188.6 6683.0 6800.6 6829.4 6911.6 6717.7 6835.8 6838.6 6844.7 6845.3 6578.7 6758.3 6797.3 6798.9 6826.9 6676.4 6694.1 6777.6 6828.6 6838.7 6536.5 6564.2 6572.7 6586.4 6592.9 25839.4 25934.7 25953.9 26141.0 26178.0 2840.0 2870.1 2873.4 2877.4 2880.2 15963.8 16932.2 17205.1 17216.9 17635.9 2069.9 2105.7 2130.8 2150.7 2186.4 71477.0 73679.0 85031.6 86320.0 95032.5 18115.5 19552.9 19703.6 19728.6 19812.8 34344.5 34472.3 34545.0 34546.8 34587.5 10935.9 11164.9 11212.7 11224.6 11282.9 9223.9 9281.5 9290.6 9434.3 9445.7 9978.9 10057.1 10272.6 10323.9 10375.2 3746.5 3916.9 3938.3 3941.0 4019.2 998.8 999.1 1001.1 1023.8 1038.3 22346.4 22459.9 22610.9 22730.0 22740.8 1018.5 1028.8 1048.3 1048.7 1049.6 11826.5 12648.9 12907.9 12929.8 13048.0 304084.0 309211.0 524025.0 693012.0 723505.0 91681.0 93419.0 94033.5 95756.0 95836.5 1199.7 1277.4 1300.2 1346.5 1362.0 18709.5 19049.1 19388.0 19407.4 19434.1 51342.0 52205.7 52466.2 52543.7 54469.0 73494.3 73544.3 73679.6 74447.6 74793.3 11993.2 12094.5 12252.2 12267.3 12450.8 13248.3 13905.7 13942.3 14143.4 14258.8 11083.9 11236.0 11406.4 11602.8 11720.9 10750.9 10912.6 10915.7 11382.8 11468.4 11052.8 11367.0 11419.5 11965.7 12320.8 12034.6 12234.7 12264.0 12290.8 12487.8 10737.9 10938.1 10963.7 11024.5 11091.4 01:59:34 INFO - PROCESS | 8685 | 01:59:34 INFO - PROCESS | 8685 | [#3] mootools.html Cycles:180 Average:6984.73 Median:2296.37 stddev:4463.59 (194.4%) stddev-sans-first:4457.37 01:59:34 INFO - PROCESS | 8685 | Values: 1541.6 1560.1 1572.2 1574.3 1574.5 10697.5 11465.7 11465.9 11469.8 11474.1 10805.3 11200.9 11211.3 11213.3 11222.1 2256.6 2292.5 2297.4 2298.5 2299.6 2140.9 2218.5 2289.9 2301.9 2310.3 2203.1 2214.3 2220.9 2232.2 2327.7 2148.3 2155.4 2162.9 2165.5 2172.2 2228.3 2290.7 2295.3 2304.3 2308.5 11465.1 11512.4 11540.0 11544.4 11546.9 5444.4 5539.6 5570.6 5585.1 5589.6 3245.2 3264.3 3419.8 3459.6 3482.6 1330.3 1347.1 1429.4 1452.7 1454.7 14413.9 14740.9 15618.8 16870.4 17106.6 4477.2 4556.7 4676.1 4679.8 4682.8 13035.0 13039.2 13047.3 13088.5 13097.9 4876.3 5021.2 5513.3 5621.6 5634.6 5193.6 5216.8 5296.8 5297.2 5298.2 3841.2 3874.1 3925.2 3951.3 3968.5 954.0 958.9 964.7 966.8 970.4 1056.1 1062.1 1062.2 1068.3 1079.3 7079.6 7179.9 7202.1 7296.2 7356.8 1031.4 1058.0 1065.9 1066.8 1070.9 4627.7 4678.3 4679.5 4687.0 4743.1 14334.9 14720.1 14724.8 14730.3 14827.6 14447.2 14514.6 14516.8 14585.0 14603.6 8797.9 10436.2 10672.1 10804.1 10817.2 6508.4 7205.6 7316.0 7413.6 7419.2 12300.1 12316.3 12319.6 12406.1 12570.1 12556.3 12575.2 12591.9 12848.0 12954.3 9152.2 9216.2 9341.3 9356.4 9359.0 10724.9 10780.0 10852.1 10863.8 10865.2 9066.4 9130.3 9144.9 9216.5 9301.7 8778.4 8809.2 8922.2 9015.5 9078.7 8382.1 8417.0 8548.2 8569.6 8570.2 6292.6 6399.6 6448.9 6497.0 6543.2 6445.9 6530.3 6534.1 6584.3 6645.5 01:59:34 INFO - PROCESS | 8685 | 01:59:34 INFO - PROCESS | 8685 | [#4] prototype.html Cycles:180 Average:4844.35 Median:5322.47 stddev:1280.79 (24.1%) stddev-sans-first:1240.51 01:59:34 INFO - PROCESS | 8685 | Values: 416.6 417.8 425.3 432.4 432.5 5283.0 5294.5 5318.4 5326.5 5329.4 4919.7 5105.4 5158.4 5210.9 5234.9 4379.7 4430.6 4466.0 4473.9 4495.7 4428.9 4446.2 4468.1 4475.3 4478.0 4432.7 4470.3 4471.6 4507.3 4546.6 4372.2 4413.6 4443.1 4447.9 4498.6 4144.8 4169.4 4185.0 4191.0 4207.1 5160.4 5173.1 5177.9 5181.7 5228.5 4913.4 5107.2 5120.2 5150.9 5253.2 5542.1 5565.2 5569.5 5595.9 5598.3 4696.0 4716.8 4718.6 4720.6 4738.9 5631.6 5731.4 5740.9 5837.2 5862.0 4700.3 4726.9 4727.0 4770.8 4797.0 4844.4 4858.7 4861.2 4883.7 4911.8 4863.2 5090.8 5103.5 5104.3 5129.3 5425.7 5442.6 5475.6 5477.2 5501.7 1671.1 1681.7 1682.7 1684.7 1688.2 1231.6 1276.5 1301.9 1307.5 1321.8 5137.8 5328.4 5392.4 5401.2 5401.8 5620.7 5663.8 5664.3 5673.8 5676.8 5397.3 5404.2 5409.9 5414.3 5438.7 2916.3 2965.8 2986.3 2991.7 3020.2 5875.0 5878.0 5899.3 5903.3 5906.8 5433.8 5741.5 5781.5 5795.5 5836.9 5144.1 5737.8 5934.2 5977.8 5982.2 5648.5 5660.5 5682.9 5706.6 5734.5 5340.0 5577.8 5691.3 5701.5 5710.4 5934.7 5948.0 5949.0 5967.9 5993.5 4751.3 4761.7 4797.5 4801.8 4814.4 5470.3 5628.5 5631.2 5670.7 5789.6 5549.1 5551.3 5551.8 5581.5 5585.0 5354.3 5595.6 5600.7 5625.3 5639.2 5492.1 5498.0 5528.7 5539.8 5566.4 5593.6 5595.4 5600.5 5607.0 5622.2 5200.3 5411.4 5439.1 5463.7 5469.7 01:59:34 INFO - PROCESS | 8685 | 01:59:34 INFO - PROCESS | 8685 | [#5] yui.html Cycles:180 Average:18933.33 Median:25270.99 stddev:24427.02 (96.7%) stddev-sans-first:24457.62 01:59:34 INFO - PROCESS | 8685 | Values: 806.2 842.3 904.7 916.5 931.4 14494.9 16985.2 17431.4 17549.4 17663.6 14543.9 15559.0 15911.2 16269.3 16445.8 862.1 878.5 880.4 880.8 881.5 861.7 878.6 891.4 892.7 896.5 919.0 924.2 926.4 928.2 931.1 924.0 928.0 929.7 930.2 930.7 677.0 682.9 683.0 683.5 683.7 16472.7 16515.3 16605.8 17009.3 17036.3 15864.8 16209.4 16317.6 16443.7 16549.9 13453.1 13673.7 13729.6 13858.1 13884.7 3897.5 3943.8 3983.1 4038.2 4118.1 91144.0 92561.0 94386.1 95644.0 96595.5 12318.8 12319.4 12325.5 12346.6 12651.0 24482.5 24594.1 24947.5 24963.9 24983.5 8180.9 8236.3 8237.4 8359.8 8492.8 4612.2 4664.0 4739.3 4841.0 4880.6 3655.8 3703.0 3730.1 3748.8 3757.8 574.5 576.5 579.8 580.1 580.1 608.9 624.2 638.6 641.6 663.3 10491.5 10999.6 11077.8 11130.7 11170.8 732.1 748.6 756.7 761.1 763.5 4643.4 4994.3 4998.5 4999.3 5040.4 82865.0 83072.0 84071.7 85758.6 87603.6 59540.4 72499.0 73873.6 75671.0 76698.0 66286.3 67222.7 67505.7 68404.3 70174.3 9338.0 9652.4 9672.1 9682.1 9683.1 44787.8 45263.0 45363.3 45929.8 46244.3 45042.0 45238.1 54227.2 55063.7 55156.0 13799.2 13888.0 14020.6 14096.6 14318.2 16018.6 16150.0 16320.3 16564.1 16633.9 13833.8 13942.5 14213.8 14334.0 14699.6 13721.9 13894.2 14278.4 14704.9 15416.2 14736.3 14761.5 15004.2 15212.4 15876.9 10239.2 10344.7 10574.0 11138.7 11209.4 11848.6 12119.3 12183.8 12203.7 12284.9 01:59:34 INFO - PROCESS | 8685 | -------- Summary: end -------- 01:59:34 INFO - PROCESS | 8685 | 01:59:35 INFO - TEST-INFO | 8685: exit 0 01:59:35 INFO - TEST-OK | dromaeo_css | took 1115271ms 01:59:35 INFO - TEST-START | kraken 01:59:35 INFO - operating with platform_type : linux_ 01:59:35 INFO - Initialising browser for kraken test... 01:59:35 INFO - TEST-INFO | started process 9008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ749KX/profile http://localhost:58179/getInfo.html) 01:59:39 INFO - PROCESS | 9008 | __metrics Screen width/height:1600/1200 01:59:39 INFO - PROCESS | 9008 | colorDepth:24 01:59:39 INFO - PROCESS | 9008 | Browser inner width/height: 1024/697 01:59:39 INFO - PROCESS | 9008 | __metrics 01:59:40 INFO - PROCESS | 9008 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:59:40 INFO - PROCESS | 9008 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:59:41 INFO - TEST-INFO | 9008: exit 0 01:59:41 INFO - Browser initialized. 01:59:41 INFO - Running cycle 1/1 for kraken test... 01:59:41 INFO - TEST-INFO | started process 9105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ749KX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:59:53 INFO - PROCESS | 9105 | RSS: Main: 140005376 01:59:53 INFO - PROCESS | 9105 | 01:59:55 INFO - PROCESS | 9105 | Cycle 1(1): loaded http://localhost:58179/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58179/tests/kraken/driver.html?testName=audio-beat-detection) 01:59:56 INFO - PROCESS | 9105 | RSS: Main: 184504320 01:59:56 INFO - PROCESS | 9105 | 01:59:59 INFO - PROCESS | 9105 | Cycle 1(1): loaded http://localhost:58179/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58179/tests/kraken/driver.html?testName=audio-dft) 01:59:59 INFO - PROCESS | 9105 | RSS: Main: 173858816 01:59:59 INFO - PROCESS | 9105 | 02:00:02 INFO - PROCESS | 9105 | Cycle 1(1): loaded http://localhost:58179/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58179/tests/kraken/driver.html?testName=audio-fft) 02:00:03 INFO - PROCESS | 9105 | RSS: Main: 265850880 02:00:03 INFO - PROCESS | 9105 | 02:00:05 INFO - PROCESS | 9105 | Cycle 1(1): loaded http://localhost:58179/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58179/tests/kraken/driver.html?testName=audio-oscillator) 02:00:05 INFO - PROCESS | 9105 | RSS: Main: 172023808 02:00:05 INFO - PROCESS | 9105 | 02:00:07 INFO - PROCESS | 9105 | Cycle 1(1): loaded http://localhost:58179/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58179/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:00:08 INFO - PROCESS | 9105 | RSS: Main: 174243840 02:00:08 INFO - PROCESS | 9105 | 02:00:11 INFO - PROCESS | 9105 | Cycle 1(1): loaded http://localhost:58179/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58179/tests/kraken/driver.html?testName=imaging-darkroom) 02:00:11 INFO - PROCESS | 9105 | RSS: Main: 214020096 02:00:11 INFO - PROCESS | 9105 | 02:00:15 INFO - PROCESS | 9105 | Cycle 1(1): loaded http://localhost:58179/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58179/tests/kraken/driver.html?testName=imaging-desaturate) 02:00:15 INFO - PROCESS | 9105 | RSS: Main: 212160512 02:00:15 INFO - PROCESS | 9105 | 02:00:18 INFO - PROCESS | 9105 | Cycle 1(1): loaded http://localhost:58179/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58179/tests/kraken/driver.html?testName=json-parse-financial) 02:00:19 INFO - PROCESS | 9105 | RSS: Main: 210513920 02:00:19 INFO - PROCESS | 9105 | 02:00:20 INFO - PROCESS | 9105 | Cycle 1(1): loaded http://localhost:58179/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58179/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:00:21 INFO - PROCESS | 9105 | RSS: Main: 172994560 02:00:21 INFO - PROCESS | 9105 | 02:00:23 INFO - PROCESS | 9105 | Cycle 1(1): loaded http://localhost:58179/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58179/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:00:23 INFO - PROCESS | 9105 | RSS: Main: 179105792 02:00:23 INFO - PROCESS | 9105 | 02:00:25 INFO - PROCESS | 9105 | Cycle 1(1): loaded http://localhost:58179/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58179/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:00:26 INFO - PROCESS | 9105 | RSS: Main: 184721408 02:00:26 INFO - PROCESS | 9105 | 02:00:28 INFO - PROCESS | 9105 | Cycle 1(1): loaded http://localhost:58179/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58179/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:00:29 INFO - PROCESS | 9105 | RSS: Main: 181538816 02:00:29 INFO - PROCESS | 9105 | 02:00:32 INFO - PROCESS | 9105 | Cycle 1(1): loaded http://localhost:58179/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58179/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:00:32 INFO - PROCESS | 9105 | RSS: Main: 184594432 02:00:32 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | Cycle 1(1): loaded http://localhost:58179/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58179/tests/kraken/driver.html?testName=ai-astar) 02:00:34 INFO - PROCESS | 9105 | RSS: Main: 237932544 02:00:34 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | __start_tp_report 02:00:34 INFO - PROCESS | 9105 | _x_x_mozilla_page_load 02:00:34 INFO - PROCESS | 9105 | _x_x_mozilla_page_load_details 02:00:34 INFO - PROCESS | 9105 | |i|pagename|runs| 02:00:34 INFO - PROCESS | 9105 | |0;ai-astar;104;115;113;113;115;116;113;115;117;115 02:00:34 INFO - PROCESS | 9105 | |1;audio-beat-detection;139;120;114;144;117;114;114;114;131;114 02:00:34 INFO - PROCESS | 9105 | |2;audio-dft;160;160;162;161;160;160;160;161;160;162 02:00:34 INFO - PROCESS | 9105 | |3;audio-fft;75;76;76;106;75;76;76;76;91;76 02:00:34 INFO - PROCESS | 9105 | |4;audio-oscillator;82;81;111;83;86;83;93;83;83;109 02:00:34 INFO - PROCESS | 9105 | |5;imaging-gaussian-blur;113;113;113;113;113;113;113;113;113;114 02:00:34 INFO - PROCESS | 9105 | |6;imaging-darkroom;147;146;146;146;147;146;147;145;146;146 02:00:34 INFO - PROCESS | 9105 | |7;imaging-desaturate;93;94;94;94;94;94;94;94;94;95 02:00:34 INFO - PROCESS | 9105 | |8;json-parse-financial;54;54;54;54;54;54;55;53;53;53 02:00:34 INFO - PROCESS | 9105 | |9;json-stringify-tinderbox;53;53;53;53;53;53;53;54;54;54 02:00:34 INFO - PROCESS | 9105 | |10;stanford-crypto-aes;79;79;74;75;80;79;81;80;79;101 02:00:34 INFO - PROCESS | 9105 | |11;stanford-crypto-ccm;126;120;120;123;129;118;121;124;133;127 02:00:34 INFO - PROCESS | 9105 | |12;stanford-crypto-pbkdf2;165;159;164;160;161;166;163;160;160;165 02:00:34 INFO - PROCESS | 9105 | |13;stanford-crypto-sha256-iterative;61;69;61;60;60;59;59;59;59;57 02:00:34 INFO - PROCESS | 9105 | __end_tp_report 02:00:34 INFO - PROCESS | 9105 | __start_cc_report 02:00:34 INFO - PROCESS | 9105 | _x_x_mozilla_cycle_collect,1658 02:00:34 INFO - PROCESS | 9105 | __end_cc_report 02:00:34 INFO - PROCESS | 9105 | __startTimestamp1491210034750__endTimestamp 02:00:34 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | ------- Summary: start ------- 02:00:34 INFO - PROCESS | 9105 | Number of tests: 14 02:00:34 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:3.63 (3.2%) stddev-sans-first:1.41 02:00:34 INFO - PROCESS | 9105 | Values: 104.0 115.0 113.0 113.0 115.0 116.0 113.0 115.0 117.0 115.0 02:00:34 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:118.50 stddev:11.56 (9.8%) stddev-sans-first:10.52 02:00:34 INFO - PROCESS | 9105 | Values: 139.0 120.0 114.0 144.0 117.0 114.0 114.0 114.0 131.0 114.0 02:00:34 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 02:00:34 INFO - PROCESS | 9105 | Values: 160.0 160.0 162.0 161.0 160.0 160.0 160.0 161.0 160.0 162.0 02:00:34 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | [#3] audio-fft Cycles:10 Average:80.30 Median:76.00 stddev:10.23 (13.5%) stddev-sans-first:10.67 02:00:34 INFO - PROCESS | 9105 | Values: 75.0 76.0 76.0 106.0 75.0 76.0 76.0 76.0 91.0 76.0 02:00:34 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:83.00 stddev:11.37 (13.7%) stddev-sans-first:11.74 02:00:34 INFO - PROCESS | 9105 | Values: 82.0 81.0 111.0 83.0 86.0 83.0 93.0 83.0 83.0 109.0 02:00:34 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:00:34 INFO - PROCESS | 9105 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 114.0 02:00:34 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 02:00:34 INFO - PROCESS | 9105 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 147.0 145.0 146.0 146.0 02:00:34 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 02:00:34 INFO - PROCESS | 9105 | Values: 93.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 02:00:34 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 02:00:34 INFO - PROCESS | 9105 | Values: 54.0 54.0 54.0 54.0 54.0 54.0 55.0 53.0 53.0 53.0 02:00:34 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | [#9] json-stringify-tinderbox Cycles:10 Average:53.30 Median:53.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 02:00:34 INFO - PROCESS | 9105 | Values: 53.0 53.0 53.0 53.0 53.0 53.0 53.0 54.0 54.0 54.0 02:00:34 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:79.00 stddev:7.47 (9.5%) stddev-sans-first:7.90 02:00:34 INFO - PROCESS | 9105 | Values: 79.0 79.0 74.0 75.0 80.0 79.0 81.0 80.0 79.0 101.0 02:00:34 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:125.00 stddev:4.68 (3.7%) stddev-sans-first:4.91 02:00:34 INFO - PROCESS | 9105 | Values: 126.0 120.0 120.0 123.0 129.0 118.0 121.0 124.0 133.0 127.0 02:00:34 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:163.50 stddev:2.58 (1.6%) stddev-sans-first:2.55 02:00:34 INFO - PROCESS | 9105 | Values: 165.0 159.0 164.0 160.0 161.0 166.0 163.0 160.0 160.0 165.0 02:00:34 INFO - PROCESS | 9105 | 02:00:34 INFO - PROCESS | 9105 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:60.00 stddev:3.24 (5.4%) stddev-sans-first:3.43 02:00:34 INFO - PROCESS | 9105 | Values: 61.0 69.0 61.0 60.0 60.0 59.0 59.0 59.0 59.0 57.0 02:00:34 INFO - PROCESS | 9105 | -------- Summary: end -------- 02:00:34 INFO - PROCESS | 9105 | 02:00:35 INFO - TEST-INFO | 9105: exit 0 02:00:35 INFO - TEST-OK | kraken | took 60385ms 02:00:35 INFO - SUITE-END | took 1175s 02:00:35 INFO - Completed test suite (00:19:35) 02:00:35 INFO - javascript benchmark 02:00:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7794.888915244544, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3381.1378098584855, 3434.605020422652, 3443.1736383268017, 3450.2236996675765, 3488.2325888304563, 5758.5393168546525, 5820.621659592123, 5832.300123985127, 5833.095870140124, 5838.153467747179, 5791.913121303184, 5795.710214489269, 5810.360860305363, 5828.883422331562, 5837.941620583793, 5265.815696450615, 5298.7350632468415, 5309.044372013036, 5383.057964856154, 5385.246065550826, 5172.379314482268, 5391.676499410048, 5395.757190926398, 5401.810936617219, 5402.243685883979, 5229.633925625208, 5251.947480525203, 5258.973705131488, 5325.7869685212545, 5399.514043736063, 5397.919031214535, 5401.621886467949, 5407.053765591006, 5417.0, 5423.972880135574, 5283.894322113536, 5336.226247194174, 5396.892062158735, 5401.378841433247, 5435.619506634537, 5554.527865131468, 5604.131359639263, 5620.91568626471, 5729.828105156852, 5820.388859169769, 6164.599301045418, 6183.319834818167, 6186.783462578788, 6189.597676151036, 6204.6587437690905, 6228.532860035515, 6239.313675495692, 6247.4377306042215, 6247.468965137923, 6249.156363890862, 5595.832125036255, 5618.213450116987, 5733.197352370671, 5828.06750919855, 5832.387599302097, 6381.074744162071, 6430.7749228776765, 6442.033694945796, 6447.967760161263, 6454.741810327534, 6193.287771906198, 6196.0, 6203.875922481616, 6208.0, 6212.316645169028, 5969.671668058299, 6234.937650623436, 6304.148939893147, 6305.148804911279, 6317.1156038154695, 6057.939420605826, 6064.06007068905, 6109.526129009804, 6127.325994140641, 6134.294556126102, 5941.257342832146, 5964.910526342108, 6178.351273116258, 6181.876362472725, 6181.876362472815, 4671.1358398695675, 4678.087772884255, 4687.10944920464, 4719.551642593948, 4735.573798358096, 4198.5591512891315, 4242.66058715302, 4273.572642735764, 4283.0363168286885, 4295.24833154203, 5763.366029736726, 5807.709614519342, 5926.111083337534, 5935.228420305332, 6040.969795150996, 6316.147320111818, 6327.905081423783, 6346.841328966812, 6351.650659213788, 6356.014817703263, 6039.909401358983, 6050.848728781815, 6051.515878729779, 6055.878882422327, 6057.212562366953, 5064.949350506447, 5093.745312734422, 5186.455422180617, 5310.0, 5336.706481143575, 6583.506237032242, 6591.769288074895, 6595.604263744191, 6607.57050791697, 6608.537402381787, 6301.4328710416285, 6302.0, 6302.527310451643, 6306.337834527309, 6317.210348706411, 6294.496440284858, 6336.398042185985, 6474.805755827333, 6607.372299631527, 6610.4711623071, 6030.216071910623, 6098.725557349841, 6151.6001459904965, 6165.660888651168, 6169.660668663267, 6199.752009919733, 6261.467775239155, 6267.96866015667, 6268.686565671789, 6269.62382257066, 5850.94149058504, 6022.879542409215, 6069.119977603311, 6083.300420451705, 6083.939160608337, 5961.91057134152, 6024.3674414187635, 6051.243594550681, 6136.969315153396, 6142.959235178615, 6050.515958723379, 6100.572959892765, 6104.32852386246, 6114.602550834182, 6116.816495505142, 5936.1095835625, 5986.730597123053, 5988.700564971821, 6143.877122457437, 6173.475254603409, 5910.881782364415, 5949.494292984971, 6022.126791615279, 6023.126646636126, 6040.154378386941], "value": 5746.678644075957, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.362844325437, 802.2458888644675, 820.712750537312, 896.8071864549121, 914.556440126539, 32220.03339899804, 44936.0, 45858.08283834325, 49850.50149498513, 50180.0, 47078.0, 47331.0, 47394.0, 47458.28812567814, 47464.525354746525, 7639.274268944441, 7794.961025194866, 9187.127222913812, 9324.766880827965, 9330.626774928995, 10592.894071059267, 10811.513481893295, 10814.621488247913, 10823.296485728442, 11192.888071119307, 10948.3978381189, 10977.560897564128, 10981.231313808037, 10983.670489885317, 10998.0, 10926.562937482491, 10968.122550196005, 10996.12031037515, 11000.559977600966, 11001.0, 10635.680929572125, 10662.413567253798, 10721.19591030668, 10722.0, 10729.356238625707, 44109.558904410864, 44137.558624413665, 44181.77909110466, 44355.55644443547, 44386.778066109786, 4066.369712694537, 4155.958440415588, 4201.4538110045805, 4277.636400905927, 4316.330968699856, 30639.846800766078, 31399.529007064913, 31573.8421307892, 31804.20489487758, 32919.17702057444, 4271.423357846682, 4383.101464199832, 4429.291313389842, 4462.085272519158, 4484.035932274576, 258326.0, 259458.0, 259896.0, 260313.0, 260741.0, 48316.0, 48552.75723621359, 48588.0, 48626.756866215444, 48653.270200947016, 49801.0, 49820.0, 49908.750456247486, 49977.25034124491, 50015.24977125346, 15557.688846223238, 15942.521724348288, 15948.601284967968, 15950.282237299118, 15960.281787319598, 11895.821562676567, 12102.213356131822, 13051.804222936664, 13790.310484475736, 13794.172349659053, 13465.596032119052, 13547.119437236548, 13579.185248885098, 13681.452741890213, 13683.521076762465, 5599.860003499945, 5631.099024156116, 5707.971460142756, 5785.797497087582, 5825.88941746079, 991.7471044883508, 995.6415690351467, 1009.6869970309227, 1012.6556970629874, 1025.5282570017876, 28995.275118121794, 29202.561961570595, 29352.330958630173, 29625.0, 29817.850910745743, 1070.9303895246785, 1080.5515710980012, 1094.0372472224392, 1094.0591091661165, 1111.1610733895857, 14632.487862924747, 15611.3755449783, 15886.682266354608, 16209.35162593483, 16220.51338459848, 368362.0, 370425.0, 370476.0, 371450.0, 372328.0, 53281.46718532765, 53363.733181333846, 53445.7327713359, 53461.465385346426, 53500.197497037574, 1462.531989763287, 1480.0, 1526.6183454136467, 1529.5411376586978, 1532.5478983699836, 27938.301542461602, 29341.413171736873, 29445.26386840346, 29682.851585741933, 29778.255543611584, 38777.806110969264, 39094.609053909095, 39247.0, 39364.60635393609, 39438.0, 346661.0, 347553.0, 348679.0, 349062.0, 349303.0, 25364.619530707423, 25875.482490350463, 28016.159515214575, 28310.292242694097, 30746.692533074383, 39058.218835623695, 39061.2187756249, 39284.0, 39344.60655393409, 39368.21263574655, 30038.3992320148, 30699.846500767355, 30830.537541937338, 30847.84576077105, 31160.688393116685, 30084.398312033198, 30327.0, 30725.078247652607, 30773.692263077977, 31167.220819479695, 33435.83282083574, 33893.83053084719, 34364.0, 39371.60628393794, 40030.39954400628, 31388.843055784575, 32014.67985320117, 32094.19764505906, 32099.0, 32330.191745206557, 26270.4745905077, 26408.471830563667, 26715.465690686466, 26719.599206011535, 26984.190474285802], "value": 18985.470788674313, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.5652759284649, 459.60933206774246, 466.6570070997817, 467.39005597695035, 473.95023522530136, 19437.125329360177, 20692.793072069293, 21089.15643374263, 21254.0, 21377.679334809953, 21692.56614867702, 22248.0, 22364.8881755591, 22862.31413057611, 23120.190793322236, 6188.566800323979, 6683.030960510723, 6800.625965571916, 6829.419499342537, 6911.585304881698, 6717.731290748364, 6835.7607483738075, 6838.589684618914, 6844.691988860513, 6845.349691779273, 6578.736850525973, 6758.290379510155, 6797.2523022467485, 6798.93201067988, 6826.897596536056, 6676.399124078807, 6694.129763130811, 6777.559458635197, 6828.624425656587, 6838.692258848364, 6536.54244202906, 6564.212294524687, 6572.737090516373, 6586.37429444202, 6592.86814263712, 25839.35401614956, 25934.74065259342, 25953.870230648914, 26141.0, 26178.0, 2840.0, 2870.138958312498, 2873.3822228221034, 2877.438899414615, 2880.1791489425623, 15963.84036159635, 16932.238049287687, 17205.139743012798, 17216.880902741283, 17635.911820440942, 2069.9172033118657, 2105.673620588811, 2130.7656157822626, 2150.666646669769, 2186.3768825884545, 71477.0, 73679.0, 85031.57484212663, 86320.0, 95032.52483737537, 18115.456536303933, 19552.90223548873, 19703.60592788165, 19728.60542789136, 19812.801871981384, 34344.48483272753, 34472.31055378878, 34545.0, 34546.82726586351, 34587.48118778221, 10935.945320273348, 11164.944175279072, 11212.719682007852, 11224.607138750105, 11282.887171128348, 9223.907760922439, 9281.489518076436, 9290.581923813445, 9434.339596228336, 9445.669401570913, 9978.850317245247, 10057.14514266281, 10272.640457583948, 10323.896761032294, 10375.221858360654, 3746.456763769238, 3916.9020774480864, 3938.2714197873483, 3940.9802950985063, 4019.196160767858, 998.7503124218945, 999.0808456220295, 1001.0940099210227, 1023.7594165371132, 1038.2524582300882, 22346.44133896633, 22459.887700561394, 22610.886945565497, 22730.0, 22740.772592273865, 1018.5111146649501, 1028.7942411517727, 1048.3081166430272, 1048.7011201807447, 1049.5801679328329, 11826.467808948619, 12648.936755316165, 12907.935460322638, 12929.806052909214, 13048.0, 304084.0, 309211.0, 524025.0, 693012.0, 723505.0, 91681.0, 93419.0, 94033.5298323504, 95756.0, 95836.52081739546, 1199.682084247675, 1277.3677029870273, 1300.2393599744066, 1346.4681450826868, 1361.9921258269007, 18709.532261693566, 19049.14278857427, 19388.030598469737, 19407.417777466697, 19434.125464353856, 51342.0, 52205.7389713049, 52466.213006804166, 52543.737281314876, 54469.0, 73494.26505734875, 73544.26455735374, 73679.63160184165, 74447.62776186084, 74793.2520674808, 11993.160478766402, 12094.45574949147, 12252.203606765532, 12267.263964162179, 12450.750984980068, 13248.337583120998, 13905.652358691113, 13942.302884855919, 14143.43426262938, 14258.786118208027, 11083.944580277048, 11236.0, 11406.429678515875, 11602.76794464123, 11720.88279117198, 10750.946245268724, 10912.61805836792, 10915.727106822393, 11382.829257560978, 11468.369239691898, 11052.778944421227, 11367.0, 11419.486123124314, 11965.700857478632, 12320.815187772012, 12034.63896083119, 12234.694132646755, 12264.0, 12290.815637765261, 12487.75122487744, 10737.89262107369, 10938.124950003821, 10963.725906852393, 11024.5038973248, 11091.44542772842], "value": 11316.189179162386, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1541.5606552132645, 1560.0795530636922, 1572.1667516216405, 1574.3466461418511, 1574.511901310593, 10697.518611662474, 11465.656030319084, 11465.885341146586, 11469.770604587904, 11474.139439542036, 10805.297655652397, 11200.887991120086, 11211.271267367636, 11213.327200367963, 11222.102231821455, 2256.616375216209, 2292.5414917016665, 2297.3911913342895, 2298.5173113646156, 2299.632058870581, 2140.8501404901663, 2218.5341078373563, 2289.896954637037, 2301.8964146613357, 2310.2838120182714, 2203.1187524989973, 2214.3356992902145, 2220.8667479951173, 2232.218723446797, 2327.7323107842644, 2148.2803260907613, 2155.374941267031, 2162.902669379882, 2165.4694599822988, 2172.196287373674, 2228.342638921522, 2290.6564015397657, 2295.3458264394567, 2304.3432621702736, 2308.4805918668335, 11465.140114491363, 11512.424378781112, 11540.0, 11544.422778861108, 11546.94226528862, 5444.428335024844, 5539.556835453154, 5570.637908535973, 5585.106382978704, 5589.580781441408, 3245.1562593725566, 3264.281857991238, 3419.760616756828, 3459.567554055743, 3482.564679415073, 1330.2750001249342, 1347.0772520823268, 1429.371076726237, 1452.6586252230718, 1454.7236025155187, 14413.927930360282, 14740.852591474055, 15618.843811561967, 16870.409535666317, 17106.572335691584, 4477.171723231213, 4556.70381425213, 4676.111538807616, 4679.836205732783, 4682.836100736526, 13035.0, 13039.152455090389, 13047.282399467931, 13088.476460941647, 13097.934510327388, 4876.268559716, 5021.246812978009, 5513.283273174462, 5621.550275977912, 5634.6337488063145, 5193.584513238932, 5216.765245563959, 5296.841094767163, 5297.152455607084, 5298.178782288752, 3841.2125514269505, 3874.089588946595, 3925.1953349563273, 3951.2887680217264, 3968.543617483969, 953.990460095404, 958.8561715742555, 964.7395203295071, 966.8453047512364, 970.4129001953858, 1056.10758908722, 1062.0919114157439, 1062.2139616683753, 1068.273573969708, 1079.266099052636, 7079.646017699094, 7179.928200717926, 7202.099737532809, 7296.197418283985, 7356.816079598053, 1031.376017509411, 1057.9894201058046, 1065.8561094252177, 1066.8079745645703, 1070.9089727373105, 4627.722336659811, 4678.3216433616935, 4679.508651591534, 4686.95313046872, 4743.146233677902, 14334.856651433352, 14720.116792992454, 14724.779128313085, 14730.263486825615, 14827.629309267139, 14447.205403702897, 14514.637134071521, 14516.782248266285, 14585.0, 14603.561893143222, 8797.868031979526, 10436.217283703601, 10672.146228301717, 10804.13566914645, 10817.188710846718, 6508.414242718178, 7205.603691796792, 7315.963420182865, 7413.629318534159, 7419.22098179705, 12300.077494187793, 12316.261024338568, 12319.63041108768, 12406.131570789958, 12570.1200915935, 12556.30434023546, 12575.245485270547, 12591.87408125907, 12848.0, 12954.28751418681, 9152.222061124612, 9216.216621586971, 9341.2994025447, 9356.391834530734, 9358.953205234202, 10724.946375268073, 10780.029797318279, 10852.131829453783, 10863.837042444527, 10865.239433239598, 9066.365354425126, 9130.269578433843, 9144.862827057732, 9216.539173041456, 9301.72094837156, 8778.385513014284, 8809.163129502687, 8922.152395522415, 9015.549222538715, 9078.727638170865, 8382.077971423018, 8416.957915210385, 8548.230659240699, 8569.571521423779, 8570.185832345916, 6292.559520833498, 6399.616023038632, 6448.935510644834, 6496.967515162394, 6543.214814222324, 6445.871082578416, 6530.349220512133, 6534.085228068169, 6584.308647591934, 6645.501587380869], "value": 5267.807652812526, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.5875782974855, 417.753535313538, 425.3322284014099, 432.40544251653955, 432.532864506333, 5282.999999999995, 5294.523492885649, 5318.414974352818, 5326.520613144816, 5329.413764485904, 4919.680220785646, 5105.3873535175735, 5158.406783219931, 5210.921836172451, 5234.92147617786, 4379.715318504287, 4430.623397011258, 4466.017476155241, 4473.865784026476, 4495.6628252881, 4428.892776805798, 4446.2219111655495, 4468.061707041526, 4475.328700694889, 4478.0, 4432.734035957837, 4470.307102399117, 4471.597556219939, 4507.256302710049, 4546.613537849286, 4372.23485889968, 4413.58070983256, 4443.111377724435, 4447.888027993002, 4498.617617502517, 4144.761828612545, 4169.353750168729, 4184.995601055755, 4191.0, 4207.148854504008, 5160.432352441228, 5173.120569503156, 5177.938522602857, 5181.740912954375, 5228.503292187236, 4913.361263035782, 5107.1828507439, 5120.231965205212, 5150.871228219287, 5253.159494480865, 5542.140968149944, 5565.163496046295, 5569.470900264469, 5595.916061259084, 5598.300212473441, 4695.980728286835, 4716.764161791931, 4718.551737584924, 4720.59874910633, 4738.881527961794, 5631.63394379364, 5731.389224788357, 5740.851829634048, 5837.227317024422, 5862.046570647796, 4700.2949557566635, 4726.881827954328, 4726.983698504838, 4770.785314660849, 4797.0, 4844.370231869834, 4858.684185527929, 4861.222204447342, 4883.658143929891, 4911.8280860170435, 4863.221884498464, 5090.847274581768, 5103.540681338697, 5104.259882317117, 5129.333186685782, 5425.697832520167, 5442.6462279951675, 5475.6440831345835, 5477.233187353773, 5501.697406642593, 1671.0558534428253, 1681.7225157849064, 1682.7307630779017, 1684.7111959351107, 1688.2318545061967, 1231.6243545718462, 1276.4766445757195, 1301.8828305452555, 1307.5162189989765, 1321.7554752370843, 5137.794488220504, 5328.374845672107, 5392.379876314196, 5401.243825864382, 5401.810936617199, 5620.690862002547, 5663.773449062074, 5664.348599911063, 5673.77304907799, 5676.829695109153, 5397.325334333208, 5404.216828333411, 5409.864753381197, 5414.3232095988005, 5438.673679579238, 2916.314666053476, 2965.792394532405, 2986.343004538998, 2991.7157870002316, 3020.199647093522, 5874.970625146847, 5878.0, 5899.292084949748, 5903.26209223847, 5906.839840685298, 5433.8369848904595, 5741.511971482387, 5781.4507621775865, 5795.464201986477, 5836.9124463133085, 5144.067881307618, 5737.848306884918, 5934.1692163097205, 5977.790777322686, 5982.222311099529, 5648.519875810603, 5660.462256085665, 5682.886342273048, 5706.572007099568, 5734.512566431733, 5340.0, 5577.776888924398, 5691.292612216236, 5701.543876489954, 5710.4004079572705, 5934.703264836655, 5947.9702601486715, 5948.970255148696, 5967.91048134287, 5993.460588547052, 4751.311059896365, 4761.714297142183, 4797.472278049342, 4801.759912004456, 4814.398200224972, 5470.288862447856, 5628.521575666115, 5631.239782629293, 5670.716464176857, 5789.6394347327505, 5549.112142057252, 5551.278333816578, 5551.833444996657, 5581.5255703265675, 5584.972075139598, 5354.330708661418, 5595.608307418442, 5600.663960162403, 5625.296837895263, 5639.182318563703, 5492.1212605982855, 5497.972510137423, 5528.695921724344, 5539.833804985696, 5566.383799614175, 5593.608447408642, 5595.412481689526, 5600.4959553640365, 5607.0, 5622.24099746529, 5200.297959775382, 5411.350637923474, 5439.062906030857, 5463.699496527729, 5469.726513674221], "value": 4473.586203086774, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.238104990784, 842.2882664148796, 904.6788390121508, 916.5234078279296, 931.4364809290375, 14494.855051449482, 16985.235664395103, 17431.389901353454, 17549.385771498, 17663.558411039714, 14543.854561454382, 15559.0, 15911.204439778023, 16269.349226030945, 16445.83554164458, 862.1163307609687, 878.4641368765048, 880.3705350674267, 880.8238352329528, 881.4755220643707, 861.7113267055544, 878.5695009445358, 891.4294851295176, 892.7366426904047, 896.4621227263623, 918.9862152067724, 924.2190349154987, 926.379325851681, 928.22029495224, 931.0642803981989, 924.0343840686498, 928.0348437624862, 929.7024952015357, 930.1953809954374, 930.7393929699695, 677.018323431022, 682.9282925292872, 683.0369179456992, 683.4942142814332, 683.6684208159039, 16472.67054658912, 16515.256813443422, 16605.750913736305, 17009.319627214896, 17036.318547258095, 15864.841351586452, 16209.432669856616, 16317.59206019847, 16443.671126577403, 16549.91725041379, 13453.125546839425, 13673.726525469534, 13729.588112356645, 13858.099223550538, 13884.722305553832, 3897.4738410314812, 3943.7633741975574, 3983.063979964706, 4038.172174704179, 4118.094019315746, 91144.0, 92561.0, 94386.05613943841, 95644.0, 96595.51702241444, 12318.75362492763, 12319.384030798425, 12325.50697972089, 12346.629601111981, 12651.0, 24482.510349792905, 24594.139205127736, 24947.5010499789, 24963.87518062398, 24983.500329993298, 8180.9181908181345, 8236.299914507214, 8237.382196335298, 8359.8328033439, 8492.787680307918, 4612.215923293048, 4663.976680116578, 4739.312799644033, 4841.0, 4880.6095512358925, 3655.7989310588173, 3703.037210325335, 3730.0674831292176, 3748.775073495599, 3757.8496860125833, 574.5231457889942, 576.4840467781396, 579.7999690106907, 580.1153241306956, 580.135597959038, 608.850831546274, 624.2384291164772, 638.5625846295303, 641.5701480008405, 663.280340830195, 10491.475426228659, 10999.61501347449, 11077.778444431066, 11130.721731956766, 11170.832437513443, 732.143392231091, 748.6144635512716, 756.71623141322, 761.0524896503778, 763.5266134996338, 4643.442786865598, 4994.2508623706735, 4998.450170481244, 4999.3000979862845, 5040.445550989388, 82865.0, 83072.0, 84071.73892391619, 85758.5712071448, 87603.56198218968, 59540.404595953485, 72499.0, 73873.63063184757, 75671.0, 76698.0, 66286.33713662802, 67222.66388668025, 67505.66247168831, 68404.31595684079, 70174.2982570178, 9337.953310233406, 9652.350519661746, 9672.08115229052, 9682.094599642322, 9683.069598933926, 44787.77606111948, 45263.0, 45363.31955020611, 45929.77035114803, 46244.306335404326, 45042.0, 45238.09523809439, 54227.186592201935, 55063.72468137794, 55156.0, 13799.172049677052, 13888.0, 14020.649483762987, 14096.577102686935, 14318.212498312276, 16018.599535011717, 16150.0, 16320.347186112898, 16564.088975106002, 16633.916830415772, 13833.792493112813, 13942.512012079529, 14213.786793198316, 14334.0, 14699.55901322962, 13721.862781372058, 13894.166350019032, 14278.357473913491, 14704.928421378521, 15416.229188540305, 14736.2631868404, 14761.483348082766, 15004.249787510798, 15212.391504339703, 15876.920615397312, 10239.232057595562, 10344.741381465523, 10574.0, 11138.721531961766, 11209.383483908463, 11848.585299514476, 12119.333436660716, 12183.817242741188, 12203.69490762738, 12284.938575307066], "value": 7708.981394551872, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1453.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 113.0, 113.0, 115.0, 116.0, 113.0, 115.0, 117.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 120.0, 114.0, 144.0, 117.0, 114.0, 114.0, 114.0, 131.0, 114.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 161.0, 160.0, 160.0, 160.0, 161.0, 160.0, 162.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 106.0, 75.0, 76.0, 76.0, 76.0, 91.0, 76.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 111.0, 83.0, 86.0, 83.0, 93.0, 83.0, 83.0, 109.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 145.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 53.0, 53.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 54.0, 54.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 74.0, 75.0, 80.0, 79.0, 81.0, 80.0, 79.0, 101.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 120.0, 120.0, 123.0, 129.0, 118.0, 121.0, 124.0, 133.0, 127.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 159.0, 164.0, 160.0, 161.0, 166.0, 163.0, 160.0, 160.0, 165.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 69.0, 61.0, 60.0, 60.0, 59.0, 59.0, 59.0, 59.0, 57.0], "value": 60.4, "unit": "score"}]}]} 02:00:36 INFO - Return code: 0 02:00:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:00:36 ERROR - # TBPL SUCCESS # 02:00:36 INFO - Running post-action listener: _resource_record_post_action 02:00:36 INFO - [mozharness: 2017-04-03 09:00:36.093888Z] Finished run-tests step (success) 02:00:36 INFO - Running post-run listener: _resource_record_post_run 02:00:36 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 366940160; Read time: 4; Write time: 243572 02:00:36 INFO - TinderboxPrint: CPU usage
13.1% 02:00:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 02:00:36 INFO - TinderboxPrint: I/O write bytes / time
366,940,160 / 243,572 02:00:36 INFO - TinderboxPrint: CPU idle
8,271.5 (86.9%) 02:00:36 INFO - TinderboxPrint: CPU user
1,203.1 (12.6%) 02:00:36 INFO - TinderboxPrint: Swap in / out
0 / 0 02:00:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110825472; Read time: 0; Write time: 99548 02:00:36 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 256114688; Read time: 4; Write time: 144024 02:00:36 INFO - Running post-run listener: _upload_blobber_files 02:00:36 INFO - Blob upload gear active. 02:00:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:00:36 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 02:00:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:00:38 INFO - (blobuploader) - INFO - Open directory for files ... 02:00:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:00:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:00:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:00:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:00:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:00:41 INFO - (blobuploader) - INFO - Done attempting. 02:00:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:00:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:00:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:00:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:00:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:00:47 INFO - (blobuploader) - INFO - Done attempting. 02:00:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:00:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:00:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:00:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:00:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:00:51 INFO - (blobuploader) - INFO - Done attempting. 02:00:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:00:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:00:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:00:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:00:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:00:54 INFO - (blobuploader) - INFO - Done attempting. 02:00:54 INFO - (blobuploader) - INFO - Iteration through files over. 02:00:54 INFO - Return code: 0 02:00:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:00:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:00:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0461001efcacdf18062d806abd920ffb6ec33129eb03607a944fb78ba1150b6b23b2d0fc41c4d35e442824efaa6cd38a46503e5557641ebcadbfad20109faa58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e00a1501bb92764b8a5bccd9a9dcbd876273a089cc4a7b2f485fcab68e1fc65d72020b2eee6e79459167ccdb8b20b4245e1f4be72671cc76efb69bdd22afd5eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b22ff3458d3cc32b78ffbe8d52bc995fe8b9af75a1748480e32f07c434708eb258e1131a742b5470530499d79e77a248bbf4ef39192f502bbe177f47d9a88fae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f0f538a5dc85c617fb104c8381b071ba1f797fdc885f2094703962b208b34ab5a53599fb2865fcae74181f01afe9e6d60db89e69cf2d4f54280f43c51ee788a"} 02:00:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:00:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:00:54 INFO - Contents: 02:00:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0461001efcacdf18062d806abd920ffb6ec33129eb03607a944fb78ba1150b6b23b2d0fc41c4d35e442824efaa6cd38a46503e5557641ebcadbfad20109faa58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e00a1501bb92764b8a5bccd9a9dcbd876273a089cc4a7b2f485fcab68e1fc65d72020b2eee6e79459167ccdb8b20b4245e1f4be72671cc76efb69bdd22afd5eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b22ff3458d3cc32b78ffbe8d52bc995fe8b9af75a1748480e32f07c434708eb258e1131a742b5470530499d79e77a248bbf4ef39192f502bbe177f47d9a88fae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f0f538a5dc85c617fb104c8381b071ba1f797fdc885f2094703962b208b34ab5a53599fb2865fcae74181f01afe9e6d60db89e69cf2d4f54280f43c51ee788a"} 02:00:54 INFO - Running post-run listener: copy_logs_to_upload_dir 02:00:54 INFO - Copying logs to upload dir... 02:00:54 INFO - mkdir: /builds/slave/test/build/upload/logs 02:00:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.337345 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-04-03 02:00:53.948139) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 02:00:53.951407) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0461001efcacdf18062d806abd920ffb6ec33129eb03607a944fb78ba1150b6b23b2d0fc41c4d35e442824efaa6cd38a46503e5557641ebcadbfad20109faa58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e00a1501bb92764b8a5bccd9a9dcbd876273a089cc4a7b2f485fcab68e1fc65d72020b2eee6e79459167ccdb8b20b4245e1f4be72671cc76efb69bdd22afd5eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b22ff3458d3cc32b78ffbe8d52bc995fe8b9af75a1748480e32f07c434708eb258e1131a742b5470530499d79e77a248bbf4ef39192f502bbe177f47d9a88fae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f0f538a5dc85c617fb104c8381b071ba1f797fdc885f2094703962b208b34ab5a53599fb2865fcae74181f01afe9e6d60db89e69cf2d4f54280f43c51ee788a"} build_url:https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011459 build_url: 'https://queue.taskcluster.net/v1/task/AdtRDzOcSK29fxASgXfYDQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0461001efcacdf18062d806abd920ffb6ec33129eb03607a944fb78ba1150b6b23b2d0fc41c4d35e442824efaa6cd38a46503e5557641ebcadbfad20109faa58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e00a1501bb92764b8a5bccd9a9dcbd876273a089cc4a7b2f485fcab68e1fc65d72020b2eee6e79459167ccdb8b20b4245e1f4be72671cc76efb69bdd22afd5eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b22ff3458d3cc32b78ffbe8d52bc995fe8b9af75a1748480e32f07c434708eb258e1131a742b5470530499d79e77a248bbf4ef39192f502bbe177f47d9a88fae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f0f538a5dc85c617fb104c8381b071ba1f797fdc885f2094703962b208b34ab5a53599fb2865fcae74181f01afe9e6d60db89e69cf2d4f54280f43c51ee788a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 02:00:53.980747) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 02:00:53.981155) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1491187537.715548-1021942554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 02:00:54.066230) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 02:00:54.066608) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 02:00:54.067066) ========= ========= Total master_lag: 0.18 =========