builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1491332510.54 results: success (0) revision: b043233ec04f06768d59dcdfb9e928142280f3cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 12:01:50.540902) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 12:01:50.541634) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 12:01:50.541967) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 12:01:50.561944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 12:01:50.562375) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-04 12:01:50-- 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% 220M=0s 2017-04-04 12:01:50 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128035 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 12:01:50.707896) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 12:01:50.708287) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017830 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 12:01:50.758938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 12:01:50.759303) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b043233ec04f06768d59dcdfb9e928142280f3cc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev b043233ec04f06768d59dcdfb9e928142280f3cc --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=56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-04 12:01:51,117 truncating revision to first 12 chars 2017-04-04 12:01:51,117 Setting DEBUG logging. 2017-04-04 12:01:51,117 attempt 1/10 2017-04-04 12:01:51,117 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b043233ec04f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 12:01:51,436 unpacking tar archive at: mozilla-central-b043233ec04f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639945 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 12:01:51.414521) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 12:01:51.415214) ========= script_repo_revision: b043233ec04f06768d59dcdfb9e928142280f3cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 12:01:51.415847) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 12:01:51.416320) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 12:01:51.426863) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-04-04 12:01:51.427183) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:01:51 INFO - MultiFileLogger online at 20170404 12:01:51 in /builds/slave/test 12:01:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:01:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:01:51 INFO - {'append_to_log': False, 12:01:51 INFO - 'base_work_dir': '/builds/slave/test', 12:01:51 INFO - 'blob_upload_branch': 'Firefox', 12:01:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:01:51 INFO - 'branch': 'Firefox', 12:01:51 INFO - 'buildbot_json_path': 'buildprops.json', 12:01:51 INFO - 'config_files': ('talos/linux_config.py',), 12:01:51 INFO - 'default_actions': ('clobber', 12:01:51 INFO - 'read-buildbot-config', 12:01:51 INFO - 'download-and-extract', 12:01:51 INFO - 'populate-webroot', 12:01:51 INFO - 'create-virtualenv', 12:01:51 INFO - 'install', 12:01:51 INFO - 'run-tests'), 12:01:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:01:51 INFO - 'download_minidump_stackwalk': True, 12:01:51 INFO - 'download_symbols': 'ondemand', 12:01:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:01:51 INFO - 'tooltool.py': '/tools/tooltool.py', 12:01:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:01:51 INFO - '/tools/misc-python/virtualenv.py')}, 12:01:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:01:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:01:51 INFO - 'gecko_profile': False, 12:01:51 INFO - 'gecko_profile_interval': 0, 12:01:51 INFO - 'installer_path': 'installer.exe', 12:01:51 INFO - 'log_level': 'info', 12:01:51 INFO - 'log_name': 'talos', 12:01:51 INFO - 'log_to_console': True, 12:01:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:01:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:01:51 INFO - 'opt_config_files': (), 12:01:51 INFO - 'pip_index': False, 12:01:51 INFO - 'suite': 'dromaeojs', 12:01:51 INFO - 'system_bits': '32', 12:01:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:01:51 INFO - 'title': 'talos-linux64-ix-037', 12:01:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:01:51 INFO - 'use_talos_json': True, 12:01:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:01:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:01:51 INFO - 'work_dir': 'build'} 12:01:51 INFO - [mozharness: 2017-04-04 19:01:51.881413Z] Running clobber step. 12:01:51 INFO - Running pre-action listener: _resource_record_pre_action 12:01:51 INFO - Running main action method: clobber 12:01:51 INFO - rmtree: /builds/slave/test/build 12:01:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:01:53 INFO - Running post-action listener: _resource_record_post_action 12:01:53 INFO - [mozharness: 2017-04-04 19:01:53.337204Z] Finished clobber step (success) 12:01:53 INFO - [mozharness: 2017-04-04 19:01:53.337303Z] Running read-buildbot-config step. 12:01:53 INFO - Running pre-action listener: _resource_record_pre_action 12:01:53 INFO - Running main action method: read_buildbot_config 12:01:53 INFO - Using buildbot properties: 12:01:53 INFO - { 12:01:53 INFO - "project": "", 12:01:53 INFO - "product": "firefox", 12:01:53 INFO - "who": "kwierso@gmail.com", 12:01:53 INFO - "installer_path": "public/build/target.tar.bz2", 12:01:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 12:01:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 12:01:53 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 12:01:53 INFO - "stage_platform": "linux64-stylo", 12:01:53 INFO - "basedir": "/builds/slave/test", 12:01:53 INFO - "buildnumber": 17, 12:01:53 INFO - "platform": "ubuntu64_hw_stylo", 12:01:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:01:53 INFO - "slavebuilddir": "test", 12:01:53 INFO - "taskId": "XI1h43ZhTq-cp4AIi8f9hA", 12:01:53 INFO - "branch": "mozilla-central", 12:01:53 INFO - "script_repo_revision": "production", 12:01:53 INFO - "revision": "b043233ec04f06768d59dcdfb9e928142280f3cc", 12:01:53 INFO - "slavename": "talos-linux64-ix-037", 12:01:53 INFO - "repo_path": "mozilla-central" 12:01:53 INFO - } 12:01:53 INFO - Finding installer, test and symbols from parent task. 12:01:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XI1h43ZhTq-cp4AIi8f9hA'}, attempt #1 12:01:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XI1h43ZhTq-cp4AIi8f9hA'}, attempt #1 12:01:54 INFO - Task dependencies: JMkrglegRteWlaQZDMjn8A 12:01:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A'}, attempt #1 12:01:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.tar.bz2 12:01:54 INFO - Set test_url: https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/test_packages.json 12:01:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.crashreporter-symbols.zip 12:01:54 INFO - Running post-action listener: _resource_record_post_action 12:01:54 INFO - [mozharness: 2017-04-04 19:01:54.716710Z] Finished read-buildbot-config step (success) 12:01:54 INFO - [mozharness: 2017-04-04 19:01:54.716929Z] Running download-and-extract step. 12:01:54 INFO - Running pre-action listener: _resource_record_pre_action 12:01:54 INFO - Running main action method: download_and_extract 12:01:54 INFO - mkdir: /builds/slave/test/build/tests 12:01: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')]} 12:01:54 INFO - trying https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.test_packages.json 12:01:54 INFO - Downloading https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:01:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:01:55 INFO - Downloaded 986 bytes. 12:01:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:01:55 INFO - Using the following test package requirements: 12:01:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:01:55 INFO - u'common': [u'target.common.tests.zip'], 12:01:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:01:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:01:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:01:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:01:55 INFO - u'mozbase': [u'target.common.tests.zip'], 12:01:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:01:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:01:55 INFO - u'web-platform': [u'target.common.tests.zip', 12:01:55 INFO - u'target.web-platform.tests.zip'], 12:01:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:01:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:01:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.common.tests.zip 12:01:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:01:55 INFO - Fetch https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.common.tests.zip into memory 12:01:56 INFO - Expected file size: 58242912 12:01:56 INFO - Obtained file size: 58242912 12:02:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:02:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.common.tests.zip 12:02:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:02:06 INFO - Fetch https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.common.tests.zip into memory 12:02:07 INFO - Expected file size: 58242912 12:02:07 INFO - Obtained file size: 58242912 12:02:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.talos.tests.zip 12:02:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:02:18 INFO - Fetch https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.talos.tests.zip into memory 12:02:19 INFO - Expected file size: 14404152 12:02:19 INFO - Obtained file size: 14404152 12:02: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')]} 12:02:19 INFO - trying https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.tar.bz2 12:02:19 INFO - Downloading https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:02:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:02:21 INFO - Downloaded 58915843 bytes. 12:02:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.tar.bz2 12:02:21 INFO - mkdir: /builds/slave/test/properties 12:02:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:02:21 INFO - Writing to file /builds/slave/test/properties/build_url 12:02:21 INFO - Contents: 12:02:21 INFO - build_url:https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.tar.bz2 12:02:21 INFO - Running post-action listener: _resource_record_post_action 12:02:21 INFO - Running post-action listener: set_extra_try_arguments 12:02:21 INFO - [mozharness: 2017-04-04 19:02:21.818527Z] Finished download-and-extract step (success) 12:02:21 INFO - [mozharness: 2017-04-04 19:02:21.818654Z] Running populate-webroot step. 12:02:21 INFO - Running pre-action listener: _resource_record_pre_action 12:02:21 INFO - Running main action method: populate_webroot 12:02:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:02:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:02:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:02:21 INFO - '--tppagecycles', 12:02:21 INFO - '7'], 12:02:21 INFO - 'tests': ['tsvgm']}}, 12:02:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:02:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:02:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:02:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:02:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:02:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:02:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:02:21 INFO - 'talos_options': ['--disable-e10s'], 12:02:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:02:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:02:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:02:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:02:21 INFO - 'talos_options': ['--disable-e10s'], 12:02:21 INFO - 'tests': ['damp', 'tps']}, 12:02:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:02:21 INFO - 'tests': ['damp', 'tps']}, 12:02:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:02:21 INFO - 'tests': ['dromaeo_dom']}, 12:02:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:02:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:02:21 INFO - 'tests': ['basic_compositor_video']}, 12:02:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:02:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:02:21 INFO - 'tests': ['a11yr', 12:02:21 INFO - 'ts_paint', 12:02:21 INFO - 'tpaint', 12:02:21 INFO - 'sessionrestore', 12:02:21 INFO - 'sessionrestore_no_auto_restore', 12:02:21 INFO - 'tabpaint']}, 12:02:21 INFO - 'other-e10s': {'tests': ['a11yr', 12:02:21 INFO - 'ts_paint', 12:02:21 INFO - 'tpaint', 12:02:21 INFO - 'sessionrestore', 12:02:21 INFO - 'sessionrestore_no_auto_restore', 12:02:21 INFO - 'tabpaint']}, 12:02:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:02:21 INFO - 'ts_paint', 12:02:21 INFO - 'tpaint', 12:02:21 INFO - 'sessionrestore', 12:02:21 INFO - 'sessionrestore_no_auto_restore', 12:02:21 INFO - 'tabpaint']}, 12:02:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:02:21 INFO - 'ts_paint', 12:02:21 INFO - 'tpaint', 12:02:21 INFO - 'sessionrestore', 12:02:21 INFO - 'sessionrestore_no_auto_restore', 12:02:21 INFO - 'tabpaint']}, 12:02:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:02:21 INFO - 'tests': ['a11yr', 12:02:21 INFO - 'ts_paint', 12:02:21 INFO - 'tpaint', 12:02:21 INFO - 'sessionrestore', 12:02:21 INFO - 'sessionrestore_no_auto_restore', 12:02:21 INFO - 'tabpaint']}, 12:02:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:02:21 INFO - 'tests': ['a11yr', 12:02:21 INFO - 'ts_paint', 12:02:21 INFO - 'tpaint', 12:02:21 INFO - 'sessionrestore', 12:02:21 INFO - 'sessionrestore_no_auto_restore', 12:02:21 INFO - 'tabpaint']}, 12:02:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:02:21 INFO - 'tests': ['tsvgx', 12:02:21 INFO - 'tsvgr_opacity', 12:02:21 INFO - 'tart', 12:02:21 INFO - 'tscrollx', 12:02:21 INFO - 'cart', 12:02:21 INFO - 'tsvg_static']}, 12:02:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:02:21 INFO - 'tsvgr_opacity', 12:02:21 INFO - 'tart', 12:02:21 INFO - 'tscrollx', 12:02:21 INFO - 'cart', 12:02:21 INFO - 'tsvg_static']}, 12:02:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:02:21 INFO - 'talos_options': ['--disable-e10s'], 12:02:21 INFO - 'tests': ['tp5o']}, 12:02:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:02:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:02:21 INFO - 'talos_options': ['--disable-e10s', 12:02:21 INFO - '--xperf_path', 12:02:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:02:21 INFO - 'tests': ['tp5n']}, 12:02:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:02:21 INFO - 'talos_options': ['--xperf_path', 12:02:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:02:21 INFO - 'tests': ['tp5n']}}, 12:02:21 INFO - 'talos.zip': {'path': '', 12:02:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:02:21 INFO - Running post-action listener: _resource_record_post_action 12:02:21 INFO - [mozharness: 2017-04-04 19:02:21.834925Z] Finished populate-webroot step (success) 12:02:21 INFO - [mozharness: 2017-04-04 19:02:21.835016Z] Running create-virtualenv step. 12:02:21 INFO - Running pre-action listener: _resource_record_pre_action 12:02:21 INFO - Running main action method: create_virtualenv 12:02:21 INFO - Creating virtualenv /builds/slave/test/build/venv 12:02:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:02:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:02:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:02:21 INFO - Using real prefix '/usr' 12:02:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:02:22 INFO - Installing distribute.............................................................................................................................................................................................done. 12:02:24 INFO - Installing pip.................done. 12:02:24 INFO - Return code: 0 12:02:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:02:24 INFO - Reading from file tmpfile_stdout 12:02:24 INFO - Output received: 12:02:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:02:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1400>, '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 0x1fd23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:02:24 INFO - Using env: {'DISPLAY': ':0', 12:02:24 INFO - 'HOME': '/home/cltbld', 12:02:24 INFO - 'LANG': 'en_US.UTF-8', 12:02:24 INFO - 'LANGUAGE': 'en_US:en', 12:02:24 INFO - 'LOGNAME': 'cltbld', 12:02:24 INFO - 'MAIL': '/var/mail/cltbld', 12:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:24 INFO - 'MOZ_NO_REMOTE': '1', 12:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:24 INFO - 'NO_EM_RESTART': '1', 12:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:24 INFO - 'PWD': '/builds/slave/test', 12:02:24 INFO - 'SHELL': '/bin/bash', 12:02:24 INFO - 'SHLVL': '1', 12:02:24 INFO - 'TERM': 'linux', 12:02:24 INFO - 'TMOUT': '86400', 12:02:24 INFO - 'USER': 'cltbld', 12:02:24 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 12:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:24 INFO - '_': '/tools/buildbot/bin/python'} 12:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:02:24 INFO - Cleaning up... 12:02:24 INFO - Return code: 0 12:02:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1400>, '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 0x1fd23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:02:24 INFO - Using env: {'DISPLAY': ':0', 12:02:24 INFO - 'HOME': '/home/cltbld', 12:02:24 INFO - 'LANG': 'en_US.UTF-8', 12:02:24 INFO - 'LANGUAGE': 'en_US:en', 12:02:24 INFO - 'LOGNAME': 'cltbld', 12:02:24 INFO - 'MAIL': '/var/mail/cltbld', 12:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:24 INFO - 'MOZ_NO_REMOTE': '1', 12:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:24 INFO - 'NO_EM_RESTART': '1', 12:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:24 INFO - 'PWD': '/builds/slave/test', 12:02:24 INFO - 'SHELL': '/bin/bash', 12:02:24 INFO - 'SHLVL': '1', 12:02:24 INFO - 'TERM': 'linux', 12:02:24 INFO - 'TMOUT': '86400', 12:02:24 INFO - 'USER': 'cltbld', 12:02:24 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 12:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:24 INFO - '_': '/tools/buildbot/bin/python'} 12:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:25 INFO - Downloading/unpacking psutil>=3.1.1 12:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:02:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:02:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:02:27 INFO - Installing collected packages: psutil 12:02:27 INFO - Running setup.py install for psutil 12:02:27 INFO - building 'psutil._psutil_linux' extension 12:02:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:02:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:02:27 INFO - building 'psutil._psutil_posix' extension 12:02:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:02:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:02:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:02:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:02:27 INFO - Successfully installed psutil 12:02:27 INFO - Cleaning up... 12:02:27 INFO - Return code: 0 12:02:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1400>, '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 0x1fd23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:02:27 INFO - Using env: {'DISPLAY': ':0', 12:02:27 INFO - 'HOME': '/home/cltbld', 12:02:27 INFO - 'LANG': 'en_US.UTF-8', 12:02:27 INFO - 'LANGUAGE': 'en_US:en', 12:02:27 INFO - 'LOGNAME': 'cltbld', 12:02:27 INFO - 'MAIL': '/var/mail/cltbld', 12:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:27 INFO - 'MOZ_NO_REMOTE': '1', 12:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:27 INFO - 'NO_EM_RESTART': '1', 12:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:27 INFO - 'PWD': '/builds/slave/test', 12:02:27 INFO - 'SHELL': '/bin/bash', 12:02:27 INFO - 'SHLVL': '1', 12:02:27 INFO - 'TERM': 'linux', 12:02:27 INFO - 'TMOUT': '86400', 12:02:27 INFO - 'USER': 'cltbld', 12:02:27 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 12:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:27 INFO - '_': '/tools/buildbot/bin/python'} 12:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:02:30 INFO - Installing collected packages: mozsystemmonitor 12:02:30 INFO - Running setup.py install for mozsystemmonitor 12:02:30 INFO - Successfully installed mozsystemmonitor 12:02:30 INFO - Cleaning up... 12:02:30 INFO - Return code: 0 12:02:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:30 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 0x1d361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1400>, '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 0x1fd23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:02:30 INFO - Using env: {'DISPLAY': ':0', 12:02:30 INFO - 'HOME': '/home/cltbld', 12:02:30 INFO - 'LANG': 'en_US.UTF-8', 12:02:30 INFO - 'LANGUAGE': 'en_US:en', 12:02:30 INFO - 'LOGNAME': 'cltbld', 12:02:30 INFO - 'MAIL': '/var/mail/cltbld', 12:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:30 INFO - 'MOZ_NO_REMOTE': '1', 12:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:30 INFO - 'NO_EM_RESTART': '1', 12:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:30 INFO - 'PWD': '/builds/slave/test', 12:02:30 INFO - 'SHELL': '/bin/bash', 12:02:30 INFO - 'SHLVL': '1', 12:02:30 INFO - 'TERM': 'linux', 12:02:30 INFO - 'TMOUT': '86400', 12:02:30 INFO - 'USER': 'cltbld', 12:02:30 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 12:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:30 INFO - '_': '/tools/buildbot/bin/python'} 12:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:30 INFO - Downloading/unpacking jsonschema==2.5.1 12:02: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 12:02: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 12:02: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 12:02: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 12:02: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 12:02: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 12:02:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:02:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:32 INFO - Downloading functools32-3.2.3-2.tar.gz 12:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:02:32 INFO - warning: no files found matching '*.txt' 12:02:32 INFO - no previously-included directories found matching 'build' 12:02:32 INFO - no previously-included directories found matching 'dist' 12:02:32 INFO - no previously-included directories found matching '.git*' 12:02:32 INFO - Installing collected packages: jsonschema, functools32 12:02:32 INFO - Running setup.py install for functools32 12:02:32 INFO - warning: no files found matching '*.txt' 12:02:32 INFO - no previously-included directories found matching 'build' 12:02:32 INFO - no previously-included directories found matching 'dist' 12:02:32 INFO - no previously-included directories found matching '.git*' 12:02:32 INFO - Successfully installed jsonschema functools32 12:02:32 INFO - Cleaning up... 12:02:33 INFO - Return code: 0 12:02:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:33 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 0x1d361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1400>, '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 0x1fd23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:02:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:02:33 INFO - Using env: {'DISPLAY': ':0', 12:02:33 INFO - 'HOME': '/home/cltbld', 12:02:33 INFO - 'LANG': 'en_US.UTF-8', 12:02:33 INFO - 'LANGUAGE': 'en_US:en', 12:02:33 INFO - 'LOGNAME': 'cltbld', 12:02:33 INFO - 'MAIL': '/var/mail/cltbld', 12:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:33 INFO - 'MOZ_NO_REMOTE': '1', 12:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:33 INFO - 'NO_EM_RESTART': '1', 12:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:33 INFO - 'PWD': '/builds/slave/test', 12:02:33 INFO - 'SHELL': '/bin/bash', 12:02:33 INFO - 'SHLVL': '1', 12:02:33 INFO - 'TERM': 'linux', 12:02:33 INFO - 'TMOUT': '86400', 12:02:33 INFO - 'USER': 'cltbld', 12:02:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 12:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:33 INFO - '_': '/tools/buildbot/bin/python'} 12:02:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:02:33 INFO - Cleaning up... 12:02:33 INFO - Return code: 0 12:02:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:33 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 0x1d361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1400>, '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 0x1fd23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:02:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:02:33 INFO - Using env: {'DISPLAY': ':0', 12:02:33 INFO - 'HOME': '/home/cltbld', 12:02:33 INFO - 'LANG': 'en_US.UTF-8', 12:02:33 INFO - 'LANGUAGE': 'en_US:en', 12:02:33 INFO - 'LOGNAME': 'cltbld', 12:02:33 INFO - 'MAIL': '/var/mail/cltbld', 12:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:33 INFO - 'MOZ_NO_REMOTE': '1', 12:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:33 INFO - 'NO_EM_RESTART': '1', 12:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:33 INFO - 'PWD': '/builds/slave/test', 12:02:33 INFO - 'SHELL': '/bin/bash', 12:02:33 INFO - 'SHLVL': '1', 12:02:33 INFO - 'TERM': 'linux', 12:02:33 INFO - 'TMOUT': '86400', 12:02:33 INFO - 'USER': 'cltbld', 12:02:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 12:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:33 INFO - '_': '/tools/buildbot/bin/python'} 12:02:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:33 INFO - Downloading/unpacking blobuploader==1.2.4 12:02: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 12:02: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 12:02: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 12:02: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 12:02: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 12:02: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 12:02:35 INFO - Downloading blobuploader-1.2.4.tar.gz 12:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:02:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:02:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:36 INFO - Downloading docopt-0.6.1.tar.gz 12:02:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:02:36 INFO - Installing collected packages: blobuploader, requests, docopt 12:02:36 INFO - Running setup.py install for blobuploader 12:02:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:02:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:02:36 INFO - Running setup.py install for requests 12:02:36 INFO - Running setup.py install for docopt 12:02:36 INFO - Successfully installed blobuploader requests docopt 12:02:36 INFO - Cleaning up... 12:02:36 INFO - Return code: 0 12:02:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:36 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 0x1d361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1400>, '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 0x1fd23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:02:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:02:36 INFO - Using env: {'DISPLAY': ':0', 12:02:36 INFO - 'HOME': '/home/cltbld', 12:02:36 INFO - 'LANG': 'en_US.UTF-8', 12:02:36 INFO - 'LANGUAGE': 'en_US:en', 12:02:36 INFO - 'LOGNAME': 'cltbld', 12:02:36 INFO - 'MAIL': '/var/mail/cltbld', 12:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:36 INFO - 'MOZ_NO_REMOTE': '1', 12:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:36 INFO - 'NO_EM_RESTART': '1', 12:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:36 INFO - 'PWD': '/builds/slave/test', 12:02:36 INFO - 'SHELL': '/bin/bash', 12:02:36 INFO - 'SHLVL': '1', 12:02:36 INFO - 'TERM': 'linux', 12:02:36 INFO - 'TMOUT': '86400', 12:02:36 INFO - 'USER': 'cltbld', 12:02:36 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 12:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:36 INFO - '_': '/tools/buildbot/bin/python'} 12:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:02:37 INFO - Running setup.py (path:/tmp/pip-KHxTmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:02:37 INFO - Running setup.py (path:/tmp/pip-V9ODMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:02:37 INFO - Running setup.py (path:/tmp/pip-qX9W58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:02:37 INFO - Running setup.py (path:/tmp/pip-THYJNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:02:37 INFO - Running setup.py (path:/tmp/pip-FqYHX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:02:37 INFO - Running setup.py (path:/tmp/pip-HS0Ixq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:02:37 INFO - Running setup.py (path:/tmp/pip-f3QM0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:02:37 INFO - Running setup.py (path:/tmp/pip-WVKDS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:02:37 INFO - Running setup.py (path:/tmp/pip-O3NmIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:02:37 INFO - Running setup.py (path:/tmp/pip-cNmzGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:02:37 INFO - Running setup.py (path:/tmp/pip-xfgxrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:02:37 INFO - Running setup.py (path:/tmp/pip-T6xqkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:02:37 INFO - Running setup.py (path:/tmp/pip-ZqTcq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:02:38 INFO - Running setup.py (path:/tmp/pip-MXdDwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:02:38 INFO - Running setup.py (path:/tmp/pip-rGzped-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:02:38 INFO - Running setup.py (path:/tmp/pip-Bow_Vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:02:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:02:38 INFO - Running setup.py (path:/tmp/pip-CNj7qQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:02:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:02:38 INFO - Running setup.py install for manifestparser 12:02:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:02:38 INFO - Running setup.py install for mozcrash 12:02:38 INFO - Running setup.py install for mozdebug 12:02:38 INFO - Running setup.py install for mozdevice 12:02:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:02:38 INFO - Running setup.py install for mozfile 12:02:38 INFO - Running setup.py install for mozhttpd 12:02:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:02:38 INFO - Running setup.py install for mozinfo 12:02:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:02:39 INFO - Running setup.py install for mozInstall 12:02:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:02:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:02:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:02:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:02:39 INFO - Running setup.py install for mozleak 12:02:39 INFO - Running setup.py install for mozlog 12:02:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:02:39 INFO - Running setup.py install for moznetwork 12:02:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:02:39 INFO - Running setup.py install for mozprocess 12:02:39 INFO - Running setup.py install for mozprofile 12:02:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:02:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:02:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:02:39 INFO - Running setup.py install for mozrunner 12:02:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:02:39 INFO - Running setup.py install for mozscreenshot 12:02:39 INFO - Running setup.py install for moztest 12:02:39 INFO - Running setup.py install for mozversion 12:02:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:02:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:02:40 INFO - Cleaning up... 12:02:40 INFO - Return code: 0 12:02:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:40 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 0x1d361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1400>, '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 0x1fd23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:02:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:02:40 INFO - Using env: {'DISPLAY': ':0', 12:02:40 INFO - 'HOME': '/home/cltbld', 12:02:40 INFO - 'LANG': 'en_US.UTF-8', 12:02:40 INFO - 'LANGUAGE': 'en_US:en', 12:02:40 INFO - 'LOGNAME': 'cltbld', 12:02:40 INFO - 'MAIL': '/var/mail/cltbld', 12:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:40 INFO - 'MOZ_NO_REMOTE': '1', 12:02:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:40 INFO - 'NO_EM_RESTART': '1', 12:02:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:40 INFO - 'PWD': '/builds/slave/test', 12:02:40 INFO - 'SHELL': '/bin/bash', 12:02:40 INFO - 'SHLVL': '1', 12:02:40 INFO - 'TERM': 'linux', 12:02:40 INFO - 'TMOUT': '86400', 12:02:40 INFO - 'USER': 'cltbld', 12:02:40 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 12:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:40 INFO - '_': '/tools/buildbot/bin/python'} 12:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:02:40 INFO - Running setup.py (path:/tmp/pip-MvNQyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:02:40 INFO - Running setup.py (path:/tmp/pip-eM9ZIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:02:40 INFO - Running setup.py (path:/tmp/pip-L0Rxse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:02:40 INFO - Running setup.py (path:/tmp/pip-GQLNRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:02:40 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)) 12:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:02:40 INFO - Running setup.py (path:/tmp/pip-4f0i64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:02:40 INFO - Running setup.py (path:/tmp/pip-UsyKzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:02:40 INFO - Running setup.py (path:/tmp/pip-GhRUt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:02:40 INFO - Running setup.py (path:/tmp/pip-lzMKQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:02:40 INFO - Running setup.py (path:/tmp/pip-0ZwhUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:02:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:02:40 INFO - Running setup.py (path:/tmp/pip-djPpAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:02:41 INFO - Running setup.py (path:/tmp/pip-H3nlNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:02:41 INFO - Running setup.py (path:/tmp/pip-ejQtDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:02:41 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)) 12:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:02:41 INFO - Running setup.py (path:/tmp/pip-hTMMyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:02:41 INFO - Running setup.py (path:/tmp/pip-ue42WD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:02:41 INFO - Running setup.py (path:/tmp/pip-0qiotJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:02:41 INFO - Running setup.py (path:/tmp/pip-kLhzuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:02:41 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)) 12:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:02:41 INFO - Running setup.py (path:/tmp/pip-d3swu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:02:41 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)) 12:02:41 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)) 12:02:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:43 INFO - Downloading blessings-1.6.tar.gz 12:02:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:02:43 INFO - Installing collected packages: blessings 12:02:43 INFO - Running setup.py install for blessings 12:02:43 INFO - Successfully installed blessings 12:02:43 INFO - Cleaning up... 12:02:43 INFO - Return code: 0 12:02:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:02:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:02:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:02:44 INFO - Reading from file tmpfile_stdout 12:02:44 INFO - Current package versions: 12:02:44 INFO - argparse == 1.2.1 12:02:44 INFO - blessings == 1.6 12:02:44 INFO - blobuploader == 1.2.4 12:02:44 INFO - docopt == 0.6.1 12:02:44 INFO - functools32 == 3.2.3-2 12:02:44 INFO - jsonschema == 2.5.1 12:02:44 INFO - manifestparser == 1.1 12:02:44 INFO - mozInstall == 1.12 12:02:44 INFO - mozcrash == 1.0 12:02:44 INFO - mozdebug == 0.1 12:02:44 INFO - mozdevice == 0.49 12:02:44 INFO - mozfile == 1.2 12:02:44 INFO - mozhttpd == 0.7 12:02:44 INFO - mozinfo == 0.9 12:02:44 INFO - mozleak == 0.1 12:02:44 INFO - mozlog == 3.4 12:02:44 INFO - moznetwork == 0.27 12:02:44 INFO - mozprocess == 0.25 12:02:44 INFO - mozprofile == 0.28 12:02:44 INFO - mozrunner == 6.13 12:02:44 INFO - mozscreenshot == 0.1 12:02:44 INFO - mozsystemmonitor == 0.3 12:02:44 INFO - moztest == 0.8 12:02:44 INFO - mozversion == 1.4 12:02:44 INFO - psutil == 3.1.1 12:02:44 INFO - requests == 1.2.3 12:02:44 INFO - wsgiref == 0.1.2 12:02:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:44 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 0x1d361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1400>, '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 0x1fd23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:02:44 INFO - Using env: {'DISPLAY': ':0', 12:02:44 INFO - 'HOME': '/home/cltbld', 12:02:44 INFO - 'LANG': 'en_US.UTF-8', 12:02:44 INFO - 'LANGUAGE': 'en_US:en', 12:02:44 INFO - 'LOGNAME': 'cltbld', 12:02:44 INFO - 'MAIL': '/var/mail/cltbld', 12:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:44 INFO - 'MOZ_NO_REMOTE': '1', 12:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:44 INFO - 'NO_EM_RESTART': '1', 12:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:44 INFO - 'PWD': '/builds/slave/test', 12:02:44 INFO - 'SHELL': '/bin/bash', 12:02:44 INFO - 'SHLVL': '1', 12:02:44 INFO - 'TERM': 'linux', 12:02:44 INFO - 'TMOUT': '86400', 12:02:44 INFO - 'USER': 'cltbld', 12:02:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 12:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:44 INFO - '_': '/tools/buildbot/bin/python'} 12:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:02:44 INFO - Cleaning up... 12:02:44 INFO - Return code: 0 12:02:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:44 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 0x1d361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d73a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1400>, '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 0x1fd23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2840>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:02:44 INFO - Using env: {'DISPLAY': ':0', 12:02:44 INFO - 'HOME': '/home/cltbld', 12:02:44 INFO - 'LANG': 'en_US.UTF-8', 12:02:44 INFO - 'LANGUAGE': 'en_US:en', 12:02:44 INFO - 'LOGNAME': 'cltbld', 12:02:44 INFO - 'MAIL': '/var/mail/cltbld', 12:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:44 INFO - 'MOZ_NO_REMOTE': '1', 12:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:02:44 INFO - 'NO_EM_RESTART': '1', 12:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:44 INFO - 'PWD': '/builds/slave/test', 12:02:44 INFO - 'SHELL': '/bin/bash', 12:02:44 INFO - 'SHLVL': '1', 12:02:44 INFO - 'TERM': 'linux', 12:02:44 INFO - 'TMOUT': '86400', 12:02:44 INFO - 'USER': 'cltbld', 12:02:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 12:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:44 INFO - '_': '/tools/buildbot/bin/python'} 12:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:02:44 INFO - Cleaning up... 12:02:44 INFO - Return code: 0 12:02:44 INFO - Running post-action listener: _resource_record_post_action 12:02:44 INFO - Running post-action listener: _start_resource_monitoring 12:02:44 INFO - Starting resource monitoring. 12:02:44 INFO - [mozharness: 2017-04-04 19:02:44.529858Z] Finished create-virtualenv step (success) 12:02:44 INFO - [mozharness: 2017-04-04 19:02:44.530331Z] Running install step. 12:02:44 INFO - Running pre-action listener: _resource_record_pre_action 12:02:44 INFO - Running main action method: install 12:02:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:02:44 INFO - Reading from file tmpfile_stdout 12:02:44 INFO - Detecting whether we're running mozinstall >=1.0... 12:02:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:02:44 INFO - Reading from file tmpfile_stdout 12:02:44 INFO - Output received: 12:02:44 INFO - Usage: mozinstall [options] installer 12:02:44 INFO - Options: 12:02:44 INFO - -h, --help show this help message and exit 12:02:44 INFO - -d DEST, --destination=DEST 12:02:44 INFO - Directory to install application into. [default: 12:02:44 INFO - "/builds/slave/test"] 12:02:44 INFO - --app=APP Application being installed. [default: firefox] 12:02:44 INFO - mkdir: /builds/slave/test/build/application 12:02:44 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'] 12:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:02:59 INFO - Reading from file tmpfile_stdout 12:02:59 INFO - Output received: 12:02:59 INFO - /builds/slave/test/build/application/firefox/firefox 12:02:59 INFO - Running post-action listener: _resource_record_post_action 12:02:59 INFO - [mozharness: 2017-04-04 19:02:59.914562Z] Finished install step (success) 12:02:59 INFO - [mozharness: 2017-04-04 19:02:59.914838Z] Running run-tests step. 12:02:59 INFO - Running pre-action listener: _resource_record_pre_action 12:02:59 INFO - Running main action method: run_tests 12:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:02:59 INFO - Python 2.7.3 12:02:59 INFO - Return code: 0 12:02:59 INFO - grabbing minidump binary from tooltool 12:02: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')]} 12:02: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 0x1fd1400>, '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 0x1fd23b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd2840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:02: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 12:02: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 12:02: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 12:02:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:02:59 INFO - Return code: 0 12:02:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:02:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:02:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:02:59 INFO - ENV: RUST_BACKTRACE is now 1 12:02:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:02:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:02:59 INFO - Using env: {'DISPLAY': ':0', 12:02:59 INFO - 'HOME': '/home/cltbld', 12:02:59 INFO - 'LANG': 'en_US.UTF-8', 12:02:59 INFO - 'LANGUAGE': 'en_US:en', 12:02:59 INFO - 'LOGNAME': 'cltbld', 12:02:59 INFO - 'MAIL': '/var/mail/cltbld', 12:02:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:02:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:59 INFO - 'MOZ_NO_REMOTE': '1', 12:02:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:00 INFO - 'NO_EM_RESTART': '1', 12:03:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:00 INFO - 'PWD': '/builds/slave/test', 12:03:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:03:00 INFO - 'RUST_BACKTRACE': '1', 12:03:00 INFO - 'SHELL': '/bin/bash', 12:03:00 INFO - 'SHLVL': '1', 12:03:00 INFO - 'TERM': 'linux', 12:03:00 INFO - 'TMOUT': '86400', 12:03:00 INFO - 'USER': 'cltbld', 12:03:00 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879', 12:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:00 INFO - '_': '/tools/buildbot/bin/python'} 12:03:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:03:00 INFO - mozversion application_buildid: 20170404182520 12:03:00 INFO - mozversion application_changeset: b043233ec04f06768d59dcdfb9e928142280f3cc 12:03:00 INFO - mozversion application_display_name: Nightly 12:03:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:03:00 INFO - mozversion application_name: Firefox 12:03:00 INFO - mozversion application_remotingname: firefox 12:03:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:03:00 INFO - mozversion application_vendor: Mozilla 12:03:00 INFO - mozversion application_version: 55.0a1 12:03:00 INFO - mozversion platform_buildid: 20170404182520 12:03:00 INFO - mozversion platform_changeset: b043233ec04f06768d59dcdfb9e928142280f3cc 12:03:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:03:00 INFO - mozversion platform_version: 55.0a1 12:03:00 INFO - using testdate: 1491332580 12:03:00 INFO - actual date: 1491332580 12:03:00 INFO - starting webserver on 'localhost:51742' 12:03:00 INFO - SUITE-START | Running 2 tests 12:03:00 INFO - TEST-START | dromaeo_css 12:03:00 INFO - operating with platform_type : linux_ 12:03:00 INFO - Initialising browser for dromaeo_css test... 12:03:00 INFO - TEST-INFO | started process 2538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLxeLmB/profile http://localhost:51742/getInfo.html) 12:03:04 INFO - PID 2538 | __metrics Screen width/height:1600/1200 12:03:04 INFO - PID 2538 | colorDepth:24 12:03:04 INFO - PID 2538 | Browser inner width/height: 1024/697 12:03:04 INFO - PID 2538 | __metrics 12:03:05 INFO - PID 2538 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:03:05 INFO - PID 2538 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:03:06 INFO - TEST-INFO | 2538: exit 0 12:03:06 INFO - Browser initialized. 12:03:06 INFO - Running cycle 1/1 for dromaeo_css test... 12:03:06 INFO - TEST-INFO | started process 2637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLxeLmB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:03:18 INFO - PID 2637 | RSS: Main: 169832448 12:03:18 INFO - PID 2637 | 12:06:25 INFO - PID 2637 | Cycle 1(1): loaded http://localhost:51742/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51742/tests/dromaeo/cssquery-ext.html) 12:06:26 INFO - PID 2637 | RSS: Main: 319021056 12:06:26 INFO - PID 2637 | 12:08:08 INFO - PID 2637 | ************************* 12:08:08 INFO - PID 2637 | A coding exception was thrown and uncaught in a Task. 12:08:08 INFO - PID 2637 | 12:08:08 ERROR - PID 2637 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:08:08 INFO - PID 2637 | Full stack: 12:08:08 INFO - PID 2637 | ************************* 12:08:08 INFO - PID 2637 | ************************* 12:08:08 INFO - PID 2637 | A coding exception was thrown and uncaught in a Task. 12:08:08 INFO - PID 2637 | 12:08:08 ERROR - PID 2637 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:08:08 INFO - PID 2637 | Full stack: 12:08:08 INFO - PID 2637 | ************************* 12:08:08 INFO - PID 2637 | ************************* 12:08:08 INFO - PID 2637 | A coding exception was thrown and uncaught in a Task. 12:08:08 INFO - PID 2637 | 12:08:08 ERROR - PID 2637 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:08:08 INFO - PID 2637 | Full stack: 12:08:08 INFO - PID 2637 | ************************* 12:08:08 INFO - PID 2637 | ************************* 12:08:08 INFO - PID 2637 | A coding exception was thrown and uncaught in a Task. 12:08:08 INFO - PID 2637 | 12:08:08 ERROR - PID 2637 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:08:08 INFO - PID 2637 | Full stack: 12:08:08 INFO - PID 2637 | ************************* 12:09:29 INFO - PID 2637 | Cycle 1(1): loaded http://localhost:51742/tests/dromaeo/cssquery-ext.html (next: http://localhost:51742/tests/dromaeo/cssquery-jquery.html) 12:09:29 INFO - PID 2637 | RSS: Main: 262934528 12:09:29 INFO - PID 2637 | 12:12:31 INFO - PID 2637 | Cycle 1(1): loaded http://localhost:51742/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51742/tests/dromaeo/cssquery-mootools.html) 12:12:32 INFO - PID 2637 | RSS: Main: 202706944 12:12:32 INFO - PID 2637 | 12:15:34 INFO - PID 2637 | Cycle 1(1): loaded http://localhost:51742/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51742/tests/dromaeo/cssquery-prototype.html) 12:15:35 INFO - PID 2637 | RSS: Main: 239185920 12:15:35 INFO - PID 2637 | 12:18:38 INFO - PID 2637 | Cycle 1(1): loaded http://localhost:51742/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51742/tests/dromaeo/cssquery-yui.html) 12:18:39 INFO - PID 2637 | RSS: Main: 213962752 12:18:39 INFO - PID 2637 | 12:21:42 INFO - PID 2637 | Cycle 1(1): loaded http://localhost:51742/tests/dromaeo/cssquery-yui.html (next: http://localhost:51742/tests/dromaeo/cssquery-dojo.html) 12:21:42 INFO - PID 2637 | RSS: Main: 300445696 12:21:42 INFO - PID 2637 | 12:21:42 INFO - PID 2637 | __start_tp_report 12:21:42 INFO - PID 2637 | _x_x_mozilla_page_load 12:21:42 INFO - PID 2637 | _x_x_mozilla_page_load_details 12:21:42 INFO - PID 2637 | |i|pagename|runs| 12:21:42 INFO - PID 2637 | |0;dojo.html;2683.141394753679;2703.1214855172075;2744.3413580740616;2747.038536512221;2748.4777892200473;4997.775100120494;5067.923981140281;5093.159628661267;5110.565601923831;5146.691198528086;5210.843674689756;5249.816256431026;5268.367795864501;5271.130263506517;5279.1817268323375;4575.725456472623;4580.221362368397;4649.790759415834;4672.509386514401;4698;4647.442306923174;4677.649176311773;4678.485366609671;4683.953160468386;4698.577128058474;555.3601585132405;4196.916061678749;4607.861764147081;4638;4647.3958385410015;4596.310553416981;4605.815767369301;4615.9076818463445;4622.121796858586;4664.416947881515;4548.158590660738;4572.314152877062;4573.542645735433;4582.358469814229;4620.006698559792;4999.700017998932;5007.173816320339;5074.3657042869645;5078.187490001619;5084.339035925343;5586.91619625706;5593.692346920918;5606;5625.296837895263;5664.376918538957;5601.663900166003;5605.047141985831;5605.887882242373;5615.606907516475;5615.9157612635845;5118.8976220476125;5178.870528236749;5199.142141546602;5199.423831520419;5250.842474725764;5708.4862362387585;5767.480926716532;5772.480476757112;5776.1624564437925;5799.18811366409;5317.361916570037;5344.652597581145;5352.357717073976;5362.812301569426;5398.730063496888;5511.311086114236;5609.887802243932;5629.634073785191;5656.971715141398;5661.122526008476;5490.862728431821;5518.696471694096;5522.088855338824;5530.253415788898;5532.28080349552;5411.053065713563;5495.010898038311;5497.367802702661;5502.147167189092;5510.256115424447;4589.655775816827;4602.217623004098;4644.0247548015295;4656.371389862393;4664.953350466452;3956.2680904032845;3972.1459886124044;3973.205358928226;3999.0202400411504;4013.3779264214095;4687.882802929886;4691.859244222679;4694.36626055485;4694.976525117352;4729.266963620645;5392.218128371364;5490.066688662857;5535.944640553624;5575.414581468968;5583.776648934078;4701.694389864648;4714.528547145258;4723.5984941279685;4725.527447255247;4728.5507876752345;4884.169691152512;4890.706557606555;4895.8041678332465;4899.04468628614;4939.5554400104165;5168.095583272837;5174.068667639711;5204.089284375219;5223.634345595772;5272.6309158358545;5487.42382049895;5568.359638641446;5576;5581.553475721851;5584.664920104644;5191.29917461153;5210.348706411699;5235.083860324352;5272.499112584298;5276.736163191748;5415.404305526467;5417.51242388187;5419.701916394636;5463.836084917459;5503.972480137573;5486.177073439016;5487.945120548743;5539.473749993744;5540.750666219949;5547;5284.867878303073;5357.8392648220615;5360.356757189163;5390.27231323782;5408.026555220098;5430.51125398716;5433.402325744244;5441.918371224356;5460.508554229979;5490.286262785812;5343.7862485500145;5361.27622770921;5364.38309594386;5387.191921211693;5438.75525601341;5399.568034557305;5411.269478620493;5421.512063914267;5470.781168753205;5492.038893193595;5165.251038599457;5179.171332586768;5183.792648294177;5220.530152286161;5226.137687281556 12:21:42 INFO - PID 2637 | |1;ext.html;652.5203975078317;719.6761457344196;740.7444431671073;1066.4028144239232;1079.2607064161045;27687.584686229722;34193.14517137073;35019.1245218869;35119;35133.648663513355;37304.25391492168;37432.25135497288;37729.622703772955;37754.244915101684;37765.81117094417;5601.943980560183;7271.490995630321;7439.59082250476;7441.962790186041;7445.069366329209;5706.400827913071;7132.429405647562;7291.708331666727;7300.744473943413;7302.81742956425;7403.629818509053;7451.664675089634;7455.664495097733;7456.925430745704;7459.104907411118;7357.448191385667;7427.888581671279;7433.888491672629;7435.256474352575;7437.256274372519;7205.135383753931;7262.891056634155;7263.60050197239;7266.927330726678;7267.273272672691;33753.49369759455;34010.48984265238;34028.48957265643;34168.14579635504;34214.82892585546;2975.5685425613383;3002.2644452109153;3003.6245469316336;3010.548417737335;3011.5181570948544;24997.50004999908;25051.498970020497;25101.748982510122;25131.87434062836;25178.622320665203;3035.3474003089223;3074.108508532523;3076.9076927692204;3093.7060979207163;3121.250899784058;145239;145479;146240.26879865638;146647;147112;43168.56831431646;43213;43275;43284.56715432868;43288;45559.77220113944;45782;45801.77099114483;45802.312965305544;45937.540624593996;12342.876571234352;12344.75310493785;12440.875591244152;12441.813372799234;12444.128910976326;8037.678492860337;8219.383546234056;9860.30977831545;9917.65288214909;9920.652777152765;12313.322767247888;12431.875681243253;12554.623361299176;12630.431630576646;12634.305113218861;5023.2214006829;5092.872678183075;5108.948910510921;5115.820946266863;5116.411612664517;870.3776799588325;900.4957223954607;900.9099090090939;913.4793167894369;932.9067093290616;19793;20647.793522064887;20745.481362966046;20815.687764683542;21064;959.6737109382703;969.3747532841278;971.4948226922103;983.4345251480285;988.8269552828226;10228.437435940947;10547;10912.23614347004;11003.504842282116;11110.16673749456;217370;217441.56396090225;218087;218441;218575.2137179404;41410.37884431736;41500.584994150275;41516.58483415127;41522.37716434256;41560.58439415628;1202.8857258560422;1253.0289026004918;1263.3304348695206;1264.2035517623838;1265.025930033887;18930.242790288234;19202.192599975086;19343.709844352066;20388.388348349574;20795.896020519802;31137.221569460944;31160.22099447532;31190;31191.68808311888;31199;218017;219958;221202;221371;222334;23385.181518646765;28755;29170.416591668472;29422.26444338823;29441.411171776017;27296;27535.86232068907;27651.170464886087;30786.69213307838;33829.985100447026;25333.619995700446;25671;25916.35209119787;26277.73722262753;26533.204003879913;25274.620880687173;25566.488670226863;26190.73809261883;26574.468510629293;26578;27691.44617107687;27765.167044988684;27806.721932780412;28106.2973425666;28496.715032850236;24922;24940.37649058788;25306.493870122125;25432;25792.613110802977;19312.517187070436;20529.79470205279;20663.8966805165;20698.379048628565;20716.792832071485 12:21:42 INFO - PID 2637 | |2;jquery.html;406.7173314546391;408.18566958916966;432.2975165356296;433.35862922874145;440.9250427427337;18577.071146442675;18796.906015469922;19388.90305548472;19589.020548972567;19668.114934827932;16830.83169168308;16919.407820726276;16975.15124243789;16986.83013169868;17475.126243687795;5673.489385955263;5758.280214973118;5826.514238869083;5872.618279811799;5875.118732190184;5560.666360018412;5732.283464566929;5836.241288632472;5839.824805255849;5842.152887831262;5755.827325180251;5766.9711651441685;5767.279090113736;5797.826065218051;5804.767809287623;5690.516306113986;5710.971445142748;5729.713514324267;5764.164196191549;5778.0466223073145;5237.607179461517;5239.214117882349;5241.0828105081455;5243.030039442715;5244;22550;22678.659820102712;23302;23586.76413235863;23643.408914777097;1594.7607858821154;1636.8363163683655;1637.4596383193518;1639.8114216865094;1640.1717132847955;14122.293885305693;14208.644783880382;14394.784078238834;14529.200893950829;14736.189509576969;1999.5001249687577;2024.5242368043498;2096.1720120552295;2098.95802083959;2103.5897999890026;69429;90102.54948725214;93756;94423;95507.52246238793;11248.381339026431;11316.076267034623;11379.260348077349;11650.825237621442;11692.415379231004;16264.51206463808;16272.43046493367;16295.59261018484;16307.510774676779;16424.75362869558;7388.704451821867;7574.772756817304;7725.381969442431;7786.883196752054;7792.883106753403;6806.693698783567;6811.182658081062;6839.555428897106;6978.930210697929;6997.545159564612;7088.468364872655;7160.606166660779;7167.856642867114;7267.655483735526;7339.669714862844;1933;1939.7478327817294;1953.5506833428392;1980.692493245353;2096.992117583113;860.1699360117517;866.7616405488541;892.5403417240127;893.7497500699815;899.8920129584492;16661.25024373906;16815.831841681673;17290.308387664605;17378.913105434644;17670.469885903443;881.6341218394423;892.9910700892908;900.1718419054486;907.609727817045;919.4483310013939;9113.635454581876;9742.171915387129;10797.619047619048;12141.964508872781;12143.696407589881;510176;511677;518544;518675;519390;96321;96529;99236;101190.4940475293;101947.99999999852;1098.2092893116942;1151.8445009923553;1176.5470293936726;1180.816973369129;1183.7632473505162;17780.644387111926;17918.372856950467;18240.726389103907;18619.876785325258;18671.253149873854;42435.26941917474;44334.33498497461;44370.33444498399;44548.77725611351;46554;52978.470215297355;53507.80734550272;53910.19134713061;54401.72799135979;59672;7970.760877173694;7991.120976692676;8382.49705017701;8410.285125764134;8445.87331190045;12423.31671758062;12666.873331266937;12670.239785612892;12674.176178548734;12888.548900788428;10789.56841726322;10957.178211634;11012.559497620005;11427.085833133495;11456.255343402652;9868.457234851865;9963.25275604318;10015.248856335658;10119.59521619127;10164.136048435967;10296.279260451696;10347.379157250589;10675.519601618102;10686.25196236256;10793.892061079603;8125;8158.959205203936;8187.426880118334;8338.04112527067;8343.874841877498;10579.94710026445;10769.730756731144;11122.110231181648;11191.72020699489;11281.661550153509 12:21:42 INFO - PID 2637 | |3;mootools.html;1253.3419954523874;1317.8089177069326;1337.832770903637;1338.0633556510445;1350.5610676530127;9466.621335146594;9900.059494348025;9904.306698531087;9920.503974801268;9929.304948653587;9807.31348805584;10166.898331016688;10204;10220.48897555121;10232.43721595312;2214;2271.136967952176;2272.2728726807427;2272.943176420586;2276.635738281875;1907.7233801098832;1986.6026794641057;2171.2617709978604;2246.73039235292;2254.391314345126;2217.6008318502663;2296.781805728453;2305.7348404933396;2307.469282065126;2307.7576854430213;2155.3749412670463;2206.4042708468705;2218.5673793610254;2222.577710235066;2279.4529312964933;2227.732672079345;2230.8549944253573;2233.8436309458343;2237.5524895021063;2239.8992045358;9590.280728945358;9640.95179524105;9643.807123857554;9696.563654635558;9698.272629552812;5215.243789650517;5270.130428479296;5373.892522149535;5377.7311134443125;5452.372977107604;3148.2601588626653;3258.071449636866;3410.4031794436123;3439.4324936385465;3487.3722729908604;972.7811242470458;1027.7379268286613;1056.6354607660344;1074.4359211413991;1114;13873.167609943335;14180.787288190686;14184.43262269508;14198.290085495684;14213.076150050214;4703.200455922433;4828.275758636162;5039.899202015939;5079.8984020319385;5114.693118412907;12018.098642601839;12069.215500992583;12105;12126.029122864778;12140.089493288038;5504.174373843955;5507.642003269855;5520.861978450571;5564.443555644484;5565.471280228372;4817.662763606584;4859.3682821233015;4947.925781113287;5001.024800163933;5019.949800501949;4085.241929180011;4122.2786012447705;4165.91668166641;4169.061961058737;4244.893877653021;1115.8673945944872;1233.3278363292027;1257.2833484913695;1259.0619988108735;1278.0606254403006;592.5111782779138;681.6148875885109;691.7267679266662;711.3242419701304;732.5604637217626;5028.7737051832755;5139.434662187156;5153.484651534816;5169.689818610896;5401.378841433207;835.8590523934786;836.8573777148259;839.9076101628938;842.1073661918387;849.8810166576684;3251.869925203013;3327.4842399428126;3347.7991320520846;3366.7643264971707;3440.2947395783804;12209.206401583868;12349.814752778715;12912.870871291167;12914.547990820463;12914.612561623166;12506.874931250572;12618.305993170281;12622.116451848282;12622.30577318238;12626.242425454502;8694.17405346491;9112.8633070504;9162.541872906462;9175.26597872182;9195.678151264674;5649.689267090185;5683.516901063456;5695.686737229492;5818.359980402237;5895.14520394549;11554.42227888619;11572.36352000648;11609.709757256136;11645.76708465809;11743.647690569296;11604.419779011185;11694.122940779305;11738.354390508604;11783.998360139483;11848.585299514476;8012.278894899487;8066.596670166351;8221.931148950598;8226.341892648454;8244.381671374791;9019.278457723236;9081.77295567616;9114.04302548223;9143.862842057508;9168.54157292146;7809.882851757342;7835.960820195863;7985.08171560278;8100.108988011432;8160.224778646019;7641.35048520882;7784.610769461618;7802.648880800264;7821.983142191479;7876.881846772418;6675.299093595297;6763.357481039294;6847.897281540881;6860.897086543606;6863.450923925974;4772.260299653559;4809.927851082307;4839.080574690797;4890.853274401774;5020.046191223656;4924.138275801649;4975.776090076028;5005.399352077774;5071.137906555969;5201.583873290203 12:21:42 INFO - PID 2637 | |4;prototype.html;370.96846768024716;394.5088364985592;396.2787726338065;396.8432469174674;402.861012950532;5163.380394352674;5341.679499230044;5363.436839131884;5420.5934554908345;5454.781808727651;5158.793648254065;5223.320968274129;5303.390110137336;5317.601179911503;5331.493508116722;4216.262154123032;4220.324748040314;4224.894377640553;4233.915321693565;4238.347044652588;4043.65628921542;4206.41110244566;4211.578842115795;4223.366495025755;4249.298865687158;4163.875083747493;4164.416981622575;4181.226473102471;4182.393552934838;4209.473815773028;4172.77049762263;4190.9999999999845;4192.323070771716;4198.202341555095;4216.873493795191;3793.3172029034763;3817.3892177251782;3828.5979972102805;3830.4062870255157;3832.061145019488;5041.243813427978;5136.691798492065;5159.22611608258;5161.354830646169;5203.297554830087;4974.403071631427;4987.600991920638;4994.750262486898;5023.246513023039;5026.723530205837;5566.554675625981;5717.599768016241;5722.227499287585;5723.427657234285;5724.570657200727;4254.829921771507;4279.422277992462;4295.742255464682;4321.200577893069;4322.113966636832;5986.55100867428;6000.429959153874;6008.669523176223;6013.128096426081;6030.96984515079;4286.207051695384;4412.889677758018;4427.955720442755;4429.579189976947;4432.911341773211;4486.327050942385;4486.327050942385;4513.255312873404;4513.307509683868;4536.478304994902;4953.2074868020945;4981.227909674007;4982.651214415028;4986.650934434628;4994.200927851526;5394.3796463406425;5673.375928647845;5680.857978550569;5688.658680479184;5695.686737229492;1457.1548501869102;1487.5388629524882;1512.1909778268573;1528.312259483237;1564.6635973265575;1081.1296905990753;1094.7536804218987;1111.6776134920945;1115.4701516779464;1122.4836575175348;4870.512948705101;4875.609951203966;4878.707277563287;4878.878028049327;4886.364772579542;5800.854978625568;5821.417858214229;5844.26946631671;5844.357120716718;5848.590598658138;4678.6491013174145;4876.756162191876;4887.682300650446;4896.485868983706;4897.363342765418;3066.861991210401;3078.291992841659;3084.352286019961;3085.6142982127235;3092.8144311341393;5469.753861076261;5509.228707980886;5516.531609396402;5519.834404967857;5523.6409633373705;5903.734331955073;6005.669688167192;6007.15899774032;6019.819405417757;6032.849178770478;5450.400455949763;5473.7263136843;5484.725763711798;5486.91769623456;5499.560035197254;5641.746121424628;5830.883382332415;5864.560157988082;5864.794732184524;5908.645481271137;5746.850629874126;5760.753306210665;5790.884182316414;5796.304443466811;5808.883822323445;5510.39881698786;5529.778808847762;5529.806456773994;5546.944530554642;5552.779887285611;4013.2174226026814;4064.532578753481;4088.671181865965;4094.6314831665295;4134.586541345841;5575.4424557543925;5746.879358525048;5859.619124756877;5895.380984996514;5916.852078698067;5567.192757050124;5577.8047768327915;5588.608797384144;5598.496135347838;5669.9794037073725;5670.9432905672065;5677;5692.51613612831;5694.4590263924865;5695.971520142539;5403.351597808131;5567.220589117608;5596.888062238814;5623.831285061455;5629.634073785191;5711.971440142773;5736.139579063174;5742.961248756631;5751;5752.942470575241;5419.593530485151;5518.834434966958;5566;5567.944320556905;5593.860153496195 12:21:42 INFO - PID 2637 | |5;yui.html;752.2139364364242;761.900952876126;772.1467778105193;783.6003638144547;785.2814674572767;13723.58829235122;13868.514601988933;13884.097533660304;13997.16017038977;14011.299435028259;13196.208227506357;13334.332833583208;13537.323133843292;13564.389602467889;13588.592342229724;901.3285102598556;910.4127837544779;923.9122283383068;926.4302453990814;926.7127190570944;945.6831961292975;948.4546385828141;952.2239374909461;953.0517135450202;954.4225743425197;994.9253805964581;997.0179373317277;997.7306127345612;998.0219385002702;998.1565577087349;983.3313346924089;983.3313346924089;983.6163896080499;985.733851860001;986.1322036607775;725.1950335128004;725.7895210388981;726.0851327327553;726.2628432141381;726.3027493606145;11955;12115.091368147425;12360.690982725413;12525.373731313397;12716.682082947907;10798.676039718743;10884.183686223565;10952.507137178845;11251.887481125248;11441.599544016002;10695.251332406735;10741.785164296749;10802.405867677275;10877.184211184192;10885.455727213608;2809.6768871579825;2910.854457277149;2915.1691767846064;2917.1102813641833;2931.8680659370166;61587.692061539405;62844.371556284306;63070;63752.68123659352;64174;10189.796204076025;10212.234082443847;10331.535080921376;10386.688399348031;10544.789104217873;20515.692264616042;20545.280915168198;20557.280495182596;20564;20572.58854822925;6541.411272985454;6623.602583844985;6801.877690181064;6839.93160068393;6870.038194652752;3441.397755392796;3454.5870510180675;3480.216951185963;3484.3553942520716;3563.982180089135;3493.5982362028185;3504.9123771905906;3538.3807833629526;3545.6099829018785;3580.03339098442;701.6526819224516;707.5224223649017;712.6401167410424;716.5485743981259;716.5521549031855;551.1457241276006;558.1766893831566;566.2921348314607;573.6529399713113;588.1060787602905;8001.359891208689;8699.173578510032;8968.23769979559;9066;9135.680251191176;610.1793088296234;612.7089632424563;615.4676205082661;632.181325183888;636.8726254749068;3721.404575267944;3737.8878633641034;3832.984259171322;3921.8235179416993;3944.9211015780097;62029.68985155045;63433.36566634367;64102.67948660227;65804.34195657982;66969.33030669729;56756;58208.7089564558;58323;58943.70528147332;59478.70260648669;50332.245016324785;51860.48139518557;52290.47709522856;52839.73580132152;53580.46419535833;7403.777886663409;7678.308952194329;7784.2215778421705;7797.454178207471;7852.921470785219;27461.45077098487;27579.72420275852;27831.30421739473;28053.298667533476;28459.43081138407;33235.83382083074;33454.4981825268;33741.49387759136;34107.488387674704;35199.47200792041;9970.860821953307;10031.749206269902;10145.64490242838;10294.227932905213;10390.532426040998;9734.659286924923;9799.657012004545;9911.10800028001;9962.651307204213;10290.228232882415;10479.214058945458;10611.522481488197;10794.622188223375;10999.285046471954;11187.272827266203;9362.625494980124;9552.23582113443;9598.616055357708;10092.444915529717;10126.79746405053;10250.436226007641;10315.48422578853;10587.629432969808;10664.573417063231;10831.187660925305;7711.845763084595;7751.907183725357;7862.567558784093;8055;8158.673653054048;7864.331531819631;8047.195280471906;8178.9591052046735;8308.210719981593;8483.74548763538 12:21:42 INFO - PID 2637 | __end_tp_report 12:21:42 INFO - PID 2637 | __start_cc_report 12:21:42 INFO - PID 2637 | _x_x_mozilla_cycle_collect,1451 12:21:42 INFO - PID 2637 | __end_cc_report 12:21:42 INFO - PID 2637 | __startTimestamp1491333702671__endTimestamp 12:21:42 INFO - PID 2637 | 12:21:42 INFO - PID 2637 | ------- Summary: start ------- 12:21:42 INFO - PID 2637 | Number of tests: 6 12:21:42 INFO - PID 2637 | 12:21:42 INFO - PID 2637 | [#0] dojo.html Cycles:165 Average:5052.98 Median:5250.84 stddev:687.24 (13.1%) stddev-sans-first:663.73 12:21:42 INFO - PID 2637 | Values: 2683.1 2703.1 2744.3 2747.0 2748.5 4997.8 5067.9 5093.2 5110.6 5146.7 5210.8 5249.8 5268.4 5271.1 5279.2 4575.7 4580.2 4649.8 4672.5 4698.0 4647.4 4677.6 4678.5 4684.0 4698.6 555.4 4196.9 4607.9 4638.0 4647.4 4596.3 4605.8 4615.9 4622.1 4664.4 4548.2 4572.3 4573.5 4582.4 4620.0 4999.7 5007.2 5074.4 5078.2 5084.3 5586.9 5593.7 5606.0 5625.3 5664.4 5601.7 5605.0 5605.9 5615.6 5615.9 5118.9 5178.9 5199.1 5199.4 5250.8 5708.5 5767.5 5772.5 5776.2 5799.2 5317.4 5344.7 5352.4 5362.8 5398.7 5511.3 5609.9 5629.6 5657.0 5661.1 5490.9 5518.7 5522.1 5530.3 5532.3 5411.1 5495.0 5497.4 5502.1 5510.3 4589.7 4602.2 4644.0 4656.4 4665.0 3956.3 3972.1 3973.2 3999.0 4013.4 4687.9 4691.9 4694.4 4695.0 4729.3 5392.2 5490.1 5535.9 5575.4 5583.8 4701.7 4714.5 4723.6 4725.5 4728.6 4884.2 4890.7 4895.8 4899.0 4939.6 5168.1 5174.1 5204.1 5223.6 5272.6 5487.4 5568.4 5576.0 5581.6 5584.7 5191.3 5210.3 5235.1 5272.5 5276.7 5415.4 5417.5 5419.7 5463.8 5504.0 5486.2 5487.9 5539.5 5540.8 5547.0 5284.9 5357.8 5360.4 5390.3 5408.0 5430.5 5433.4 5441.9 5460.5 5490.3 5343.8 5361.3 5364.4 5387.2 5438.8 5399.6 5411.3 5421.5 5470.8 5492.0 5165.3 5179.2 5183.8 5220.5 5226.1 12:21:42 INFO - PID 2637 | 12:21:42 INFO - PID 2637 | [#1] ext.html Cycles:180 Average:33225.02 Median:3023.43 stddev:51586.01 (1706.2%) stddev-sans-first:51672.75 12:21:42 INFO - PID 2637 | Values: 652.5 719.7 740.7 1066.4 1079.3 27687.6 34193.1 35019.1 35119.0 35133.6 37304.3 37432.3 37729.6 37754.2 37765.8 5601.9 7271.5 7439.6 7442.0 7445.1 5706.4 7132.4 7291.7 7300.7 7302.8 7403.6 7451.7 7455.7 7456.9 7459.1 7357.4 7427.9 7433.9 7435.3 7437.3 7205.1 7262.9 7263.6 7266.9 7267.3 33753.5 34010.5 34028.5 34168.1 34214.8 2975.6 3002.3 3003.6 3010.5 3011.5 24997.5 25051.5 25101.7 25131.9 25178.6 3035.3 3074.1 3076.9 3093.7 3121.3 145239.0 145479.0 146240.3 146647.0 147112.0 43168.6 43213.0 43275.0 43284.6 43288.0 45559.8 45782.0 45801.8 45802.3 45937.5 12342.9 12344.8 12440.9 12441.8 12444.1 8037.7 8219.4 9860.3 9917.7 9920.7 12313.3 12431.9 12554.6 12630.4 12634.3 5023.2 5092.9 5108.9 5115.8 5116.4 870.4 900.5 900.9 913.5 932.9 19793.0 20647.8 20745.5 20815.7 21064.0 959.7 969.4 971.5 983.4 988.8 10228.4 10547.0 10912.2 11003.5 11110.2 217370.0 217441.6 218087.0 218441.0 218575.2 41410.4 41500.6 41516.6 41522.4 41560.6 1202.9 1253.0 1263.3 1264.2 1265.0 18930.2 19202.2 19343.7 20388.4 20795.9 31137.2 31160.2 31190.0 31191.7 31199.0 218017.0 219958.0 221202.0 221371.0 222334.0 23385.2 28755.0 29170.4 29422.3 29441.4 27296.0 27535.9 27651.2 30786.7 33830.0 25333.6 25671.0 25916.4 26277.7 26533.2 25274.6 25566.5 26190.7 26574.5 26578.0 27691.4 27765.2 27806.7 28106.3 28496.7 24922.0 24940.4 25306.5 25432.0 25792.6 19312.5 20529.8 20663.9 20698.4 20716.8 12:21:42 INFO - PID 2637 | 12:21:42 INFO - PID 2637 | [#2] jquery.html Cycles:180 Average:30039.60 Median:21433.78 stddev:85198.61 (397.5%) stddev-sans-first:85408.56 12:21:42 INFO - PID 2637 | Values: 406.7 408.2 432.3 433.4 440.9 18577.1 18796.9 19388.9 19589.0 19668.1 16830.8 16919.4 16975.2 16986.8 17475.1 5673.5 5758.3 5826.5 5872.6 5875.1 5560.7 5732.3 5836.2 5839.8 5842.2 5755.8 5767.0 5767.3 5797.8 5804.8 5690.5 5711.0 5729.7 5764.2 5778.0 5237.6 5239.2 5241.1 5243.0 5244.0 22550.0 22678.7 23302.0 23586.8 23643.4 1594.8 1636.8 1637.5 1639.8 1640.2 14122.3 14208.6 14394.8 14529.2 14736.2 1999.5 2024.5 2096.2 2099.0 2103.6 69429.0 90102.5 93756.0 94423.0 95507.5 11248.4 11316.1 11379.3 11650.8 11692.4 16264.5 16272.4 16295.6 16307.5 16424.8 7388.7 7574.8 7725.4 7786.9 7792.9 6806.7 6811.2 6839.6 6978.9 6997.5 7088.5 7160.6 7167.9 7267.7 7339.7 1933.0 1939.7 1953.6 1980.7 2097.0 860.2 866.8 892.5 893.7 899.9 16661.3 16815.8 17290.3 17378.9 17670.5 881.6 893.0 900.2 907.6 919.4 9113.6 9742.2 10797.6 12142.0 12143.7 510176.0 511677.0 518544.0 518675.0 519390.0 96321.0 96529.0 99236.0 101190.5 101948.0 1098.2 1151.8 1176.5 1180.8 1183.8 17780.6 17918.4 18240.7 18619.9 18671.3 42435.3 44334.3 44370.3 44548.8 46554.0 52978.5 53507.8 53910.2 54401.7 59672.0 7970.8 7991.1 8382.5 8410.3 8445.9 12423.3 12666.9 12670.2 12674.2 12888.5 10789.6 10957.2 11012.6 11427.1 11456.3 9868.5 9963.3 10015.2 10119.6 10164.1 10296.3 10347.4 10675.5 10686.3 10793.9 8125.0 8159.0 8187.4 8338.0 8343.9 10579.9 10769.7 11122.1 11191.7 11281.7 12:21:42 INFO - PID 2637 | 12:21:42 INFO - PID 2637 | [#3] mootools.html Cycles:180 Average:6166.82 Median:4813.80 stddev:3920.45 (81.4%) stddev-sans-first:3914.06 12:21:42 INFO - PID 2637 | Values: 1253.3 1317.8 1337.8 1338.1 1350.6 9466.6 9900.1 9904.3 9920.5 9929.3 9807.3 10166.9 10204.0 10220.5 10232.4 2214.0 2271.1 2272.3 2272.9 2276.6 1907.7 1986.6 2171.3 2246.7 2254.4 2217.6 2296.8 2305.7 2307.5 2307.8 2155.4 2206.4 2218.6 2222.6 2279.5 2227.7 2230.9 2233.8 2237.6 2239.9 9590.3 9641.0 9643.8 9696.6 9698.3 5215.2 5270.1 5373.9 5377.7 5452.4 3148.3 3258.1 3410.4 3439.4 3487.4 972.8 1027.7 1056.6 1074.4 1114.0 13873.2 14180.8 14184.4 14198.3 14213.1 4703.2 4828.3 5039.9 5079.9 5114.7 12018.1 12069.2 12105.0 12126.0 12140.1 5504.2 5507.6 5520.9 5564.4 5565.5 4817.7 4859.4 4947.9 5001.0 5019.9 4085.2 4122.3 4165.9 4169.1 4244.9 1115.9 1233.3 1257.3 1259.1 1278.1 592.5 681.6 691.7 711.3 732.6 5028.8 5139.4 5153.5 5169.7 5401.4 835.9 836.9 839.9 842.1 849.9 3251.9 3327.5 3347.8 3366.8 3440.3 12209.2 12349.8 12912.9 12914.5 12914.6 12506.9 12618.3 12622.1 12622.3 12626.2 8694.2 9112.9 9162.5 9175.3 9195.7 5649.7 5683.5 5695.7 5818.4 5895.1 11554.4 11572.4 11609.7 11645.8 11743.6 11604.4 11694.1 11738.4 11784.0 11848.6 8012.3 8066.6 8221.9 8226.3 8244.4 9019.3 9081.8 9114.0 9143.9 9168.5 7809.9 7836.0 7985.1 8100.1 8160.2 7641.4 7784.6 7802.6 7822.0 7876.9 6675.3 6763.4 6847.9 6860.9 6863.5 4772.3 4809.9 4839.1 4890.9 5020.0 4924.1 4975.8 5005.4 5071.1 5201.6 12:21:42 INFO - PID 2637 | 12:21:42 INFO - PID 2637 | [#4] prototype.html Cycles:180 Average:4739.87 Median:5183.34 stddev:1340.59 (25.9%) stddev-sans-first:1303.63 12:21:42 INFO - PID 2637 | Values: 371.0 394.5 396.3 396.8 402.9 5163.4 5341.7 5363.4 5420.6 5454.8 5158.8 5223.3 5303.4 5317.6 5331.5 4216.3 4220.3 4224.9 4233.9 4238.3 4043.7 4206.4 4211.6 4223.4 4249.3 4163.9 4164.4 4181.2 4182.4 4209.5 4172.8 4191.0 4192.3 4198.2 4216.9 3793.3 3817.4 3828.6 3830.4 3832.1 5041.2 5136.7 5159.2 5161.4 5203.3 4974.4 4987.6 4994.8 5023.2 5026.7 5566.6 5717.6 5722.2 5723.4 5724.6 4254.8 4279.4 4295.7 4321.2 4322.1 5986.6 6000.4 6008.7 6013.1 6031.0 4286.2 4412.9 4428.0 4429.6 4432.9 4486.3 4486.3 4513.3 4513.3 4536.5 4953.2 4981.2 4982.7 4986.7 4994.2 5394.4 5673.4 5680.9 5688.7 5695.7 1457.2 1487.5 1512.2 1528.3 1564.7 1081.1 1094.8 1111.7 1115.5 1122.5 4870.5 4875.6 4878.7 4878.9 4886.4 5800.9 5821.4 5844.3 5844.4 5848.6 4678.6 4876.8 4887.7 4896.5 4897.4 3066.9 3078.3 3084.4 3085.6 3092.8 5469.8 5509.2 5516.5 5519.8 5523.6 5903.7 6005.7 6007.2 6019.8 6032.8 5450.4 5473.7 5484.7 5486.9 5499.6 5641.7 5830.9 5864.6 5864.8 5908.6 5746.9 5760.8 5790.9 5796.3 5808.9 5510.4 5529.8 5529.8 5546.9 5552.8 4013.2 4064.5 4088.7 4094.6 4134.6 5575.4 5746.9 5859.6 5895.4 5916.9 5567.2 5577.8 5588.6 5598.5 5670.0 5670.9 5677.0 5692.5 5694.5 5696.0 5403.4 5567.2 5596.9 5623.8 5629.6 5712.0 5736.1 5743.0 5751.0 5752.9 5419.6 5518.8 5566.0 5567.9 5593.9 12:21:42 INFO - PID 2637 | 12:21:42 INFO - PID 2637 | [#5] yui.html Cycles:180 Average:13994.85 Median:28664.83 stddev:17791.90 (62.1%) stddev-sans-first:17814.02 12:21:42 INFO - PID 2637 | Values: 752.2 761.9 772.1 783.6 785.3 13723.6 13868.5 13884.1 13997.2 14011.3 13196.2 13334.3 13537.3 13564.4 13588.6 901.3 910.4 923.9 926.4 926.7 945.7 948.5 952.2 953.1 954.4 994.9 997.0 997.7 998.0 998.2 983.3 983.3 983.6 985.7 986.1 725.2 725.8 726.1 726.3 726.3 11955.0 12115.1 12360.7 12525.4 12716.7 10798.7 10884.2 10952.5 11251.9 11441.6 10695.3 10741.8 10802.4 10877.2 10885.5 2809.7 2910.9 2915.2 2917.1 2931.9 61587.7 62844.4 63070.0 63752.7 64174.0 10189.8 10212.2 10331.5 10386.7 10544.8 20515.7 20545.3 20557.3 20564.0 20572.6 6541.4 6623.6 6801.9 6839.9 6870.0 3441.4 3454.6 3480.2 3484.4 3564.0 3493.6 3504.9 3538.4 3545.6 3580.0 701.7 707.5 712.6 716.5 716.6 551.1 558.2 566.3 573.7 588.1 8001.4 8699.2 8968.2 9066.0 9135.7 610.2 612.7 615.5 632.2 636.9 3721.4 3737.9 3833.0 3921.8 3944.9 62029.7 63433.4 64102.7 65804.3 66969.3 56756.0 58208.7 58323.0 58943.7 59478.7 50332.2 51860.5 52290.5 52839.7 53580.5 7403.8 7678.3 7784.2 7797.5 7852.9 27461.5 27579.7 27831.3 28053.3 28459.4 33235.8 33454.5 33741.5 34107.5 35199.5 9970.9 10031.7 10145.6 10294.2 10390.5 9734.7 9799.7 9911.1 9962.7 10290.2 10479.2 10611.5 10794.6 10999.3 11187.3 9362.6 9552.2 9598.6 10092.4 10126.8 10250.4 10315.5 10587.6 10664.6 10831.2 7711.8 7751.9 7862.6 8055.0 8158.7 7864.3 8047.2 8179.0 8308.2 8483.7 12:21:42 INFO - PID 2637 | -------- Summary: end -------- 12:21:42 INFO - PID 2637 | 12:21:43 INFO - TEST-INFO | 2637: exit 0 12:21:43 INFO - TEST-OK | dromaeo_css | took 1123417ms 12:21:43 INFO - TEST-START | kraken 12:21:43 INFO - operating with platform_type : linux_ 12:21:43 INFO - Initialising browser for kraken test... 12:21:43 INFO - TEST-INFO | started process 3082 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWtDmq4/profile http://localhost:51742/getInfo.html) 12:21:47 INFO - PID 3082 | __metrics Screen width/height:1600/1200 12:21:47 INFO - PID 3082 | colorDepth:24 12:21:47 INFO - PID 3082 | Browser inner width/height: 1024/697 12:21:47 INFO - PID 3082 | __metrics 12:21:48 INFO - PID 3082 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:21:48 INFO - PID 3082 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:21:49 INFO - TEST-INFO | 3082: exit 0 12:21:49 INFO - Browser initialized. 12:21:49 INFO - Running cycle 1/1 for kraken test... 12:21:49 INFO - TEST-INFO | started process 3180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWtDmq4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:22:02 INFO - PID 3180 | RSS: Main: 169959424 12:22:02 INFO - PID 3180 | 12:22:04 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51742/tests/kraken/driver.html?testName=audio-beat-detection) 12:22:05 INFO - PID 3180 | RSS: Main: 231112704 12:22:05 INFO - PID 3180 | 12:22:08 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51742/tests/kraken/driver.html?testName=audio-dft) 12:22:09 INFO - PID 3180 | RSS: Main: 209342464 12:22:09 INFO - PID 3180 | 12:22:12 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51742/tests/kraken/driver.html?testName=audio-fft) 12:22:12 INFO - PID 3180 | RSS: Main: 294739968 12:22:12 INFO - PID 3180 | 12:22:15 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51742/tests/kraken/driver.html?testName=audio-oscillator) 12:22:15 INFO - PID 3180 | RSS: Main: 206012416 12:22:15 INFO - PID 3180 | 12:22:17 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51742/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:22:18 INFO - PID 3180 | RSS: Main: 210567168 12:22:18 INFO - PID 3180 | 12:22:21 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51742/tests/kraken/driver.html?testName=imaging-darkroom) 12:22:22 INFO - PID 3180 | RSS: Main: 249614336 12:22:22 INFO - PID 3180 | 12:22:26 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51742/tests/kraken/driver.html?testName=imaging-desaturate) 12:22:26 INFO - PID 3180 | RSS: Main: 242384896 12:22:26 INFO - PID 3180 | 12:22:29 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51742/tests/kraken/driver.html?testName=json-parse-financial) 12:22:30 INFO - PID 3180 | RSS: Main: 246550528 12:22:30 INFO - PID 3180 | 12:22:31 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51742/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:22:32 INFO - PID 3180 | RSS: Main: 209711104 12:22:32 INFO - PID 3180 | 12:22:34 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51742/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:22:34 INFO - PID 3180 | RSS: Main: 217243648 12:22:34 INFO - PID 3180 | 12:22:37 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51742/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:22:37 INFO - PID 3180 | RSS: Main: 224579584 12:22:37 INFO - PID 3180 | 12:22:40 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:22:41 INFO - PID 3180 | RSS: Main: 232763392 12:22:41 INFO - PID 3180 | 12:22:44 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:22:45 INFO - PID 3180 | RSS: Main: 230510592 12:22:45 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51742/tests/kraken/driver.html?testName=ai-astar) 12:22:47 INFO - PID 3180 | RSS: Main: 297775104 12:22:47 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | __start_tp_report 12:22:47 INFO - PID 3180 | _x_x_mozilla_page_load 12:22:47 INFO - PID 3180 | _x_x_mozilla_page_load_details 12:22:47 INFO - PID 3180 | |i|pagename|runs| 12:22:47 INFO - PID 3180 | |0;ai-astar;106;112;112;112;112;110;111;111;112;111 12:22:47 INFO - PID 3180 | |1;audio-beat-detection;152;128;126;175;130;125;122;128;157;125 12:22:47 INFO - PID 3180 | |2;audio-dft;165;165;166;166;165;164;164;164;166;167 12:22:47 INFO - PID 3180 | |3;audio-fft;75;75;76;110;76;76;76;77;100;75 12:22:47 INFO - PID 3180 | |4;audio-oscillator;83;85;106;84;84;83;99;85;84;114 12:22:47 INFO - PID 3180 | |5;imaging-gaussian-blur;114;115;114;114;114;114;114;115;114;114 12:22:47 INFO - PID 3180 | |6;imaging-darkroom;151;151;155;150;149;150;150;150;150;151 12:22:47 INFO - PID 3180 | |7;imaging-desaturate;94;94;95;94;95;94;95;94;94;95 12:22:47 INFO - PID 3180 | |8;json-parse-financial;52;53;53;53;55;54;53;53;52;54 12:22:47 INFO - PID 3180 | |9;json-stringify-tinderbox;56;56;56;56;55;56;55;55;56;57 12:22:47 INFO - PID 3180 | |10;stanford-crypto-aes;82;82;82;83;84;83;84;86;88;88 12:22:47 INFO - PID 3180 | |11;stanford-crypto-ccm;137;146;131;134;132;138;149;142;180;142 12:22:47 INFO - PID 3180 | |12;stanford-crypto-pbkdf2;197;197;201;202;200;197;196;197;198;198 12:22:47 INFO - PID 3180 | |13;stanford-crypto-sha256-iterative;71;71;71;71;71;70;72;72;71;70 12:22:47 INFO - PID 3180 | __end_tp_report 12:22:47 INFO - PID 3180 | __start_cc_report 12:22:47 INFO - PID 3180 | _x_x_mozilla_cycle_collect,1967 12:22:47 INFO - PID 3180 | __end_cc_report 12:22:47 INFO - PID 3180 | __startTimestamp1491333767378__endTimestamp 12:22:47 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | ------- Summary: start ------- 12:22:47 INFO - PID 3180 | Number of tests: 14 12:22:47 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:1.85 (1.7%) stddev-sans-first:0.73 12:22:47 INFO - PID 3180 | Values: 106.0 112.0 112.0 112.0 112.0 110.0 111.0 111.0 112.0 111.0 12:22:47 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:129.00 stddev:17.99 (13.9%) stddev-sans-first:18.22 12:22:47 INFO - PID 3180 | Values: 152.0 128.0 126.0 175.0 130.0 125.0 122.0 128.0 157.0 125.0 12:22:47 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.50 stddev:1.03 (0.6%) stddev-sans-first:1.09 12:22:47 INFO - PID 3180 | Values: 165.0 165.0 166.0 166.0 165.0 164.0 164.0 164.0 166.0 167.0 12:22:47 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:12.57 (16.5%) stddev-sans-first:13.11 12:22:47 INFO - PID 3180 | Values: 75.0 75.0 76.0 110.0 76.0 76.0 76.0 77.0 100.0 75.0 12:22:47 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:84.00 stddev:11.37 (13.5%) stddev-sans-first:11.72 12:22:47 INFO - PID 3180 | Values: 83.0 85.0 106.0 84.0 84.0 83.0 99.0 85.0 84.0 114.0 12:22:47 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:22:47 INFO - PID 3180 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 114.0 115.0 114.0 114.0 12:22:47 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:150.50 stddev:1.64 (1.1%) stddev-sans-first:1.73 12:22:47 INFO - PID 3180 | Values: 151.0 151.0 155.0 150.0 149.0 150.0 150.0 150.0 150.0 151.0 12:22:47 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 12:22:47 INFO - PID 3180 | Values: 94.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 94.0 95.0 12:22:47 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:0.92 (1.7%) stddev-sans-first:0.87 12:22:47 INFO - PID 3180 | Values: 52.0 53.0 53.0 53.0 55.0 54.0 53.0 53.0 52.0 54.0 12:22:47 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 12:22:47 INFO - PID 3180 | Values: 56.0 56.0 56.0 56.0 55.0 56.0 55.0 55.0 56.0 57.0 12:22:47 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:2.35 (2.8%) stddev-sans-first:2.35 12:22:47 INFO - PID 3180 | Values: 82.0 82.0 82.0 83.0 84.0 83.0 84.0 86.0 88.0 88.0 12:22:47 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:142.00 stddev:14.23 (10.0%) stddev-sans-first:14.92 12:22:47 INFO - PID 3180 | Values: 137.0 146.0 131.0 134.0 132.0 138.0 149.0 142.0 180.0 142.0 12:22:47 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.30 Median:198.00 stddev:2.00 (1.0%) stddev-sans-first:2.07 12:22:47 INFO - PID 3180 | Values: 197.0 197.0 201.0 202.0 200.0 197.0 196.0 197.0 198.0 198.0 12:22:47 INFO - PID 3180 | 12:22:47 INFO - PID 3180 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:0.67 (0.9%) stddev-sans-first:0.71 12:22:47 INFO - PID 3180 | Values: 71.0 71.0 71.0 71.0 71.0 70.0 72.0 72.0 71.0 70.0 12:22:47 INFO - PID 3180 | -------- Summary: end -------- 12:22:47 INFO - PID 3180 | 12:22:48 INFO - TEST-INFO | 3180: exit 0 12:22:48 INFO - TEST-OK | kraken | took 65133ms 12:22:48 INFO - SUITE-END | took 1188s 12:22:49 INFO - Completed test suite (00:19:48) 12:22:49 INFO - javascript benchmark 12:22:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6628.873852831221, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2683.141394753679, 2703.1214855172075, 2744.3413580740616, 2747.038536512221, 2748.4777892200473, 4997.775100120494, 5067.923981140281, 5093.159628661267, 5110.565601923831, 5146.691198528086, 5210.843674689756, 5249.816256431026, 5268.367795864501, 5271.130263506517, 5279.1817268323375, 4575.725456472623, 4580.221362368397, 4649.790759415834, 4672.509386514401, 4698.0, 4647.442306923174, 4677.649176311773, 4678.485366609671, 4683.953160468386, 4698.577128058474, 555.3601585132405, 4196.916061678749, 4607.861764147081, 4638.0, 4647.3958385410015, 4596.310553416981, 4605.815767369301, 4615.9076818463445, 4622.121796858586, 4664.416947881515, 4548.158590660738, 4572.314152877062, 4573.542645735433, 4582.358469814229, 4620.006698559792, 4999.700017998932, 5007.173816320339, 5074.3657042869645, 5078.187490001619, 5084.339035925343, 5586.91619625706, 5593.692346920918, 5606.0, 5625.296837895263, 5664.376918538957, 5601.663900166003, 5605.047141985831, 5605.887882242373, 5615.606907516475, 5615.9157612635845, 5118.8976220476125, 5178.870528236749, 5199.142141546602, 5199.423831520419, 5250.842474725764, 5708.4862362387585, 5767.480926716532, 5772.480476757112, 5776.1624564437925, 5799.18811366409, 5317.361916570037, 5344.652597581145, 5352.357717073976, 5362.812301569426, 5398.730063496888, 5511.311086114236, 5609.887802243932, 5629.634073785191, 5656.971715141398, 5661.122526008476, 5490.862728431821, 5518.696471694096, 5522.088855338824, 5530.253415788898, 5532.28080349552, 5411.053065713563, 5495.010898038311, 5497.367802702661, 5502.147167189092, 5510.256115424447, 4589.655775816827, 4602.217623004098, 4644.0247548015295, 4656.371389862393, 4664.953350466452, 3956.2680904032845, 3972.1459886124044, 3973.205358928226, 3999.0202400411504, 4013.3779264214095, 4687.882802929886, 4691.859244222679, 4694.36626055485, 4694.976525117352, 4729.266963620645, 5392.218128371364, 5490.066688662857, 5535.944640553624, 5575.414581468968, 5583.776648934078, 4701.694389864648, 4714.528547145258, 4723.5984941279685, 4725.527447255247, 4728.5507876752345, 4884.169691152512, 4890.706557606555, 4895.8041678332465, 4899.04468628614, 4939.5554400104165, 5168.095583272837, 5174.068667639711, 5204.089284375219, 5223.634345595772, 5272.6309158358545, 5487.42382049895, 5568.359638641446, 5576.0, 5581.553475721851, 5584.664920104644, 5191.29917461153, 5210.348706411699, 5235.083860324352, 5272.499112584298, 5276.736163191748, 5415.404305526467, 5417.51242388187, 5419.701916394636, 5463.836084917459, 5503.972480137573, 5486.177073439016, 5487.945120548743, 5539.473749993744, 5540.750666219949, 5547.0, 5284.867878303073, 5357.8392648220615, 5360.356757189163, 5390.27231323782, 5408.026555220098, 5430.51125398716, 5433.402325744244, 5441.918371224356, 5460.508554229979, 5490.286262785812, 5343.7862485500145, 5361.27622770921, 5364.38309594386, 5387.191921211693, 5438.75525601341, 5399.568034557305, 5411.269478620493, 5421.512063914267, 5470.781168753205, 5492.038893193595, 5165.251038599457, 5179.171332586768, 5183.792648294177, 5220.530152286161, 5226.137687281556], "value": 5005.454560460447, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.5203975078317, 719.6761457344196, 740.7444431671073, 1066.4028144239232, 1079.2607064161045, 27687.584686229722, 34193.14517137073, 35019.1245218869, 35119.0, 35133.648663513355, 37304.25391492168, 37432.25135497288, 37729.622703772955, 37754.244915101684, 37765.81117094417, 5601.943980560183, 7271.490995630321, 7439.59082250476, 7441.962790186041, 7445.069366329209, 5706.400827913071, 7132.429405647562, 7291.708331666727, 7300.744473943413, 7302.81742956425, 7403.629818509053, 7451.664675089634, 7455.664495097733, 7456.925430745704, 7459.104907411118, 7357.448191385667, 7427.888581671279, 7433.888491672629, 7435.256474352575, 7437.256274372519, 7205.135383753931, 7262.891056634155, 7263.60050197239, 7266.927330726678, 7267.273272672691, 33753.49369759455, 34010.48984265238, 34028.48957265643, 34168.14579635504, 34214.82892585546, 2975.5685425613383, 3002.2644452109153, 3003.6245469316336, 3010.548417737335, 3011.5181570948544, 24997.50004999908, 25051.498970020497, 25101.748982510122, 25131.87434062836, 25178.622320665203, 3035.3474003089223, 3074.108508532523, 3076.9076927692204, 3093.7060979207163, 3121.250899784058, 145239.0, 145479.0, 146240.26879865638, 146647.0, 147112.0, 43168.56831431646, 43213.0, 43275.0, 43284.56715432868, 43288.0, 45559.77220113944, 45782.0, 45801.77099114483, 45802.312965305544, 45937.540624593996, 12342.876571234352, 12344.75310493785, 12440.875591244152, 12441.813372799234, 12444.128910976326, 8037.678492860337, 8219.383546234056, 9860.30977831545, 9917.65288214909, 9920.652777152765, 12313.322767247888, 12431.875681243253, 12554.623361299176, 12630.431630576646, 12634.305113218861, 5023.2214006829, 5092.872678183075, 5108.948910510921, 5115.820946266863, 5116.411612664517, 870.3776799588325, 900.4957223954607, 900.9099090090939, 913.4793167894369, 932.9067093290616, 19793.0, 20647.793522064887, 20745.481362966046, 20815.687764683542, 21064.0, 959.6737109382703, 969.3747532841278, 971.4948226922103, 983.4345251480285, 988.8269552828226, 10228.437435940947, 10547.0, 10912.23614347004, 11003.504842282116, 11110.16673749456, 217370.0, 217441.56396090225, 218087.0, 218441.0, 218575.2137179404, 41410.37884431736, 41500.584994150275, 41516.58483415127, 41522.37716434256, 41560.58439415628, 1202.8857258560422, 1253.0289026004918, 1263.3304348695206, 1264.2035517623838, 1265.025930033887, 18930.242790288234, 19202.192599975086, 19343.709844352066, 20388.388348349574, 20795.896020519802, 31137.221569460944, 31160.22099447532, 31190.0, 31191.68808311888, 31199.0, 218017.0, 219958.0, 221202.0, 221371.0, 222334.0, 23385.181518646765, 28755.0, 29170.416591668472, 29422.26444338823, 29441.411171776017, 27296.0, 27535.86232068907, 27651.170464886087, 30786.69213307838, 33829.985100447026, 25333.619995700446, 25671.0, 25916.35209119787, 26277.73722262753, 26533.204003879913, 25274.620880687173, 25566.488670226863, 26190.73809261883, 26574.468510629293, 26578.0, 27691.44617107687, 27765.167044988684, 27806.721932780412, 28106.2973425666, 28496.715032850236, 24922.0, 24940.37649058788, 25306.493870122125, 25432.0, 25792.613110802977, 19312.517187070436, 20529.79470205279, 20663.8966805165, 20698.379048628565, 20716.792832071485], "value": 14607.410660843614, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.7173314546391, 408.18566958916966, 432.2975165356296, 433.35862922874145, 440.9250427427337, 18577.071146442675, 18796.906015469922, 19388.90305548472, 19589.020548972567, 19668.114934827932, 16830.83169168308, 16919.407820726276, 16975.15124243789, 16986.83013169868, 17475.126243687795, 5673.489385955263, 5758.280214973118, 5826.514238869083, 5872.618279811799, 5875.118732190184, 5560.666360018412, 5732.283464566929, 5836.241288632472, 5839.824805255849, 5842.152887831262, 5755.827325180251, 5766.9711651441685, 5767.279090113736, 5797.826065218051, 5804.767809287623, 5690.516306113986, 5710.971445142748, 5729.713514324267, 5764.164196191549, 5778.0466223073145, 5237.607179461517, 5239.214117882349, 5241.0828105081455, 5243.030039442715, 5244.0, 22550.0, 22678.659820102712, 23302.0, 23586.76413235863, 23643.408914777097, 1594.7607858821154, 1636.8363163683655, 1637.4596383193518, 1639.8114216865094, 1640.1717132847955, 14122.293885305693, 14208.644783880382, 14394.784078238834, 14529.200893950829, 14736.189509576969, 1999.5001249687577, 2024.5242368043498, 2096.1720120552295, 2098.95802083959, 2103.5897999890026, 69429.0, 90102.54948725214, 93756.0, 94423.0, 95507.52246238793, 11248.381339026431, 11316.076267034623, 11379.260348077349, 11650.825237621442, 11692.415379231004, 16264.51206463808, 16272.43046493367, 16295.59261018484, 16307.510774676779, 16424.75362869558, 7388.704451821867, 7574.772756817304, 7725.381969442431, 7786.883196752054, 7792.883106753403, 6806.693698783567, 6811.182658081062, 6839.555428897106, 6978.930210697929, 6997.545159564612, 7088.468364872655, 7160.606166660779, 7167.856642867114, 7267.655483735526, 7339.669714862844, 1933.0, 1939.7478327817294, 1953.5506833428392, 1980.692493245353, 2096.992117583113, 860.1699360117517, 866.7616405488541, 892.5403417240127, 893.7497500699815, 899.8920129584492, 16661.25024373906, 16815.831841681673, 17290.308387664605, 17378.913105434644, 17670.469885903443, 881.6341218394423, 892.9910700892908, 900.1718419054486, 907.609727817045, 919.4483310013939, 9113.635454581876, 9742.171915387129, 10797.619047619048, 12141.964508872781, 12143.696407589881, 510176.0, 511677.0, 518544.0, 518675.0, 519390.0, 96321.0, 96529.0, 99236.0, 101190.4940475293, 101947.99999999852, 1098.2092893116942, 1151.8445009923553, 1176.5470293936726, 1180.816973369129, 1183.7632473505162, 17780.644387111926, 17918.372856950467, 18240.726389103907, 18619.876785325258, 18671.253149873854, 42435.26941917474, 44334.33498497461, 44370.33444498399, 44548.77725611351, 46554.0, 52978.470215297355, 53507.80734550272, 53910.19134713061, 54401.72799135979, 59672.0, 7970.760877173694, 7991.120976692676, 8382.49705017701, 8410.285125764134, 8445.87331190045, 12423.31671758062, 12666.873331266937, 12670.239785612892, 12674.176178548734, 12888.548900788428, 10789.56841726322, 10957.178211634, 11012.559497620005, 11427.085833133495, 11456.255343402652, 9868.457234851865, 9963.25275604318, 10015.248856335658, 10119.59521619127, 10164.136048435967, 10296.279260451696, 10347.379157250589, 10675.519601618102, 10686.25196236256, 10793.892061079603, 8125.0, 8158.959205203936, 8187.426880118334, 8338.04112527067, 8343.874841877498, 10579.94710026445, 10769.730756731144, 11122.110231181648, 11191.72020699489, 11281.661550153509], "value": 9195.53175933347, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.3419954523874, 1317.8089177069326, 1337.832770903637, 1338.0633556510445, 1350.5610676530127, 9466.621335146594, 9900.059494348025, 9904.306698531087, 9920.503974801268, 9929.304948653587, 9807.31348805584, 10166.898331016688, 10204.0, 10220.48897555121, 10232.43721595312, 2214.0, 2271.136967952176, 2272.2728726807427, 2272.943176420586, 2276.635738281875, 1907.7233801098832, 1986.6026794641057, 2171.2617709978604, 2246.73039235292, 2254.391314345126, 2217.6008318502663, 2296.781805728453, 2305.7348404933396, 2307.469282065126, 2307.7576854430213, 2155.3749412670463, 2206.4042708468705, 2218.5673793610254, 2222.577710235066, 2279.4529312964933, 2227.732672079345, 2230.8549944253573, 2233.8436309458343, 2237.5524895021063, 2239.8992045358, 9590.280728945358, 9640.95179524105, 9643.807123857554, 9696.563654635558, 9698.272629552812, 5215.243789650517, 5270.130428479296, 5373.892522149535, 5377.7311134443125, 5452.372977107604, 3148.2601588626653, 3258.071449636866, 3410.4031794436123, 3439.4324936385465, 3487.3722729908604, 972.7811242470458, 1027.7379268286613, 1056.6354607660344, 1074.4359211413991, 1114.0, 13873.167609943335, 14180.787288190686, 14184.43262269508, 14198.290085495684, 14213.076150050214, 4703.200455922433, 4828.275758636162, 5039.899202015939, 5079.8984020319385, 5114.693118412907, 12018.098642601839, 12069.215500992583, 12105.0, 12126.029122864778, 12140.089493288038, 5504.174373843955, 5507.642003269855, 5520.861978450571, 5564.443555644484, 5565.471280228372, 4817.662763606584, 4859.3682821233015, 4947.925781113287, 5001.024800163933, 5019.949800501949, 4085.241929180011, 4122.2786012447705, 4165.91668166641, 4169.061961058737, 4244.893877653021, 1115.8673945944872, 1233.3278363292027, 1257.2833484913695, 1259.0619988108735, 1278.0606254403006, 592.5111782779138, 681.6148875885109, 691.7267679266662, 711.3242419701304, 732.5604637217626, 5028.7737051832755, 5139.434662187156, 5153.484651534816, 5169.689818610896, 5401.378841433207, 835.8590523934786, 836.8573777148259, 839.9076101628938, 842.1073661918387, 849.8810166576684, 3251.869925203013, 3327.4842399428126, 3347.7991320520846, 3366.7643264971707, 3440.2947395783804, 12209.206401583868, 12349.814752778715, 12912.870871291167, 12914.547990820463, 12914.612561623166, 12506.874931250572, 12618.305993170281, 12622.116451848282, 12622.30577318238, 12626.242425454502, 8694.17405346491, 9112.8633070504, 9162.541872906462, 9175.26597872182, 9195.678151264674, 5649.689267090185, 5683.516901063456, 5695.686737229492, 5818.359980402237, 5895.14520394549, 11554.42227888619, 11572.36352000648, 11609.709757256136, 11645.76708465809, 11743.647690569296, 11604.419779011185, 11694.122940779305, 11738.354390508604, 11783.998360139483, 11848.585299514476, 8012.278894899487, 8066.596670166351, 8221.931148950598, 8226.341892648454, 8244.381671374791, 9019.278457723236, 9081.77295567616, 9114.04302548223, 9143.862842057508, 9168.54157292146, 7809.882851757342, 7835.960820195863, 7985.08171560278, 8100.108988011432, 8160.224778646019, 7641.35048520882, 7784.610769461618, 7802.648880800264, 7821.983142191479, 7876.881846772418, 6675.299093595297, 6763.357481039294, 6847.897281540881, 6860.897086543606, 6863.450923925974, 4772.260299653559, 4809.927851082307, 4839.080574690797, 4890.853274401774, 5020.046191223656, 4924.138275801649, 4975.776090076028, 5005.399352077774, 5071.137906555969, 5201.583873290203], "value": 4677.417448842616, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.96846768024716, 394.5088364985592, 396.2787726338065, 396.8432469174674, 402.861012950532, 5163.380394352674, 5341.679499230044, 5363.436839131884, 5420.5934554908345, 5454.781808727651, 5158.793648254065, 5223.320968274129, 5303.390110137336, 5317.601179911503, 5331.493508116722, 4216.262154123032, 4220.324748040314, 4224.894377640553, 4233.915321693565, 4238.347044652588, 4043.65628921542, 4206.41110244566, 4211.578842115795, 4223.366495025755, 4249.298865687158, 4163.875083747493, 4164.416981622575, 4181.226473102471, 4182.393552934838, 4209.473815773028, 4172.77049762263, 4190.9999999999845, 4192.323070771716, 4198.202341555095, 4216.873493795191, 3793.3172029034763, 3817.3892177251782, 3828.5979972102805, 3830.4062870255157, 3832.061145019488, 5041.243813427978, 5136.691798492065, 5159.22611608258, 5161.354830646169, 5203.297554830087, 4974.403071631427, 4987.600991920638, 4994.750262486898, 5023.246513023039, 5026.723530205837, 5566.554675625981, 5717.599768016241, 5722.227499287585, 5723.427657234285, 5724.570657200727, 4254.829921771507, 4279.422277992462, 4295.742255464682, 4321.200577893069, 4322.113966636832, 5986.55100867428, 6000.429959153874, 6008.669523176223, 6013.128096426081, 6030.96984515079, 4286.207051695384, 4412.889677758018, 4427.955720442755, 4429.579189976947, 4432.911341773211, 4486.327050942385, 4486.327050942385, 4513.255312873404, 4513.307509683868, 4536.478304994902, 4953.2074868020945, 4981.227909674007, 4982.651214415028, 4986.650934434628, 4994.200927851526, 5394.3796463406425, 5673.375928647845, 5680.857978550569, 5688.658680479184, 5695.686737229492, 1457.1548501869102, 1487.5388629524882, 1512.1909778268573, 1528.312259483237, 1564.6635973265575, 1081.1296905990753, 1094.7536804218987, 1111.6776134920945, 1115.4701516779464, 1122.4836575175348, 4870.512948705101, 4875.609951203966, 4878.707277563287, 4878.878028049327, 4886.364772579542, 5800.854978625568, 5821.417858214229, 5844.26946631671, 5844.357120716718, 5848.590598658138, 4678.6491013174145, 4876.756162191876, 4887.682300650446, 4896.485868983706, 4897.363342765418, 3066.861991210401, 3078.291992841659, 3084.352286019961, 3085.6142982127235, 3092.8144311341393, 5469.753861076261, 5509.228707980886, 5516.531609396402, 5519.834404967857, 5523.6409633373705, 5903.734331955073, 6005.669688167192, 6007.15899774032, 6019.819405417757, 6032.849178770478, 5450.400455949763, 5473.7263136843, 5484.725763711798, 5486.91769623456, 5499.560035197254, 5641.746121424628, 5830.883382332415, 5864.560157988082, 5864.794732184524, 5908.645481271137, 5746.850629874126, 5760.753306210665, 5790.884182316414, 5796.304443466811, 5808.883822323445, 5510.39881698786, 5529.778808847762, 5529.806456773994, 5546.944530554642, 5552.779887285611, 4013.2174226026814, 4064.532578753481, 4088.671181865965, 4094.6314831665295, 4134.586541345841, 5575.4424557543925, 5746.879358525048, 5859.619124756877, 5895.380984996514, 5916.852078698067, 5567.192757050124, 5577.8047768327915, 5588.608797384144, 5598.496135347838, 5669.9794037073725, 5670.9432905672065, 5677.0, 5692.51613612831, 5694.4590263924865, 5695.971520142539, 5403.351597808131, 5567.220589117608, 5596.888062238814, 5623.831285061455, 5629.634073785191, 5711.971440142773, 5736.139579063174, 5742.961248756631, 5751.0, 5752.942470575241, 5419.593530485151, 5518.834434966958, 5566.0, 5567.944320556905, 5593.860153496195], "value": 4337.942106352225, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.2139364364242, 761.900952876126, 772.1467778105193, 783.6003638144547, 785.2814674572767, 13723.58829235122, 13868.514601988933, 13884.097533660304, 13997.16017038977, 14011.299435028259, 13196.208227506357, 13334.332833583208, 13537.323133843292, 13564.389602467889, 13588.592342229724, 901.3285102598556, 910.4127837544779, 923.9122283383068, 926.4302453990814, 926.7127190570944, 945.6831961292975, 948.4546385828141, 952.2239374909461, 953.0517135450202, 954.4225743425197, 994.9253805964581, 997.0179373317277, 997.7306127345612, 998.0219385002702, 998.1565577087349, 983.3313346924089, 983.3313346924089, 983.6163896080499, 985.733851860001, 986.1322036607775, 725.1950335128004, 725.7895210388981, 726.0851327327553, 726.2628432141381, 726.3027493606145, 11955.0, 12115.091368147425, 12360.690982725413, 12525.373731313397, 12716.682082947907, 10798.676039718743, 10884.183686223565, 10952.507137178845, 11251.887481125248, 11441.599544016002, 10695.251332406735, 10741.785164296749, 10802.405867677275, 10877.184211184192, 10885.455727213608, 2809.6768871579825, 2910.854457277149, 2915.1691767846064, 2917.1102813641833, 2931.8680659370166, 61587.692061539405, 62844.371556284306, 63070.0, 63752.68123659352, 64174.0, 10189.796204076025, 10212.234082443847, 10331.535080921376, 10386.688399348031, 10544.789104217873, 20515.692264616042, 20545.280915168198, 20557.280495182596, 20564.0, 20572.58854822925, 6541.411272985454, 6623.602583844985, 6801.877690181064, 6839.93160068393, 6870.038194652752, 3441.397755392796, 3454.5870510180675, 3480.216951185963, 3484.3553942520716, 3563.982180089135, 3493.5982362028185, 3504.9123771905906, 3538.3807833629526, 3545.6099829018785, 3580.03339098442, 701.6526819224516, 707.5224223649017, 712.6401167410424, 716.5485743981259, 716.5521549031855, 551.1457241276006, 558.1766893831566, 566.2921348314607, 573.6529399713113, 588.1060787602905, 8001.359891208689, 8699.173578510032, 8968.23769979559, 9066.0, 9135.680251191176, 610.1793088296234, 612.7089632424563, 615.4676205082661, 632.181325183888, 636.8726254749068, 3721.404575267944, 3737.8878633641034, 3832.984259171322, 3921.8235179416993, 3944.9211015780097, 62029.68985155045, 63433.36566634367, 64102.67948660227, 65804.34195657982, 66969.33030669729, 56756.0, 58208.7089564558, 58323.0, 58943.70528147332, 59478.70260648669, 50332.245016324785, 51860.48139518557, 52290.47709522856, 52839.73580132152, 53580.46419535833, 7403.777886663409, 7678.308952194329, 7784.2215778421705, 7797.454178207471, 7852.921470785219, 27461.45077098487, 27579.72420275852, 27831.30421739473, 28053.298667533476, 28459.43081138407, 33235.83382083074, 33454.4981825268, 33741.49387759136, 34107.488387674704, 35199.47200792041, 9970.860821953307, 10031.749206269902, 10145.64490242838, 10294.227932905213, 10390.532426040998, 9734.659286924923, 9799.657012004545, 9911.10800028001, 9962.651307204213, 10290.228232882415, 10479.214058945458, 10611.522481488197, 10794.622188223375, 10999.285046471954, 11187.272827266203, 9362.625494980124, 9552.23582113443, 9598.616055357708, 10092.444915529717, 10126.79746405053, 10250.436226007641, 10315.48422578853, 10587.629432969808, 10664.573417063231, 10831.187660925305, 7711.845763084595, 7751.907183725357, 7862.567558784093, 8055.0, 8158.673653054048, 7864.331531819631, 8047.195280471906, 8178.9591052046735, 8308.210719981593, 8483.74548763538], "value": 6219.015141390819, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 112.0, 112.0, 112.0, 110.0, 111.0, 111.0, 112.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 128.0, 126.0, 175.0, 130.0, 125.0, 122.0, 128.0, 157.0, 125.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 166.0, 166.0, 165.0, 164.0, 164.0, 164.0, 166.0, 167.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 110.0, 76.0, 76.0, 76.0, 77.0, 100.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 106.0, 84.0, 84.0, 83.0, 99.0, 85.0, 84.0, 114.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 155.0, 150.0, 149.0, 150.0, 150.0, 150.0, 150.0, 151.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 53.0, 55.0, 54.0, 53.0, 53.0, 52.0, 54.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 55.0, 56.0, 55.0, 55.0, 56.0, 57.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 83.0, 84.0, 83.0, 84.0, 86.0, 88.0, 88.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 146.0, 131.0, 134.0, 132.0, 138.0, 149.0, 142.0, 180.0, 142.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 197.0, 201.0, 202.0, 200.0, 197.0, 196.0, 197.0, 198.0, 198.0], "value": 198.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 71.0, 71.0, 71.0, 70.0, 72.0, 72.0, 71.0, 70.0], "value": 71.0, "unit": "score"}]}]} 12:22:49 INFO - Return code: 0 12:22:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:22:49 ERROR - # TBPL SUCCESS # 12:22:49 INFO - Running post-action listener: _resource_record_post_action 12:22:49 INFO - [mozharness: 2017-04-04 19:22:49.158817Z] Finished run-tests step (success) 12:22:49 INFO - Running post-run listener: _resource_record_post_run 12:22:49 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 359215104; Read time: 20; Write time: 216644 12:22:49 INFO - TinderboxPrint: CPU usage
13.0% 12:22:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 12:22:49 INFO - TinderboxPrint: I/O write bytes / time
359,215,104 / 216,644 12:22:49 INFO - TinderboxPrint: CPU idle
8,358.2 (87.0%) 12:22:49 INFO - TinderboxPrint: CPU user
1,204.8 (12.5%) 12:22:49 INFO - TinderboxPrint: Swap in / out
0 / 0 12:22:49 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 102236160; Read time: 0; Write time: 62868 12:22:49 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 256978944; Read time: 0; Write time: 153776 12:22:49 INFO - Running post-run listener: _upload_blobber_files 12:22:49 INFO - Blob upload gear active. 12:22:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:22:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:22:49 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:22:49 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:22:50 INFO - (blobuploader) - INFO - Open directory for files ... 12:22:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:22:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:22:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:22:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:22:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:22:51 INFO - (blobuploader) - INFO - Done attempting. 12:22:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:22:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:22:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:22:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:22:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:22:51 INFO - (blobuploader) - INFO - Done attempting. 12:22:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:22:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:22:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:22:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:22:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:22:55 INFO - (blobuploader) - INFO - Done attempting. 12:22:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:22:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:22:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:22:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:22:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:22:56 INFO - (blobuploader) - INFO - Done attempting. 12:22:56 INFO - (blobuploader) - INFO - Iteration through files over. 12:22:56 INFO - Return code: 0 12:22:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:22:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:22:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96bfc5769096d3c4b2f6c3f712c98eff210b12d9c43e74c6c996c8e981d0be9c4fa11edd7cfc4a80b047ee36d61e00b059beef27608c9ca411d3e01621b46637", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/767638d9a4b3ba59a37664bead73bc291b1c64da9e20fabead99ed0a753bb44b628c5511465b3c16d9200c61c9da7038301573d610d3da0e8e90926e97491740", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51fb984ace3a04383a88624774a4951f22ffbb9c2054372d151b3a42c042bafdeb3a4aeb8ad4f7b770cf10dafb30c6d83d0f33dd88fc751d2ac6792949411de7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e383b5cbfd28fbf9e235f170570522f35943200cd7d5474b05924f2bf0e440da096aeedf6030cf7fcbfe72c6741b25f800b729f256539c35e5f3c98a403fcb57"} 12:22:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:22:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:22:56 INFO - Contents: 12:22:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96bfc5769096d3c4b2f6c3f712c98eff210b12d9c43e74c6c996c8e981d0be9c4fa11edd7cfc4a80b047ee36d61e00b059beef27608c9ca411d3e01621b46637", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/767638d9a4b3ba59a37664bead73bc291b1c64da9e20fabead99ed0a753bb44b628c5511465b3c16d9200c61c9da7038301573d610d3da0e8e90926e97491740", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51fb984ace3a04383a88624774a4951f22ffbb9c2054372d151b3a42c042bafdeb3a4aeb8ad4f7b770cf10dafb30c6d83d0f33dd88fc751d2ac6792949411de7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e383b5cbfd28fbf9e235f170570522f35943200cd7d5474b05924f2bf0e440da096aeedf6030cf7fcbfe72c6741b25f800b729f256539c35e5f3c98a403fcb57"} 12:22:56 INFO - Running post-run listener: copy_logs_to_upload_dir 12:22:56 INFO - Copying logs to upload dir... 12:22:56 INFO - mkdir: /builds/slave/test/build/upload/logs 12:22:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.387029 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-04-04 12:22:55.837893) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 12:22:55.841411) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96bfc5769096d3c4b2f6c3f712c98eff210b12d9c43e74c6c996c8e981d0be9c4fa11edd7cfc4a80b047ee36d61e00b059beef27608c9ca411d3e01621b46637", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/767638d9a4b3ba59a37664bead73bc291b1c64da9e20fabead99ed0a753bb44b628c5511465b3c16d9200c61c9da7038301573d610d3da0e8e90926e97491740", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51fb984ace3a04383a88624774a4951f22ffbb9c2054372d151b3a42c042bafdeb3a4aeb8ad4f7b770cf10dafb30c6d83d0f33dd88fc751d2ac6792949411de7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e383b5cbfd28fbf9e235f170570522f35943200cd7d5474b05924f2bf0e440da096aeedf6030cf7fcbfe72c6741b25f800b729f256539c35e5f3c98a403fcb57"} build_url:https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/JMkrglegRteWlaQZDMjn8A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96bfc5769096d3c4b2f6c3f712c98eff210b12d9c43e74c6c996c8e981d0be9c4fa11edd7cfc4a80b047ee36d61e00b059beef27608c9ca411d3e01621b46637", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/767638d9a4b3ba59a37664bead73bc291b1c64da9e20fabead99ed0a753bb44b628c5511465b3c16d9200c61c9da7038301573d610d3da0e8e90926e97491740", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51fb984ace3a04383a88624774a4951f22ffbb9c2054372d151b3a42c042bafdeb3a4aeb8ad4f7b770cf10dafb30c6d83d0f33dd88fc751d2ac6792949411de7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e383b5cbfd28fbf9e235f170570522f35943200cd7d5474b05924f2bf0e440da096aeedf6030cf7fcbfe72c6741b25f800b729f256539c35e5f3c98a403fcb57"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 12:22:55.870527) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 12:22:55.870851) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1491332348.397843-345078879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 12:22:55.952081) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 12:22:55.952429) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 12:22:55.952765) ========= ========= Total master_lag: 0.18 =========