builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-076 starttime: 1493846583.37 results: success (0) revision: b25ad0674afd563e888dc07981baa626e8d794db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 14:23:03.370838) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 14:23:03.371263) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 14:23:03.371534) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 14:23:03.386172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 14:23:03.386447) ========= 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=9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-03 14:23:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 109M=0s 2017-05-03 14:23:03 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093256 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 14:23:03.493951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 14:23:03.494267) ========= 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=9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017169 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 14:23:03.547938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 14:23:03.550282) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b25ad0674afd563e888dc07981baa626e8d794db --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 b25ad0674afd563e888dc07981baa626e8d794db --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=9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-03 14:23:04,052 truncating revision to first 12 chars 2017-05-03 14:23:04,052 Setting DEBUG logging. 2017-05-03 14:23:04,052 attempt 1/10 2017-05-03 14:23:04,052 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b25ad0674afd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-03 14:23:05,504 unpacking tar archive at: mozilla-central-b25ad0674afd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.724177 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 14:23:05.287924) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 14:23:05.288246) ========= script_repo_revision: b25ad0674afd563e888dc07981baa626e8d794db ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 14:23:05.288667) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 14:23:05.288923) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 14:23:05.305046) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-03 14:23:05.305433) ========= /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=9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:23:05 INFO - MultiFileLogger online at 20170503 14:23:05 in /builds/slave/test 14:23:05 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 14:23:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:23:05 INFO - {'append_to_log': False, 14:23:05 INFO - 'base_work_dir': '/builds/slave/test', 14:23:05 INFO - 'blob_upload_branch': 'Firefox', 14:23:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:23:05 INFO - 'branch': 'Firefox', 14:23:05 INFO - 'buildbot_json_path': 'buildprops.json', 14:23:05 INFO - 'config_files': ('talos/linux_config.py',), 14:23:05 INFO - 'default_actions': ('clobber', 14:23:05 INFO - 'read-buildbot-config', 14:23:05 INFO - 'download-and-extract', 14:23:05 INFO - 'populate-webroot', 14:23:05 INFO - 'create-virtualenv', 14:23:05 INFO - 'install', 14:23:05 INFO - 'run-tests'), 14:23:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:23:05 INFO - 'download_minidump_stackwalk': True, 14:23:05 INFO - 'download_symbols': 'ondemand', 14:23:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:23:05 INFO - 'tooltool.py': '/tools/tooltool.py', 14:23:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:23:05 INFO - '/tools/misc-python/virtualenv.py')}, 14:23:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:23:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:23:05 INFO - 'gecko_profile': False, 14:23:05 INFO - 'gecko_profile_interval': 0, 14:23:05 INFO - 'installer_path': 'installer.exe', 14:23:05 INFO - 'log_level': 'info', 14:23:05 INFO - 'log_name': 'talos', 14:23:05 INFO - 'log_to_console': True, 14:23:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:23:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:23:05 INFO - 'opt_config_files': (), 14:23:05 INFO - 'pip_index': False, 14:23:05 INFO - 'suite': 'dromaeojs', 14:23:05 INFO - 'system_bits': '32', 14:23:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:23:05 INFO - 'title': 'talos-linux64-ix-076', 14:23:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:23:05 INFO - 'use_talos_json': True, 14:23:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:23:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:23:05 INFO - 'work_dir': 'build'} 14:23:05 INFO - [mozharness: 2017-05-03 21:23:05.906302Z] Running clobber step. 14:23:05 INFO - Running pre-action listener: _resource_record_pre_action 14:23:05 INFO - Running main action method: clobber 14:23:05 INFO - rmtree: /builds/slave/test/build 14:23:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:23:06 INFO - Running post-action listener: _resource_record_post_action 14:23:06 INFO - [mozharness: 2017-05-03 21:23:06.910088Z] Finished clobber step (success) 14:23:06 INFO - [mozharness: 2017-05-03 21:23:06.910188Z] Running read-buildbot-config step. 14:23:06 INFO - Running pre-action listener: _resource_record_pre_action 14:23:06 INFO - Running main action method: read_buildbot_config 14:23:06 INFO - Using buildbot properties: 14:23:06 INFO - { 14:23:06 INFO - "project": "", 14:23:06 INFO - "product": "firefox", 14:23:06 INFO - "who": "kwierso@gmail.com", 14:23:06 INFO - "installer_path": "public/build/target.tar.bz2", 14:23:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 14:23:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:23:06 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 14:23:06 INFO - "stage_platform": "linux64-stylo", 14:23:06 INFO - "basedir": "/builds/slave/test", 14:23:06 INFO - "buildnumber": 55, 14:23:06 INFO - "platform": "ubuntu64_hw_stylo", 14:23:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:23:06 INFO - "slavebuilddir": "test", 14:23:06 INFO - "taskId": "P9L6aZtRQg-GA7ARoXaihg", 14:23:06 INFO - "branch": "mozilla-central", 14:23:06 INFO - "script_repo_revision": "production", 14:23:06 INFO - "revision": "b25ad0674afd563e888dc07981baa626e8d794db", 14:23:06 INFO - "slavename": "talos-linux64-ix-076", 14:23:06 INFO - "repo_path": "mozilla-central" 14:23:06 INFO - } 14:23:06 INFO - Finding installer, test and symbols from parent task. 14:23:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P9L6aZtRQg-GA7ARoXaihg'}, attempt #1 14:23:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P9L6aZtRQg-GA7ARoXaihg'}, attempt #1 14:23:07 INFO - Task dependencies: QYt3XzFASXWxISA0iLjPUg 14:23:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg'}, attempt #1 14:23:08 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.tar.bz2 14:23:08 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/test_packages.json 14:23:08 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.crashreporter-symbols.zip 14:23:08 INFO - Running post-action listener: _resource_record_post_action 14:23:08 INFO - [mozharness: 2017-05-03 21:23:08.286173Z] Finished read-buildbot-config step (success) 14:23:08 INFO - [mozharness: 2017-05-03 21:23:08.286392Z] Running download-and-extract step. 14:23:08 INFO - Running pre-action listener: _resource_record_pre_action 14:23:08 INFO - Running main action method: download_and_extract 14:23:08 INFO - mkdir: /builds/slave/test/build/tests 14:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:08 INFO - trying https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.test_packages.json 14:23:08 INFO - Downloading https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:23:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:23:08 INFO - Downloaded 986 bytes. 14:23:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:23:08 INFO - Using the following test package requirements: 14:23:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:23:08 INFO - u'common': [u'target.common.tests.zip'], 14:23:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:23:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:23:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:23:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:23:08 INFO - u'mozbase': [u'target.common.tests.zip'], 14:23:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:23:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:23:08 INFO - u'web-platform': [u'target.common.tests.zip', 14:23:08 INFO - u'target.web-platform.tests.zip'], 14:23:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:23:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:23:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.common.tests.zip 14:23:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:23:08 INFO - Fetch https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.common.tests.zip into memory 14:23:09 INFO - Content-Length response header: 58441317 14:23:09 INFO - Bytes received: 58441317 14:23:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:23:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.common.tests.zip 14:23:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:23:19 INFO - Fetch https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.common.tests.zip into memory 14:23:20 INFO - Content-Length response header: 58441317 14:23:20 INFO - Bytes received: 58441317 14:23:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.talos.tests.zip 14:23:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:23:30 INFO - Fetch https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.talos.tests.zip into memory 14:23:31 INFO - Content-Length response header: 14408809 14:23:31 INFO - Bytes received: 14408809 14:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:31 INFO - trying https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.tar.bz2 14:23:31 INFO - Downloading https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:23:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:23:33 INFO - Downloaded 59951951 bytes. 14:23:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.tar.bz2 14:23:33 INFO - mkdir: /builds/slave/test/properties 14:23:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:23:33 INFO - Writing to file /builds/slave/test/properties/build_url 14:23:33 INFO - Contents: 14:23:33 INFO - build_url:https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.tar.bz2 14:23:33 INFO - Running post-action listener: _resource_record_post_action 14:23:33 INFO - Running post-action listener: set_extra_try_arguments 14:23:33 INFO - [mozharness: 2017-05-03 21:23:33.057174Z] Finished download-and-extract step (success) 14:23:33 INFO - [mozharness: 2017-05-03 21:23:33.057270Z] Running populate-webroot step. 14:23:33 INFO - Running pre-action listener: _resource_record_pre_action 14:23:33 INFO - Running main action method: populate_webroot 14:23:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:23:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:23:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:23:33 INFO - '--tppagecycles', 14:23:33 INFO - '7'], 14:23:33 INFO - 'tests': ['tsvgm']}}, 14:23:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:23:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:23:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:23:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:23:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:23:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:23:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:23:33 INFO - 'talos_options': ['--disable-e10s'], 14:23:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:23:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:23:33 INFO - 'talos_options': ['--disable-e10s'], 14:23:33 INFO - 'tests': ['damp', 'tps']}, 14:23:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:23:33 INFO - 'tests': ['damp', 'tps']}, 14:23:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:23:33 INFO - 'tests': ['dromaeo_dom']}, 14:23:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:23:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:23:33 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:23:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:23:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:23:33 INFO - 'tests': ['a11yr', 14:23:33 INFO - 'ts_paint', 14:23:33 INFO - 'tpaint', 14:23:33 INFO - 'sessionrestore', 14:23:33 INFO - 'sessionrestore_no_auto_restore', 14:23:33 INFO - 'tabpaint']}, 14:23:33 INFO - 'other-e10s': {'tests': ['a11yr', 14:23:33 INFO - 'ts_paint', 14:23:33 INFO - 'tpaint', 14:23:33 INFO - 'sessionrestore', 14:23:33 INFO - 'sessionrestore_no_auto_restore', 14:23:33 INFO - 'tabpaint']}, 14:23:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:23:33 INFO - 'ts_paint', 14:23:33 INFO - 'tpaint', 14:23:33 INFO - 'sessionrestore', 14:23:33 INFO - 'sessionrestore_no_auto_restore', 14:23:33 INFO - 'tabpaint']}, 14:23:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:23:33 INFO - 'ts_paint', 14:23:33 INFO - 'tpaint', 14:23:33 INFO - 'sessionrestore', 14:23:33 INFO - 'sessionrestore_no_auto_restore', 14:23:33 INFO - 'tabpaint']}, 14:23:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:23:33 INFO - 'tests': ['a11yr', 14:23:33 INFO - 'ts_paint', 14:23:33 INFO - 'tpaint', 14:23:33 INFO - 'sessionrestore', 14:23:33 INFO - 'sessionrestore_no_auto_restore', 14:23:33 INFO - 'tabpaint']}, 14:23:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:23:33 INFO - 'tests': ['a11yr', 14:23:33 INFO - 'ts_paint', 14:23:33 INFO - 'tpaint', 14:23:33 INFO - 'sessionrestore', 14:23:33 INFO - 'sessionrestore_no_auto_restore', 14:23:33 INFO - 'tabpaint']}, 14:23:33 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:23:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:23:33 INFO - 'bloom_basic_ref']}, 14:23:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:23:33 INFO - 'tests': ['tsvgx', 14:23:33 INFO - 'tsvgr_opacity', 14:23:33 INFO - 'tart', 14:23:33 INFO - 'tscrollx', 14:23:33 INFO - 'cart', 14:23:33 INFO - 'tsvg_static']}, 14:23:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:23:33 INFO - 'tsvgr_opacity', 14:23:33 INFO - 'tart', 14:23:33 INFO - 'tscrollx', 14:23:33 INFO - 'cart', 14:23:33 INFO - 'tsvg_static']}, 14:23:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:23:33 INFO - 'talos_options': ['--disable-e10s'], 14:23:33 INFO - 'tests': ['tp5o']}, 14:23:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:23:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:23:33 INFO - 'talos_options': ['--disable-e10s', 14:23:33 INFO - '--xperf_path', 14:23:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:33 INFO - 'tests': ['tp5n']}, 14:23:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:23:33 INFO - 'talos_options': ['--xperf_path', 14:23:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:33 INFO - 'tests': ['tp5n']}}, 14:23:33 INFO - 'talos.zip': {'path': '', 14:23:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:23:33 INFO - Running post-action listener: _resource_record_post_action 14:23:33 INFO - [mozharness: 2017-05-03 21:23:33.070913Z] Finished populate-webroot step (success) 14:23:33 INFO - [mozharness: 2017-05-03 21:23:33.071007Z] Running create-virtualenv step. 14:23:33 INFO - Running pre-action listener: _resource_record_pre_action 14:23:33 INFO - Running main action method: create_virtualenv 14:23:33 INFO - Creating virtualenv /builds/slave/test/build/venv 14:23:33 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 14:23:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:23:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:23:33 INFO - Using real prefix '/usr' 14:23:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:23:33 INFO - Installing distribute.............................................................................................................................................................................................done. 14:23:35 INFO - Installing pip.................done. 14:23:35 INFO - Return code: 0 14:23:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:23:35 INFO - Reading from file tmpfile_stdout 14:23:35 INFO - Output received: 14:23:35 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) 14:23:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d400>, '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 0x101e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e840>, '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': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', '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 14:23:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:23:35 INFO - Using env: {'DISPLAY': ':0', 14:23:35 INFO - 'HOME': '/home/cltbld', 14:23:35 INFO - 'LANG': 'en_US.UTF-8', 14:23:35 INFO - 'LANGUAGE': 'en_US:en', 14:23:35 INFO - 'LOGNAME': 'cltbld', 14:23:35 INFO - 'MAIL': '/var/mail/cltbld', 14:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:35 INFO - 'MOZ_NO_REMOTE': '1', 14:23:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:35 INFO - 'NO_EM_RESTART': '1', 14:23:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:35 INFO - 'PWD': '/builds/slave/test', 14:23:35 INFO - 'SHELL': '/bin/bash', 14:23:35 INFO - 'SHLVL': '1', 14:23:35 INFO - 'TERM': 'linux', 14:23:35 INFO - 'TMOUT': '86400', 14:23:35 INFO - 'USER': 'cltbld', 14:23:35 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', 14:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:35 INFO - '_': '/tools/buildbot/bin/python'} 14:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:36 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 14:23:36 INFO - Cleaning up... 14:23:36 INFO - Return code: 0 14:23:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:23: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')]} 14:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23: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')]} 14:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:36 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 0xd821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d400>, '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 0x101e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e840>, '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': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', '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 14:23:36 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 14:23:36 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 14:23:36 INFO - Using env: {'DISPLAY': ':0', 14:23:36 INFO - 'HOME': '/home/cltbld', 14:23:36 INFO - 'LANG': 'en_US.UTF-8', 14:23:36 INFO - 'LANGUAGE': 'en_US:en', 14:23:36 INFO - 'LOGNAME': 'cltbld', 14:23:36 INFO - 'MAIL': '/var/mail/cltbld', 14:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:36 INFO - 'MOZ_NO_REMOTE': '1', 14:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:36 INFO - 'NO_EM_RESTART': '1', 14:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:36 INFO - 'PWD': '/builds/slave/test', 14:23:36 INFO - 'SHELL': '/bin/bash', 14:23:36 INFO - 'SHLVL': '1', 14:23:36 INFO - 'TERM': 'linux', 14:23:36 INFO - 'TMOUT': '86400', 14:23:36 INFO - 'USER': 'cltbld', 14:23:36 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', 14:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:36 INFO - '_': '/tools/buildbot/bin/python'} 14:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:36 INFO - Downloading/unpacking psutil>=3.1.1 14:23:36 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 14:23:36 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 14:23:36 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 14:23:36 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 14:23:36 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 14:23:36 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 14:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:23:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:37 INFO - Installing collected packages: psutil 14:23:37 INFO - Running setup.py install for psutil 14:23:37 INFO - building 'psutil._psutil_linux' extension 14:23:37 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 14:23:37 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 14:23:37 INFO - building 'psutil._psutil_posix' extension 14:23:37 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 14:23:37 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 14:23:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:37 INFO - Successfully installed psutil 14:23:37 INFO - Cleaning up... 14:23:37 INFO - Return code: 0 14:23:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:23:37 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')]} 14:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:37 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')]} 14:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:37 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 0xd821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d400>, '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 0x101e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e840>, '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': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', '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 14:23:37 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 14:23:37 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 14:23:37 INFO - Using env: {'DISPLAY': ':0', 14:23:37 INFO - 'HOME': '/home/cltbld', 14:23:37 INFO - 'LANG': 'en_US.UTF-8', 14:23:37 INFO - 'LANGUAGE': 'en_US:en', 14:23:37 INFO - 'LOGNAME': 'cltbld', 14:23:37 INFO - 'MAIL': '/var/mail/cltbld', 14:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:38 INFO - 'MOZ_NO_REMOTE': '1', 14:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:38 INFO - 'NO_EM_RESTART': '1', 14:23:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:38 INFO - 'PWD': '/builds/slave/test', 14:23:38 INFO - 'SHELL': '/bin/bash', 14:23:38 INFO - 'SHLVL': '1', 14:23:38 INFO - 'TERM': 'linux', 14:23:38 INFO - 'TMOUT': '86400', 14:23:38 INFO - 'USER': 'cltbld', 14:23:38 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', 14:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:38 INFO - '_': '/tools/buildbot/bin/python'} 14:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:23:38 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 14:23:38 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 14:23:38 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 14:23:38 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 14:23:38 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 14:23:38 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 14:23:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:23:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:23:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:23:39 INFO - Installing collected packages: mozsystemmonitor 14:23:39 INFO - Running setup.py install for mozsystemmonitor 14:23:39 INFO - Successfully installed mozsystemmonitor 14:23:39 INFO - Cleaning up... 14:23:39 INFO - Return code: 0 14:23:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:23:39 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')]} 14:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:39 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')]} 14:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:39 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 0xd821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d400>, '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 0x101e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e840>, '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': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', '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 14:23:39 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 14:23:39 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 14:23:39 INFO - Using env: {'DISPLAY': ':0', 14:23:39 INFO - 'HOME': '/home/cltbld', 14:23:39 INFO - 'LANG': 'en_US.UTF-8', 14:23:39 INFO - 'LANGUAGE': 'en_US:en', 14:23:39 INFO - 'LOGNAME': 'cltbld', 14:23:39 INFO - 'MAIL': '/var/mail/cltbld', 14:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:39 INFO - 'MOZ_NO_REMOTE': '1', 14:23:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:39 INFO - 'NO_EM_RESTART': '1', 14:23:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:39 INFO - 'PWD': '/builds/slave/test', 14:23:39 INFO - 'SHELL': '/bin/bash', 14:23:39 INFO - 'SHLVL': '1', 14:23:39 INFO - 'TERM': 'linux', 14:23:39 INFO - 'TMOUT': '86400', 14:23:39 INFO - 'USER': 'cltbld', 14:23:39 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', 14:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:39 INFO - '_': '/tools/buildbot/bin/python'} 14:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:39 INFO - Downloading/unpacking jsonschema==2.5.1 14:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:23:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:23:40 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 14:23:40 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 14:23:40 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 14:23:40 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 14:23:40 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 14:23:40 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 14:23:40 INFO - Downloading functools32-3.2.3-2.tar.gz 14:23:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:23:40 INFO - warning: no files found matching '*.txt' 14:23:40 INFO - no previously-included directories found matching 'build' 14:23:40 INFO - no previously-included directories found matching 'dist' 14:23:40 INFO - no previously-included directories found matching '.git*' 14:23:40 INFO - Installing collected packages: jsonschema, functools32 14:23:40 INFO - Running setup.py install for functools32 14:23:41 INFO - warning: no files found matching '*.txt' 14:23:41 INFO - no previously-included directories found matching 'build' 14:23:41 INFO - no previously-included directories found matching 'dist' 14:23:41 INFO - no previously-included directories found matching '.git*' 14:23:41 INFO - Successfully installed jsonschema functools32 14:23:41 INFO - Cleaning up... 14:23:41 INFO - Return code: 0 14:23:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:23:41 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')]} 14:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:41 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')]} 14:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:41 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 0xd821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d400>, '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 0x101e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e840>, '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': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', '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 14:23:41 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 14:23:41 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 14:23:41 INFO - Using env: {'DISPLAY': ':0', 14:23:41 INFO - 'HOME': '/home/cltbld', 14:23:41 INFO - 'LANG': 'en_US.UTF-8', 14:23:41 INFO - 'LANGUAGE': 'en_US:en', 14:23:41 INFO - 'LOGNAME': 'cltbld', 14:23:41 INFO - 'MAIL': '/var/mail/cltbld', 14:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:41 INFO - 'MOZ_NO_REMOTE': '1', 14:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:41 INFO - 'NO_EM_RESTART': '1', 14:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:41 INFO - 'PWD': '/builds/slave/test', 14:23:41 INFO - 'SHELL': '/bin/bash', 14:23:41 INFO - 'SHLVL': '1', 14:23:41 INFO - 'TERM': 'linux', 14:23:41 INFO - 'TMOUT': '86400', 14:23:41 INFO - 'USER': 'cltbld', 14:23:41 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', 14:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:41 INFO - '_': '/tools/buildbot/bin/python'} 14:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:23:41 INFO - Cleaning up... 14:23:41 INFO - Return code: 0 14:23:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:23:41 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')]} 14:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:41 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')]} 14:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:41 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 0xd821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d400>, '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 0x101e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e840>, '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': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', '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 14:23:41 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 14:23:41 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 14:23:41 INFO - Using env: {'DISPLAY': ':0', 14:23:41 INFO - 'HOME': '/home/cltbld', 14:23:41 INFO - 'LANG': 'en_US.UTF-8', 14:23:41 INFO - 'LANGUAGE': 'en_US:en', 14:23:41 INFO - 'LOGNAME': 'cltbld', 14:23:41 INFO - 'MAIL': '/var/mail/cltbld', 14:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:41 INFO - 'MOZ_NO_REMOTE': '1', 14:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:41 INFO - 'NO_EM_RESTART': '1', 14:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:41 INFO - 'PWD': '/builds/slave/test', 14:23:41 INFO - 'SHELL': '/bin/bash', 14:23:41 INFO - 'SHLVL': '1', 14:23:41 INFO - 'TERM': 'linux', 14:23:41 INFO - 'TMOUT': '86400', 14:23:41 INFO - 'USER': 'cltbld', 14:23:41 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', 14:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:41 INFO - '_': '/tools/buildbot/bin/python'} 14:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:41 INFO - Downloading/unpacking blobuploader==1.2.4 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23:42 INFO - Downloading blobuploader-1.2.4.tar.gz 14:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:23:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:23:42 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 14:23:42 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 14:23:42 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 14:23:42 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 14:23:42 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 14:23:42 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 14:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:23:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:23:43 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 14:23:43 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 14:23:43 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 14:23:43 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 14:23:43 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 14:23:43 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 14:23:43 INFO - Downloading docopt-0.6.1.tar.gz 14:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:23:43 INFO - Installing collected packages: blobuploader, requests, docopt 14:23:43 INFO - Running setup.py install for blobuploader 14:23:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:23:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:23:43 INFO - Running setup.py install for requests 14:23:43 INFO - Running setup.py install for docopt 14:23:43 INFO - Successfully installed blobuploader requests docopt 14:23:43 INFO - Cleaning up... 14:23:43 INFO - Return code: 0 14:23:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:43 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 0xd821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d400>, '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 0x101e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e840>, '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': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', '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 14:23:43 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 14:23:43 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 14:23:43 INFO - Using env: {'DISPLAY': ':0', 14:23:43 INFO - 'HOME': '/home/cltbld', 14:23:43 INFO - 'LANG': 'en_US.UTF-8', 14:23:43 INFO - 'LANGUAGE': 'en_US:en', 14:23:43 INFO - 'LOGNAME': 'cltbld', 14:23:43 INFO - 'MAIL': '/var/mail/cltbld', 14:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:43 INFO - 'MOZ_NO_REMOTE': '1', 14:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:43 INFO - 'NO_EM_RESTART': '1', 14:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:43 INFO - 'PWD': '/builds/slave/test', 14:23:43 INFO - 'SHELL': '/bin/bash', 14:23:43 INFO - 'SHLVL': '1', 14:23:43 INFO - 'TERM': 'linux', 14:23:43 INFO - 'TMOUT': '86400', 14:23:43 INFO - 'USER': 'cltbld', 14:23:43 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', 14:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:43 INFO - '_': '/tools/buildbot/bin/python'} 14:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:44 INFO - Running setup.py (path:/tmp/pip-6Iy0YX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:44 INFO - Running setup.py (path:/tmp/pip-Y1rT2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:44 INFO - Running setup.py (path:/tmp/pip-mjDMpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:44 INFO - Running setup.py (path:/tmp/pip-ngNUpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:44 INFO - Running setup.py (path:/tmp/pip-VDZ17N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:44 INFO - Running setup.py (path:/tmp/pip-UlMpNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:44 INFO - Running setup.py (path:/tmp/pip-Ozbaui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:44 INFO - Running setup.py (path:/tmp/pip-4GHJry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:44 INFO - Running setup.py (path:/tmp/pip-XTy0w2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:44 INFO - Running setup.py (path:/tmp/pip-Jzfxzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:44 INFO - Running setup.py (path:/tmp/pip-f2AdMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:44 INFO - Running setup.py (path:/tmp/pip-ge3Urw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:44 INFO - Running setup.py (path:/tmp/pip-NotUGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:45 INFO - Running setup.py (path:/tmp/pip-S82vEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:45 INFO - Running setup.py (path:/tmp/pip-pAnxdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:45 INFO - Running setup.py (path:/tmp/pip-47pZXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:45 INFO - Running setup.py (path:/tmp/pip-05qYCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:23:45 INFO - Running setup.py install for manifestparser 14:23:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:23:45 INFO - Running setup.py install for mozcrash 14:23:45 INFO - Running setup.py install for mozdebug 14:23:45 INFO - Running setup.py install for mozdevice 14:23:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:23:45 INFO - Running setup.py install for mozfile 14:23:45 INFO - Running setup.py install for mozhttpd 14:23:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:23:45 INFO - Running setup.py install for mozinfo 14:23:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:23:45 INFO - Running setup.py install for mozInstall 14:23:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:23:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:23:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:23:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:23:46 INFO - Running setup.py install for mozleak 14:23:46 INFO - Running setup.py install for mozlog 14:23:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:23:46 INFO - Running setup.py install for moznetwork 14:23:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:23:46 INFO - Running setup.py install for mozprocess 14:23:46 INFO - Running setup.py install for mozprofile 14:23:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:23:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:23:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:23:46 INFO - Running setup.py install for mozrunner 14:23:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:23:46 INFO - Running setup.py install for mozscreenshot 14:23:46 INFO - Running setup.py install for moztest 14:23:46 INFO - Running setup.py install for mozversion 14:23:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:23:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:23:47 INFO - Cleaning up... 14:23:47 INFO - Return code: 0 14:23:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:47 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 0xd821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d400>, '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 0x101e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e840>, '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': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', '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 14:23:47 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 14:23:47 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 14:23:47 INFO - Using env: {'DISPLAY': ':0', 14:23:47 INFO - 'HOME': '/home/cltbld', 14:23:47 INFO - 'LANG': 'en_US.UTF-8', 14:23:47 INFO - 'LANGUAGE': 'en_US:en', 14:23:47 INFO - 'LOGNAME': 'cltbld', 14:23:47 INFO - 'MAIL': '/var/mail/cltbld', 14:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:47 INFO - 'MOZ_NO_REMOTE': '1', 14:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:47 INFO - 'NO_EM_RESTART': '1', 14:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:47 INFO - 'PWD': '/builds/slave/test', 14:23:47 INFO - 'SHELL': '/bin/bash', 14:23:47 INFO - 'SHLVL': '1', 14:23:47 INFO - 'TERM': 'linux', 14:23:47 INFO - 'TMOUT': '86400', 14:23:47 INFO - 'USER': 'cltbld', 14:23:47 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', 14:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:47 INFO - '_': '/tools/buildbot/bin/python'} 14:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:47 INFO - Running setup.py (path:/tmp/pip-XJ3g6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:47 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)) 14:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:47 INFO - Running setup.py (path:/tmp/pip-wt0YFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:47 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)) 14:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:47 INFO - Running setup.py (path:/tmp/pip-Wjw9lP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:47 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)) 14:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:47 INFO - Running setup.py (path:/tmp/pip-kRrcfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 14:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:47 INFO - Running setup.py (path:/tmp/pip-Mz0PJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:47 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)) 14:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:47 INFO - Running setup.py (path:/tmp/pip-yEO21_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:47 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)) 14:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:47 INFO - Running setup.py (path:/tmp/pip-a0pYKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:47 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)) 14:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:47 INFO - Running setup.py (path:/tmp/pip-yxasYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:47 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)) 14:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:47 INFO - Running setup.py (path:/tmp/pip-ojDzTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:47 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)) 14:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:47 INFO - Running setup.py (path:/tmp/pip-_fTlwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:48 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)) 14:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:48 INFO - Running setup.py (path:/tmp/pip-9I3NlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:48 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)) 14:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:48 INFO - Running setup.py (path:/tmp/pip-a_KGL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:48 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)) 14:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:48 INFO - Running setup.py (path:/tmp/pip-8TLb1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:48 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)) 14:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:48 INFO - Running setup.py (path:/tmp/pip-G3jiIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:48 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)) 14:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:48 INFO - Running setup.py (path:/tmp/pip-wrsSKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:48 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)) 14:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:48 INFO - Running setup.py (path:/tmp/pip-QE0tfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:48 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)) 14:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:48 INFO - Running setup.py (path:/tmp/pip-3A8JcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:48 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)) 14:23:48 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)) 14:23:48 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)) 14:23:48 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)) 14:23:48 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:23:48 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:23:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:23:48 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 14:23:48 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 14:23:48 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 14:23:48 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 14:23:48 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 14:23:48 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 14:23:49 INFO - Downloading blessings-1.6.tar.gz 14:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:23:49 INFO - Installing collected packages: blessings 14:23:49 INFO - Running setup.py install for blessings 14:23:49 INFO - Successfully installed blessings 14:23:49 INFO - Cleaning up... 14:23:49 INFO - Return code: 0 14:23:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:23:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:50 INFO - Reading from file tmpfile_stdout 14:23:50 INFO - Current package versions: 14:23:50 INFO - argparse == 1.2.1 14:23:50 INFO - blessings == 1.6 14:23:50 INFO - blobuploader == 1.2.4 14:23:50 INFO - docopt == 0.6.1 14:23:50 INFO - functools32 == 3.2.3-2 14:23:50 INFO - jsonschema == 2.5.1 14:23:50 INFO - manifestparser == 1.1 14:23:50 INFO - mozInstall == 1.12 14:23:50 INFO - mozcrash == 1.0 14:23:50 INFO - mozdebug == 0.1 14:23:50 INFO - mozdevice == 0.50 14:23:50 INFO - mozfile == 1.2 14:23:50 INFO - mozhttpd == 0.7 14:23:50 INFO - mozinfo == 0.9 14:23:50 INFO - mozleak == 0.1 14:23:50 INFO - mozlog == 3.4 14:23:50 INFO - moznetwork == 0.27 14:23:50 INFO - mozprocess == 0.25 14:23:50 INFO - mozprofile == 0.28 14:23:50 INFO - mozrunner == 6.13 14:23:50 INFO - mozscreenshot == 0.1 14:23:50 INFO - mozsystemmonitor == 0.3 14:23:50 INFO - moztest == 0.8 14:23:50 INFO - mozversion == 1.4 14:23:50 INFO - psutil == 3.1.1 14:23:50 INFO - requests == 1.2.3 14:23:50 INFO - wsgiref == 0.1.2 14:23:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:50 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')]} 14:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:50 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')]} 14:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:50 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 0xd821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d400>, '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 0x101e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e840>, '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': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', '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 14:23:50 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 14:23:50 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 14:23:50 INFO - Using env: {'DISPLAY': ':0', 14:23:50 INFO - 'HOME': '/home/cltbld', 14:23:50 INFO - 'LANG': 'en_US.UTF-8', 14:23:50 INFO - 'LANGUAGE': 'en_US:en', 14:23:50 INFO - 'LOGNAME': 'cltbld', 14:23:50 INFO - 'MAIL': '/var/mail/cltbld', 14:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:50 INFO - 'MOZ_NO_REMOTE': '1', 14:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:50 INFO - 'NO_EM_RESTART': '1', 14:23:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:50 INFO - 'PWD': '/builds/slave/test', 14:23:50 INFO - 'SHELL': '/bin/bash', 14:23:50 INFO - 'SHLVL': '1', 14:23:50 INFO - 'TERM': 'linux', 14:23:50 INFO - 'TMOUT': '86400', 14:23:50 INFO - 'USER': 'cltbld', 14:23:50 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', 14:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:50 INFO - '_': '/tools/buildbot/bin/python'} 14:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:50 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)) 14:23:50 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)) 14:23:50 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)) 14:23:50 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)) 14:23:50 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)) 14:23:50 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)) 14:23:50 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)) 14:23:50 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)) 14:23:50 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)) 14:23:50 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)) 14:23:50 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)) 14:23:50 INFO - Cleaning up... 14:23:50 INFO - Return code: 0 14:23:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:23:50 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')]} 14:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:50 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')]} 14:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:50 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 0xd821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1020310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d400>, '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 0x101e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e840>, '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': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', '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 14:23:50 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 14:23:50 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 14:23:50 INFO - Using env: {'DISPLAY': ':0', 14:23:50 INFO - 'HOME': '/home/cltbld', 14:23:50 INFO - 'LANG': 'en_US.UTF-8', 14:23:50 INFO - 'LANGUAGE': 'en_US:en', 14:23:50 INFO - 'LOGNAME': 'cltbld', 14:23:50 INFO - 'MAIL': '/var/mail/cltbld', 14:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:50 INFO - 'MOZ_NO_REMOTE': '1', 14:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:50 INFO - 'NO_EM_RESTART': '1', 14:23:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:50 INFO - 'PWD': '/builds/slave/test', 14:23:50 INFO - 'SHELL': '/bin/bash', 14:23:50 INFO - 'SHLVL': '1', 14:23:50 INFO - 'TERM': 'linux', 14:23:50 INFO - 'TMOUT': '86400', 14:23:50 INFO - 'USER': 'cltbld', 14:23:50 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', 14:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:50 INFO - '_': '/tools/buildbot/bin/python'} 14:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:23:50 INFO - Cleaning up... 14:23:50 INFO - Return code: 0 14:23:50 INFO - Running post-action listener: _resource_record_post_action 14:23:50 INFO - Running post-action listener: _start_resource_monitoring 14:23:50 INFO - Starting resource monitoring. 14:23:50 INFO - [mozharness: 2017-05-03 21:23:50.534562Z] Finished create-virtualenv step (success) 14:23:50 INFO - [mozharness: 2017-05-03 21:23:50.535234Z] Running install step. 14:23:50 INFO - Running pre-action listener: _resource_record_pre_action 14:23:50 INFO - Running main action method: install 14:23:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:50 INFO - Reading from file tmpfile_stdout 14:23:50 INFO - Detecting whether we're running mozinstall >=1.0... 14:23:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:23:50 INFO - Reading from file tmpfile_stdout 14:23:50 INFO - Output received: 14:23:50 INFO - Usage: mozinstall [options] installer 14:23:50 INFO - Options: 14:23:50 INFO - -h, --help show this help message and exit 14:23:50 INFO - -d DEST, --destination=DEST 14:23:50 INFO - Directory to install application into. [default: 14:23:50 INFO - "/builds/slave/test"] 14:23:50 INFO - --app=APP Application being installed. [default: firefox] 14:23:50 INFO - mkdir: /builds/slave/test/build/application 14:23:50 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'] 14:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:24:06 INFO - Reading from file tmpfile_stdout 14:24:06 INFO - Output received: 14:24:06 INFO - /builds/slave/test/build/application/firefox/firefox 14:24:06 INFO - Running post-action listener: _resource_record_post_action 14:24:06 INFO - [mozharness: 2017-05-03 21:24:06.173207Z] Finished install step (success) 14:24:06 INFO - [mozharness: 2017-05-03 21:24:06.173482Z] Running run-tests step. 14:24:06 INFO - Running pre-action listener: _resource_record_pre_action 14:24:06 INFO - Running main action method: run_tests 14:24:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:24:06 INFO - Python 2.7.3 14:24:06 INFO - Return code: 0 14:24:06 INFO - grabbing minidump binary from tooltool 14:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:06 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 0x101d400>, '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 0x101e3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:24:06 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 14:24:06 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 14:24:06 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 14:24:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:24:06 INFO - Return code: 0 14:24:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:24:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:24:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:24:06 INFO - ENV: RUST_BACKTRACE is now 1 14:24:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:24:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:24:06 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/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 14:24:06 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/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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 14:24:06 INFO - Using env: {'DISPLAY': ':0', 14:24:06 INFO - 'HOME': '/home/cltbld', 14:24:06 INFO - 'LANG': 'en_US.UTF-8', 14:24:06 INFO - 'LANGUAGE': 'en_US:en', 14:24:06 INFO - 'LOGNAME': 'cltbld', 14:24:06 INFO - 'MAIL': '/var/mail/cltbld', 14:24:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:24:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:06 INFO - 'MOZ_NO_REMOTE': '1', 14:24:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:24:06 INFO - 'NO_EM_RESTART': '1', 14:24:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:06 INFO - 'PWD': '/builds/slave/test', 14:24:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:24:06 INFO - 'RUST_BACKTRACE': '1', 14:24:06 INFO - 'SHELL': '/bin/bash', 14:24:06 INFO - 'SHLVL': '1', 14:24:06 INFO - 'TERM': 'linux', 14:24:06 INFO - 'TMOUT': '86400', 14:24:06 INFO - 'USER': 'cltbld', 14:24:06 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640', 14:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:06 INFO - '_': '/tools/buildbot/bin/python'} 14:24:06 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/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 14:24:06 INFO - mozversion application_buildid: 20170503204424 14:24:06 INFO - mozversion application_changeset: b25ad0674afd563e888dc07981baa626e8d794db 14:24:06 INFO - mozversion application_display_name: Nightly 14:24:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:24:06 INFO - mozversion application_name: Firefox 14:24:06 INFO - mozversion application_remotingname: firefox 14:24:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:24:06 INFO - mozversion application_vendor: Mozilla 14:24:06 INFO - mozversion application_version: 55.0a1 14:24:06 INFO - mozversion platform_buildid: 20170503204424 14:24:06 INFO - mozversion platform_changeset: b25ad0674afd563e888dc07981baa626e8d794db 14:24:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:24:06 INFO - mozversion platform_version: 55.0a1 14:24:06 INFO - using testdate: 1493846646 14:24:06 INFO - actual date: 1493846646 14:24:06 INFO - starting webserver on 'localhost:43576' 14:24:06 INFO - SUITE-START | Running 2 tests 14:24:06 INFO - TEST-START | dromaeo_css 14:24:06 INFO - operating with platform_type : linux_ 14:24:06 INFO - Initialising browser for dromaeo_css test... 14:24:06 INFO - TEST-INFO | started process 11051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprPPUuA/profile http://localhost:43576/getInfo.html) 14:24:11 INFO - PID 11051 | __metrics Screen width/height:1600/1200 14:24:11 INFO - PID 11051 | colorDepth:24 14:24:11 INFO - PID 11051 | Browser inner width/height: 1024/695 14:24:11 INFO - PID 11051 | __metrics 14:24:12 INFO - PID 11051 | 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" 14:24:12 INFO - PID 11051 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:24:13 INFO - TEST-INFO | 11051: exit 0 14:24:13 INFO - Browser initialized. 14:24:13 INFO - Running cycle 1/1 for dromaeo_css test... 14:24:13 INFO - TEST-INFO | started process 11150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprPPUuA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:25 INFO - PID 11150 | RSS: Main: 166686720 14:24:25 INFO - PID 11150 | 14:27:31 INFO - PID 11150 | Cycle 1(1): loaded http://localhost:43576/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43576/tests/dromaeo/cssquery-ext.html) 14:27:34 INFO - PID 11150 | RSS: Main: 405942272 14:27:34 INFO - PID 11150 | 14:30:36 INFO - PID 11150 | Cycle 1(1): loaded http://localhost:43576/tests/dromaeo/cssquery-ext.html (next: http://localhost:43576/tests/dromaeo/cssquery-jquery.html) 14:30:37 INFO - PID 11150 | RSS: Main: 260059136 14:30:37 INFO - PID 11150 | 14:33:39 INFO - PID 11150 | Cycle 1(1): loaded http://localhost:43576/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43576/tests/dromaeo/cssquery-mootools.html) 14:33:39 INFO - PID 11150 | RSS: Main: 209510400 14:33:39 INFO - PID 11150 | 14:36:41 INFO - PID 11150 | Cycle 1(1): loaded http://localhost:43576/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43576/tests/dromaeo/cssquery-prototype.html) 14:36:42 INFO - PID 11150 | RSS: Main: 218460160 14:36:42 INFO - PID 11150 | 14:39:45 INFO - PID 11150 | Cycle 1(1): loaded http://localhost:43576/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43576/tests/dromaeo/cssquery-yui.html) 14:39:46 INFO - PID 11150 | RSS: Main: 209014784 14:39:46 INFO - PID 11150 | 14:42:48 INFO - PID 11150 | Cycle 1(1): loaded http://localhost:43576/tests/dromaeo/cssquery-yui.html (next: http://localhost:43576/tests/dromaeo/cssquery-dojo.html) 14:42:48 INFO - PID 11150 | RSS: Main: 299028480 14:42:48 INFO - PID 11150 | 14:42:48 INFO - PID 11150 | __start_tp_report 14:42:48 INFO - PID 11150 | _x_x_mozilla_page_load 14:42:48 INFO - PID 11150 | _x_x_mozilla_page_load_details 14:42:48 INFO - PID 11150 | |i|pagename|runs| 14:42:48 INFO - PID 11150 | |0;dojo.html;2700.8514531700753;2707.891684332627;2747.6290700755403;2750.9587356189672;2762.074704973833;5110;5212.504812042859;5231.973840130799;5238.895222095556;5285.524302812742;5148.279240906276;5153.149730294497;5226.320578324812;5231.267622532839;5297.337832770903;4362.5637436256275;4579.267317229244;4613.169629466703;4721.126591580552;4727.692699974491;4664.510226426227;4680.625549955996;4691.507391723854;4691.554302341272;4709.62323014158;4498.685092043558;4502.954970450319;4548.727076375428;4628.583427491509;4633.32816741574;4628.421447319085;4636.86089417318;4637.837675681335;4659.4175728034;4700.482946875841;4588.862334129982;4609.884752881171;4619.3994780678295;4655.3947986761505;4663.417072865892;5062.443131255559;5137.897242055175;5138.7173705446185;5148.6910785353;5164.044651739403;5588.385277619459;5672.319321681383;5723.771049158028;5725.427457254283;5728.226689396962;5628.662280263197;5628.859278518029;5629.268195134607;5635.520980716644;5638.605297629168;5167.767450464663;5220.451852555427;5225.425203227642;5237.109691352479;5282.920756188661;5705.7147142643535;5763.337216220189;5857.560682948711;5860.824175274749;5863.091220860773;5519.530839878575;5545.362283337387;5615.157726341082;5622.269105016322;5623.0159722048475;5607.607467477237;5647.548196144298;5668.26312579362;5673.489385955284;5682.119271512922;5520.530754885799;5619.662820230799;5621.522170615462;5627;5630.324361076697;5571.749271282721;5574.442555744474;5574.637648552831;5581.553475721932;5583.190437386637;4536.047430039728;4625.32932724753;4634.189016922025;4634.768261586907;4637.281221410687;3991.341428664296;4008.3586626139677;4026.074002979273;4077.653399461079;4079.265732168179;4765.523447655207;4785.856424307207;4786.497417771154;4790.520947905182;4855.5387238212315;5529.30883639545;5628.04323265046;5646.350669672958;5649.858753531194;5694.629849059798;4713.552212539803;4743.335932969387;4746.976265118721;4811.735354555463;4813.205821039559;4997.575206107449;4999.775010124553;5001.199808030698;5011.974940125276;5048.469910659402;5225.895482090261;5259.342582177228;5266.8419947401635;5276;5299.178627312773;5511.807086751945;5558.471945165203;5636.408177141505;5637.351704554028;5681.744321505459;5271.894562108813;5272.367315922113;5291.232771248225;5317.1492561190025;5324.440933702061;5566.888662226814;5567.693776842312;5568.331800183842;5578.470045345685;5584.190292407659;5549.944500555104;5640.633358831663;5646.3506696728755;5648.293963254593;5717.514011309086;5308.840734777963;5371.221172929982;5371.301730775131;5373.9731301343245;5377.193420986883;5319;5359.785608575613;5360.035193665178;5363.249145119765;5368.382635996911;5291.1798671206025;5300.787968481218;5303.15149576066;5303.36359636846;5303.602229832701;5403.108487099585;5413.160960051198;5415.458454154553;5417.891642167214;5444.918326225189;5397.730113494388;5405.216243644571;5427.891442171213;5449.945500544944;5454.263674404064 14:42:48 INFO - PID 11150 | |1;ext.html;707.1372925031461;732.1945859554489;1041.187873458702;1081.6809041332806;1085.489819784701;30473;33660.15849603761;33662;33754.83122584384;33799.15502112448;34941.47587786185;35414.2917141657;35431.4685279721;35431.82284088576;35473;5242.135047717122;6964.233934267239;7115.39519140871;7124.821879453003;7125.465590080738;5286.286351342558;5408;5408.107662235746;6861.794146175623;7036.296370362948;7108.537945033582;7136.678849451761;7153.356197942184;7153.6065516396575;7153.6780844862105;7088.929110708878;7140.607266600335;7142.178649455302;7142.821429464253;7144;5259.684418934838;5389.487998640123;6846.486513511507;6992.370686638227;7035.824104397379;32038.839805801053;32377.676223237937;32394.514082288784;32414.351712965843;32444.837775811207;3048.8932887348838;3087.7375423089065;3089.691030896915;3089.9691003089906;3090.3201295714907;24195.153169639154;24204.636930446057;24252.878735606384;24272;24288;2916.0377075565225;2953.438846619157;2968.0205532174546;2969.1834745445176;2987.8954236601617;143453;143829;143849;144114;144541;35318.29363412717;36246.83161436469;41542.79228603838;41710.582894171275;41750.37374439325;42640.36039459411;43844.78077609655;43909.341359879625;43950.78024609856;44057.339139912925;12634.81047784284;12711.110222284351;12714.809277860839;12744.872551274553;12757.42591583381;10245.026722461354;10252.897471025344;10270.845937310947;10275.588976441008;10315.381077135246;11869.287842729464;11932.582359617372;11949.940250298692;12016.279023258632;12092.939535302266;4895;4974.801007959641;4991.600671946236;5051.747412629354;5054.317667114966;903.6520939438363;926.1155596405416;930.8045310484739;935.934484586086;961.0917682789697;20554.79445205529;21603.891980539996;21627.459313517287;21643.593166444447;21759.12963481443;1007.5264625625944;1014.6245889020962;1024.8770147582338;1028.2185538990273;1031.0617338222182;11124.833127503094;11143.052840508648;11329;11423.485943132579;11500.53997840077;161098;161213.19393402958;161345;161397;161726;35705.46441803375;35990.640093598726;36025.45961810575;36054.278914421564;36188.45717314242;1217.1054275107788;1264.6016504800957;1268.4862630634607;1283.736833949038;1285.5243559882715;20060.69908951396;20255.898720506302;20884.164633414493;21122.788772112082;21450.892745536174;29131.85434072901;29193.270168245963;29212.70787292185;29299;29300.56049159307;145177;145524;145565.27217363846;146153;146513;28463.288417788892;28701;28912.42175156443;28944.7105528942;28992.13023609295;34138.82930585331;34935.65064349324;34938.30123397569;35265.1183720409;35416.64583354237;25976;26562.86718566395;27098;27414.451710966066;27472.58791118175;26890.596641050008;27005.459890802467;27311.863440682668;27676.584851226846;28260.576091359057;30169.396612067198;30311;30324.24189395283;30341;30397.69602304037;26561.203163905113;26673.466530669666;26780.59829102526;27458.725412746415;27837;21200.7879921205;21757.840809696365;21949.122035119057;22768.316950491513;23431.297061088193 14:42:48 INFO - PID 11150 | |2;jquery.html;417.9456670632821;424.1993832426945;427.68137737385655;436.2300539547698;439.3322150331496;17553.56116097098;17646.38237661682;18183;18270.634587308246;18352;17526.82473175268;17622.735658965124;17643.91178044111;17805.198766055528;18668.813311866877;5145.253938178962;5335.386430560497;5359.812406565771;5362.410134885159;5399.676019438826;5217.530422261995;5311.097113490716;5346.358436987567;5350.973245133769;5351.785928562853;5402.37872644647;5419.566434685235;5423.755930983115;5425.104857698495;5430.83707488776;5263.710495922723;5313.149896016657;5415.187721841736;5418.539424148932;5420.457954204588;4791;4797.856064318076;4806.951930480685;4808.158572249878;4809.687370320953;21651;21794.237201698023;21831.235906743186;22271.550129485742;22465.213717519808;1609.0828227910097;1644.629958259394;1650.983490165095;1655.106242628991;1658.5687721192455;14218.28908554568;14331.78502322466;14655.193964331958;14656.41374345025;14813.851861481355;2047.9590408191752;2085.3326935380683;2111.448085657041;2118.1844989679084;2133.679948007811;70513;88418;91357;93327.53336233276;93447.0655293452;10564.260501764957;10577.418241996611;10595.576176952836;10732.463376831127;10830.945845270724;15196.088234705952;15242.542723718307;15244.695106097815;15249.847501525064;15268.3892644293;7350.926490735131;7418.258174182646;7505.512141710771;7694.422918281151;7707.383409327353;6687.465002799764;6738.157730283715;6744.696488658022;6877.277885822016;6913.827154321182;6889.9644663519275;6968.651567421609;7031.437485001187;7063.117110361205;7173.533720308267;1930.7296978423033;1948.8928108954144;1955;1985.7815640279846;2067.7311949446776;880.366136381804;902.3953950852945;904.7150147703584;912.8083102548406;937.6404213889887;16517.669646607;16518.75221871673;16680.833191667927;17080.658386832194;17422.21600028002;863.5984267315729;900.6937641202023;906.9047749986288;909.7225346269452;912.8311262416474;8667.523286219192;9423.905760942303;9455.149036586603;9513.096255855682;9606.375585586915;391675;395355;405275;405821;407132;81742.59128704318;83678;83855;84194.15805841863;84533.15466845376;1065.338072606736;1068.2735739696925;1114.57089020726;1120.1430905357245;1123.8707548632012;16926.238319275908;17367;17628.383006594708;17821.287148513915;17867;39484.40773388344;39734.40398394084;39803.80098099491;41637.167256654095;42050.78974605107;47516.52483475121;47572;47625.52374476349;48724.26913596228;49508;8164.673413063411;8168.142345053684;8394.412391132562;8519.91480085216;8932.28541716674;12656.810147847606;12898.41957111951;13043.934780326037;13058.21650700961;13097.803532947204;11272.210945233755;11273.098152147644;11558.711032224262;11649;11729.824052639387;10426.322289051188;10462.581496740046;10530.78938421212;10596.258261921592;10632.468376581295;11063.612773552886;11306.547738090714;11381.317120972768;11412.885871141183;12032.458539365925;8345.499270043816;8420.957895210484;8424.199701028392;8600.913990860012;8789.077146899483;10623.415712135908;11115.72210694739;11268.154888383568;11353.54585816558;11417.942910285396 14:42:48 INFO - PID 11150 | |3;mootools.html;1267.8668739782324;1298.3186773128798;1312.9146605470644;1320.2012782266725;1327.3495986966377;9703.126718595326;10085.899141008578;10130.746731331712;10133.847992280122;10143.13783328418;9751.366161199534;10272.640457583986;10312.535935882885;10320.122789562896;10324.174066074715;2187.2016713899393;2227.654713519399;2227.888605569723;2229;2233.810126139272;1872.7659042619673;2115.2596591193114;2197.461621902628;2199.681046248293;2207.87856667884;1940.7380003699461;2110.303599812058;2198.6152423325852;2199.285232299501;2207.86752794832;2096.1615353858424;2115.217369573252;2117.0050076464113;2124.808767210951;2125.4367592587823;2057.609054279682;2063.772984971652;2064.7728749837506;2067.0904801887123;2068.834493240537;9802.90197098027;10030.9498452508;10040.548175332127;10044.296899217057;10047.09576138151;5459.12653975362;5659.236003139565;5660.009498337816;5661.037623603997;5662.745176467028;3246.788958717676;3389.74576906733;3405.3529829332597;3421.6578342165835;3429.5027221053056;1050.3960222871879;1071.9410432426214;1119.9888001119966;1126.881677423867;1127.4531852051748;14546.781798273034;14647.414103435744;14667.266636668124;14677.706445871023;14696.632584185374;4497.572730590654;4607.6083532900075;4751.073540659608;4814.711117332901;4832.106060378771;10739.516721747541;10772.622958196425;10785.946070269756;10786.083182929382;10794.568217271379;5631.324241091095;5634.605577609528;5639.295088113986;5643.294588176478;5649.293838270216;4935.457099719028;5019.548240658358;5033.84898453047;5050.570701490341;5103;3671.1923376857585;3808.676262517717;3823.3500304948225;3828.502294701671;3874.9806250968563;1113.7104352868312;1115.1079136690614;1121.786860496503;1136.4658610453073;1139.9943000284945;578.9102689083198;617.4381313005143;747.4207489195917;754.6943487887414;756.6481586062507;6084.269887613426;6101.542384321194;6118.112873633388;6151.2618485781095;6304.968475157595;857.9313654907593;864.0365991918965;871.3073106880046;880.4673172730406;881.0660699658255;3513.2797776455764;3569.232614987738;3600.2439487707875;3601.5318008658705;3728.2729867676085;13138.343082845819;13360.331983400985;13578.592642220749;13585.932070339783;13600.183988960496;12906.612801615967;13097.279649619171;13314.06801523884;13320.134191277535;13448.260345681081;7581.658825352873;7613.124490683532;7731;7734.458587898793;7743.845123097506;5383.9192412114635;5559.471850174227;5585.720713964204;6441.581297215666;6542.149520562297;11540.711482213012;11715.707107322385;11887.28676279426;12047.036237101187;12058.75882482363;11663.125265605284;11988.940055299669;12058.638240852788;12137.21108127969;12265.202761820454;7844.372450203856;8081.232282933112;8103.797405064684;8120.83758324842;8191.549464779494;9215.815683686424;9266.44401335922;9400.15398614128;9410.38832475887;9491.810163796823;7687.154413014452;7700.768976930701;7961.800954976172;7961.840763184588;8035.156308587748;7816.7264145754625;7830.33442157423;7902.802429939067;7984.321332686786;8115.269625733712;6859.176898772179;6870.728915150713;6955.617441040791;6957.721691132298;6960.79117626472;4793.993261415142;4839.322494850653;4848.636352273523;4957.82647607332;4984.327115839315;4815.085133824702;4852.805887764591;4925.729084900365;4964.180910149929;4993.500649934977 14:42:48 INFO - PID 11150 | |4;prototype.html;370.9369407200776;388.3436991484392;388.60944750525715;394.33357625612695;397.49716608490246;5273.1035723926925;5297.390800057985;5309.522143007138;5325.680459172448;5343;5031;5155.329807125077;5158.787684894047;5188.118019936611;5189.065968125736;3964.326064569023;3973.9667686401453;3976.383660532622;3979.3986442269647;3991.8602848900296;3989.601039896016;3993.760374377532;3996.3805610130476;3998.0804414984573;4001;3766.435034744783;3919.6668283195963;3924.666403355704;3929.0570263136783;3953.327934251184;3893.4743809585625;3896.0649444133205;3898.961010389902;3902.5512066112333;3915.8237879295502;3403.285310084885;3407.063057659139;3408.7613867029318;3409.7272218222483;3413.6245013048547;4898.951010489885;5016.2224855147515;5023.146065168893;5037;5076.847694569169;4579.885502862422;4588.449386073693;4603.723776573416;4605.907881842344;4623.930641040387;5486.753096110685;5502.752376143083;5514.117741161395;5516.972415137899;5517.44825517449;3767.6059857852497;3843.596422375638;3843.98078009611;3849.0185002824383;3850.4416859555486;5550.417206193332;5687.658740475585;5699.401562835926;5719.285089363788;5831.591788574801;3878.631530004645;3882.7282090253975;3904.2386734586485;3906.4179007502007;3934.3508321127265;3961.1483531040963;3970.1067259866877;3980.44273801668;3981.5023122109737;3989.3417586097967;4354.129174165179;4464.1071785643;4480.61914737251;4554.749488778149;4587.3348364486965;5555.722213889289;5557.972210139004;5559.6664200148125;5574.9442505574425;5577.637453565505;1352.094096955023;1367.7606418876658;1368.3021658954005;1369.8082268482422;1377.5247539598822;878.4114643188951;915.5879854065697;919.8114386550741;920.0219528014821;930.15356026016;4853.611711063107;4874.610031197496;4886.657933944661;4889.511048895082;4900.705957642553;5719.996002798058;5737.540996720252;5745.396733343023;5748.252727145528;5748.540116790647;4711.858644240679;4878.9512104878495;4883.731394773251;4919.877003074952;4921.212605983025;3018.2605261710582;3031.77261705373;3041.574179614856;3047.8628461719277;3055.801372910754;5320;5366.490183432567;5403.35159780821;5405.243325903817;5415.83752487426;5918.319393269743;5938.673372964528;5941.227640406806;5952.196453478811;5953.880922381528;5404.729763511808;5405.3513578369275;5407.45925407464;5412.945870541323;5428.891422171534;5597.80407685729;5670.497318210595;5694.345150307768;5729.3984131665575;5763.193152958505;5356.919646205388;5603.215549822947;5628.943710563006;5633.4084921082695;5644.858878527905;5070.4676009019995;5254.500822421864;5271.051210782096;5273.551748101301;5282.524572788468;3818.1409182933617;3861.343571592892;3896.551896531935;3910.6675932546054;3911.491506104302;5622.798911007384;5709.714514274353;5716.42835716425;5747.1379293106365;5770.422957704196;5487.835364939058;5487.917681234864;5496.532794712494;5508.91736623959;5550.222968784454;5505.174223866452;5520.613557050968;5532.695701736282;5533.3083364579425;5539.806106786405;5238.4237733850005;5432.864178395414;5478.397376288525;5507.311586051744;5514.200440936122;5618.550515958796;5622.156676498558;5629.943700562942;5631;5641.887162256649;5356.919646205388;5464.890702185855;5477.342718873601;5490.039243132356;5501.587380946525 14:42:48 INFO - PID 11150 | |5;yui.html;740.5704691279057;762.9885551716728;764.9655765490551;770.0528350129341;776.0377132355877;13440;14413.711725765479;14424.350904209323;14433.494827681034;14515;13801.792973105412;14596.343164557595;14643.487477938248;14677.779833302482;14801.851981480182;893.6246776353947;912.6623149434719;915.3592485260311;915.4827522449795;916.0610374366262;918.4305730447098;919.1865199298635;919.3518569408551;919.7792529792869;920.1166879795371;973.1047436358567;975.8975307592707;975.9170470510015;976.4678250353575;976.9755756106118;959.6976952260051;960.0495509445668;961.024560071528;963.1764841060897;969.6170012844957;699.0632552379835;705.2524324216347;708.1077841919167;708.4261747984149;718.8885722712988;14461.20463374514;14596.562103136923;14769.852301476954;14774;14777.630559236106;15418.53744387659;15447.382104715798;15844;15846.524604261775;15926.681466370723;12664.303463309514;12921;12950;12955.417006234742;12969.286689232089;2910.2287893708185;2984;3007.6691563927952;3020.41101985113;3020.909372718822;66501;67050;67461;69118.65440672815;69215;12371.907023244188;12424.06819488542;12441.875581244252;12477.875221247852;12535.749285014248;22874.771252287595;23076.884615576815;23417.297481075595;23477.17829875946;23484;6034.577579569475;6087.086936959403;6096.9390306096375;6102.206713127353;6122.632642041492;2547.3249588858966;2605.0491570576605;2608.765211131007;2623.9081632142784;2631.0659715801;4151.252774500619;4272.829086836492;4293.3989241506215;4293.463317085364;4295.140971805651;710.6837457331438;733.4022771441258;749.5427789048676;749.5952185819706;750.5159172333814;578.8842231553706;583.6760597868139;591.8579540910237;598.9071693887367;611.9235095613049;9263;9465.195458386115;10190.286679932333;10206;10524.684259472075;608.327797783443;618.9690515474208;620.1008537620469;625.7434451874709;637.2162240444279;4269.124829409963;4352.564743525685;4352.760598167131;4379.58393952574;4402.427684401007;65611;66240.33759662438;66566.33433665698;66866.33133668698;67614.90043545455;54174.187387189224;55147.448525515036;56498.717506412206;57221.71389143028;60338.69830650819;38064.61935380666;46815.531844681114;47781.9999999993;48079.75960120177;48251.517484824704;10129.442880641636;10860.402677852793;10963;10974.945125274322;10993.217950191693;25497.745022549538;25550.872245638653;25869;27153;27276.31809204786;30701.692983070778;31023.224419389695;31232.531512027792;31712.36575268528;31842.84078579592;13161;13257.469701211843;13555.118917270345;13567.660808479866;13912.095713778572;15085.773713394527;15263.465778697693;15459.149746763585;15470.381184752483;15773.763393549336;13218.60344189676;13321.33393330349;13374.9331253347;13506.729865402833;13632.727345453233;13944.302784860514;14191.148531088167;14212.502562410265;14858.777118343018;14932.552023439313;12585.748285034066;12735.299558523999;13495.122817016863;14077.577672669837;14144.363503642566;10736.409497477714;10798.784024319313;11017.83473247886;11021.173411994292;11028.5037173329;10672.57309707603;10850.511726972147;11099.611513596985;11195.72010699739;11238.100951923663 14:42:48 INFO - PID 11150 | __end_tp_report 14:42:48 INFO - PID 11150 | __start_cc_report 14:42:48 INFO - PID 11150 | _x_x_mozilla_cycle_collect,2713 14:42:48 INFO - PID 11150 | __end_cc_report 14:42:48 INFO - PID 11150 | __startTimestamp1493847768953__endTimestamp 14:42:48 INFO - PID 11150 | 14:42:48 INFO - PID 11150 | ------- Summary: start ------- 14:42:48 INFO - PID 11150 | Number of tests: 6 14:42:48 INFO - PID 11150 | 14:42:48 INFO - PID 11150 | [#0] dojo.html Cycles:165 Average:5130.16 Median:5297.34 stddev:605.89 (11.4%) stddev-sans-first:577.00 14:42:48 INFO - PID 11150 | Values: 2700.9 2707.9 2747.6 2751.0 2762.1 5110.0 5212.5 5232.0 5238.9 5285.5 5148.3 5153.1 5226.3 5231.3 5297.3 4362.6 4579.3 4613.2 4721.1 4727.7 4664.5 4680.6 4691.5 4691.6 4709.6 4498.7 4503.0 4548.7 4628.6 4633.3 4628.4 4636.9 4637.8 4659.4 4700.5 4588.9 4609.9 4619.4 4655.4 4663.4 5062.4 5137.9 5138.7 5148.7 5164.0 5588.4 5672.3 5723.8 5725.4 5728.2 5628.7 5628.9 5629.3 5635.5 5638.6 5167.8 5220.5 5225.4 5237.1 5282.9 5705.7 5763.3 5857.6 5860.8 5863.1 5519.5 5545.4 5615.2 5622.3 5623.0 5607.6 5647.5 5668.3 5673.5 5682.1 5520.5 5619.7 5621.5 5627.0 5630.3 5571.7 5574.4 5574.6 5581.6 5583.2 4536.0 4625.3 4634.2 4634.8 4637.3 3991.3 4008.4 4026.1 4077.7 4079.3 4765.5 4785.9 4786.5 4790.5 4855.5 5529.3 5628.0 5646.4 5649.9 5694.6 4713.6 4743.3 4747.0 4811.7 4813.2 4997.6 4999.8 5001.2 5012.0 5048.5 5225.9 5259.3 5266.8 5276.0 5299.2 5511.8 5558.5 5636.4 5637.4 5681.7 5271.9 5272.4 5291.2 5317.1 5324.4 5566.9 5567.7 5568.3 5578.5 5584.2 5549.9 5640.6 5646.4 5648.3 5717.5 5308.8 5371.2 5371.3 5374.0 5377.2 5319.0 5359.8 5360.0 5363.2 5368.4 5291.2 5300.8 5303.2 5303.4 5303.6 5403.1 5413.2 5415.5 5417.9 5444.9 5397.7 5405.2 5427.9 5449.9 5454.3 14:42:48 INFO - PID 11150 | 14:42:48 INFO - PID 11150 | [#1] ext.html Cycles:180 Average:29413.68 Median:29202.99 stddev:38777.07 (132.8%) stddev-sans-first:38825.94 14:42:48 INFO - PID 11150 | Values: 707.1 732.2 1041.2 1081.7 1085.5 30473.0 33660.2 33662.0 33754.8 33799.2 34941.5 35414.3 35431.5 35431.8 35473.0 5242.1 6964.2 7115.4 7124.8 7125.5 5286.3 5408.0 5408.1 6861.8 7036.3 7108.5 7136.7 7153.4 7153.6 7153.7 7088.9 7140.6 7142.2 7142.8 7144.0 5259.7 5389.5 6846.5 6992.4 7035.8 32038.8 32377.7 32394.5 32414.4 32444.8 3048.9 3087.7 3089.7 3090.0 3090.3 24195.2 24204.6 24252.9 24272.0 24288.0 2916.0 2953.4 2968.0 2969.2 2987.9 143453.0 143829.0 143849.0 144114.0 144541.0 35318.3 36246.8 41542.8 41710.6 41750.4 42640.4 43844.8 43909.3 43950.8 44057.3 12634.8 12711.1 12714.8 12744.9 12757.4 10245.0 10252.9 10270.8 10275.6 10315.4 11869.3 11932.6 11949.9 12016.3 12092.9 4895.0 4974.8 4991.6 5051.7 5054.3 903.7 926.1 930.8 935.9 961.1 20554.8 21603.9 21627.5 21643.6 21759.1 1007.5 1014.6 1024.9 1028.2 1031.1 11124.8 11143.1 11329.0 11423.5 11500.5 161098.0 161213.2 161345.0 161397.0 161726.0 35705.5 35990.6 36025.5 36054.3 36188.5 1217.1 1264.6 1268.5 1283.7 1285.5 20060.7 20255.9 20884.2 21122.8 21450.9 29131.9 29193.3 29212.7 29299.0 29300.6 145177.0 145524.0 145565.3 146153.0 146513.0 28463.3 28701.0 28912.4 28944.7 28992.1 34138.8 34935.7 34938.3 35265.1 35416.6 25976.0 26562.9 27098.0 27414.5 27472.6 26890.6 27005.5 27311.9 27676.6 28260.6 30169.4 30311.0 30324.2 30341.0 30397.7 26561.2 26673.5 26780.6 27458.7 27837.0 21200.8 21757.8 21949.1 22768.3 23431.3 14:42:48 INFO - PID 11150 | 14:42:48 INFO - PID 11150 | [#2] jquery.html Cycles:180 Average:25942.92 Median:405548.00 stddev:66602.10 (16.4%) stddev-sans-first:66761.36 14:42:48 INFO - PID 11150 | Values: 417.9 424.2 427.7 436.2 439.3 17553.6 17646.4 18183.0 18270.6 18352.0 17526.8 17622.7 17643.9 17805.2 18668.8 5145.3 5335.4 5359.8 5362.4 5399.7 5217.5 5311.1 5346.4 5351.0 5351.8 5402.4 5419.6 5423.8 5425.1 5430.8 5263.7 5313.1 5415.2 5418.5 5420.5 4791.0 4797.9 4807.0 4808.2 4809.7 21651.0 21794.2 21831.2 22271.6 22465.2 1609.1 1644.6 1651.0 1655.1 1658.6 14218.3 14331.8 14655.2 14656.4 14813.9 2048.0 2085.3 2111.4 2118.2 2133.7 70513.0 88418.0 91357.0 93327.5 93447.1 10564.3 10577.4 10595.6 10732.5 10830.9 15196.1 15242.5 15244.7 15249.8 15268.4 7350.9 7418.3 7505.5 7694.4 7707.4 6687.5 6738.2 6744.7 6877.3 6913.8 6890.0 6968.7 7031.4 7063.1 7173.5 1930.7 1948.9 1955.0 1985.8 2067.7 880.4 902.4 904.7 912.8 937.6 16517.7 16518.8 16680.8 17080.7 17422.2 863.6 900.7 906.9 909.7 912.8 8667.5 9423.9 9455.1 9513.1 9606.4 391675.0 395355.0 405275.0 405821.0 407132.0 81742.6 83678.0 83855.0 84194.2 84533.2 1065.3 1068.3 1114.6 1120.1 1123.9 16926.2 17367.0 17628.4 17821.3 17867.0 39484.4 39734.4 39803.8 41637.2 42050.8 47516.5 47572.0 47625.5 48724.3 49508.0 8164.7 8168.1 8394.4 8519.9 8932.3 12656.8 12898.4 13043.9 13058.2 13097.8 11272.2 11273.1 11558.7 11649.0 11729.8 10426.3 10462.6 10530.8 10596.3 10632.5 11063.6 11306.5 11381.3 11412.9 12032.5 8345.5 8421.0 8424.2 8600.9 8789.1 10623.4 11115.7 11268.2 11353.5 11417.9 14:42:48 INFO - PID 11150 | 14:42:48 INFO - PID 11150 | [#3] mootools.html Cycles:180 Average:6205.13 Median:3636.36 stddev:4001.24 (110.0%) stddev-sans-first:3995.26 14:42:48 INFO - PID 11150 | Values: 1267.9 1298.3 1312.9 1320.2 1327.3 9703.1 10085.9 10130.7 10133.8 10143.1 9751.4 10272.6 10312.5 10320.1 10324.2 2187.2 2227.7 2227.9 2229.0 2233.8 1872.8 2115.3 2197.5 2199.7 2207.9 1940.7 2110.3 2198.6 2199.3 2207.9 2096.2 2115.2 2117.0 2124.8 2125.4 2057.6 2063.8 2064.8 2067.1 2068.8 9802.9 10030.9 10040.5 10044.3 10047.1 5459.1 5659.2 5660.0 5661.0 5662.7 3246.8 3389.7 3405.4 3421.7 3429.5 1050.4 1071.9 1120.0 1126.9 1127.5 14546.8 14647.4 14667.3 14677.7 14696.6 4497.6 4607.6 4751.1 4814.7 4832.1 10739.5 10772.6 10785.9 10786.1 10794.6 5631.3 5634.6 5639.3 5643.3 5649.3 4935.5 5019.5 5033.8 5050.6 5103.0 3671.2 3808.7 3823.4 3828.5 3875.0 1113.7 1115.1 1121.8 1136.5 1140.0 578.9 617.4 747.4 754.7 756.6 6084.3 6101.5 6118.1 6151.3 6305.0 857.9 864.0 871.3 880.5 881.1 3513.3 3569.2 3600.2 3601.5 3728.3 13138.3 13360.3 13578.6 13585.9 13600.2 12906.6 13097.3 13314.1 13320.1 13448.3 7581.7 7613.1 7731.0 7734.5 7743.8 5383.9 5559.5 5585.7 6441.6 6542.1 11540.7 11715.7 11887.3 12047.0 12058.8 11663.1 11988.9 12058.6 12137.2 12265.2 7844.4 8081.2 8103.8 8120.8 8191.5 9215.8 9266.4 9400.2 9410.4 9491.8 7687.2 7700.8 7961.8 7961.8 8035.2 7816.7 7830.3 7902.8 7984.3 8115.3 6859.2 6870.7 6955.6 6957.7 6960.8 4794.0 4839.3 4848.6 4957.8 4984.3 4815.1 4852.8 4925.7 4964.2 4993.5 14:42:48 INFO - PID 11150 | 14:42:48 INFO - PID 11150 | [#4] prototype.html Cycles:180 Average:4549.48 Median:5213.74 stddev:1355.24 (26.0%) stddev-sans-first:1322.25 14:42:48 INFO - PID 11150 | Values: 370.9 388.3 388.6 394.3 397.5 5273.1 5297.4 5309.5 5325.7 5343.0 5031.0 5155.3 5158.8 5188.1 5189.1 3964.3 3974.0 3976.4 3979.4 3991.9 3989.6 3993.8 3996.4 3998.1 4001.0 3766.4 3919.7 3924.7 3929.1 3953.3 3893.5 3896.1 3899.0 3902.6 3915.8 3403.3 3407.1 3408.8 3409.7 3413.6 4899.0 5016.2 5023.1 5037.0 5076.8 4579.9 4588.4 4603.7 4605.9 4623.9 5486.8 5502.8 5514.1 5517.0 5517.4 3767.6 3843.6 3844.0 3849.0 3850.4 5550.4 5687.7 5699.4 5719.3 5831.6 3878.6 3882.7 3904.2 3906.4 3934.4 3961.1 3970.1 3980.4 3981.5 3989.3 4354.1 4464.1 4480.6 4554.7 4587.3 5555.7 5558.0 5559.7 5574.9 5577.6 1352.1 1367.8 1368.3 1369.8 1377.5 878.4 915.6 919.8 920.0 930.2 4853.6 4874.6 4886.7 4889.5 4900.7 5720.0 5737.5 5745.4 5748.3 5748.5 4711.9 4879.0 4883.7 4919.9 4921.2 3018.3 3031.8 3041.6 3047.9 3055.8 5320.0 5366.5 5403.4 5405.2 5415.8 5918.3 5938.7 5941.2 5952.2 5953.9 5404.7 5405.4 5407.5 5412.9 5428.9 5597.8 5670.5 5694.3 5729.4 5763.2 5356.9 5603.2 5628.9 5633.4 5644.9 5070.5 5254.5 5271.1 5273.6 5282.5 3818.1 3861.3 3896.6 3910.7 3911.5 5622.8 5709.7 5716.4 5747.1 5770.4 5487.8 5487.9 5496.5 5508.9 5550.2 5505.2 5520.6 5532.7 5533.3 5539.8 5238.4 5432.9 5478.4 5507.3 5514.2 5618.6 5622.2 5629.9 5631.0 5641.9 5356.9 5464.9 5477.3 5490.0 5501.6 14:42:48 INFO - PID 11150 | 14:42:48 INFO - PID 11150 | [#5] yui.html Cycles:180 Average:15069.60 Median:3014.04 stddev:17642.57 (585.3%) stddev-sans-first:17659.25 14:42:48 INFO - PID 11150 | Values: 740.6 763.0 765.0 770.1 776.0 13440.0 14413.7 14424.4 14433.5 14515.0 13801.8 14596.3 14643.5 14677.8 14801.9 893.6 912.7 915.4 915.5 916.1 918.4 919.2 919.4 919.8 920.1 973.1 975.9 975.9 976.5 977.0 959.7 960.0 961.0 963.2 969.6 699.1 705.3 708.1 708.4 718.9 14461.2 14596.6 14769.9 14774.0 14777.6 15418.5 15447.4 15844.0 15846.5 15926.7 12664.3 12921.0 12950.0 12955.4 12969.3 2910.2 2984.0 3007.7 3020.4 3020.9 66501.0 67050.0 67461.0 69118.7 69215.0 12371.9 12424.1 12441.9 12477.9 12535.7 22874.8 23076.9 23417.3 23477.2 23484.0 6034.6 6087.1 6096.9 6102.2 6122.6 2547.3 2605.0 2608.8 2623.9 2631.1 4151.3 4272.8 4293.4 4293.5 4295.1 710.7 733.4 749.5 749.6 750.5 578.9 583.7 591.9 598.9 611.9 9263.0 9465.2 10190.3 10206.0 10524.7 608.3 619.0 620.1 625.7 637.2 4269.1 4352.6 4352.8 4379.6 4402.4 65611.0 66240.3 66566.3 66866.3 67614.9 54174.2 55147.4 56498.7 57221.7 60338.7 38064.6 46815.5 47782.0 48079.8 48251.5 10129.4 10860.4 10963.0 10974.9 10993.2 25497.7 25550.9 25869.0 27153.0 27276.3 30701.7 31023.2 31232.5 31712.4 31842.8 13161.0 13257.5 13555.1 13567.7 13912.1 15085.8 15263.5 15459.1 15470.4 15773.8 13218.6 13321.3 13374.9 13506.7 13632.7 13944.3 14191.1 14212.5 14858.8 14932.6 12585.7 12735.3 13495.1 14077.6 14144.4 10736.4 10798.8 11017.8 11021.2 11028.5 10672.6 10850.5 11099.6 11195.7 11238.1 14:42:48 INFO - PID 11150 | -------- Summary: end -------- 14:42:48 INFO - PID 11150 | 14:42:49 INFO - TEST-INFO | 11150: exit 0 14:42:49 INFO - TEST-OK | dromaeo_css | took 1123387ms 14:42:49 INFO - TEST-START | kraken 14:42:49 INFO - operating with platform_type : linux_ 14:42:49 INFO - Initialising browser for kraken test... 14:42:49 INFO - TEST-INFO | started process 11486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF7y5jH/profile http://localhost:43576/getInfo.html) 14:42:54 INFO - PID 11486 | __metrics Screen width/height:1600/1200 14:42:54 INFO - PID 11486 | colorDepth:24 14:42:54 INFO - PID 11486 | Browser inner width/height: 1024/695 14:42:54 INFO - PID 11486 | __metrics 14:42:55 INFO - PID 11486 | 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" 14:42:55 INFO - PID 11486 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:42:56 INFO - TEST-INFO | 11486: exit 0 14:42:56 INFO - Browser initialized. 14:42:56 INFO - Running cycle 1/1 for kraken test... 14:42:56 INFO - TEST-INFO | started process 11585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF7y5jH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:43:08 INFO - PID 11585 | RSS: Main: 168914944 14:43:08 INFO - PID 11585 | 14:43:10 INFO - PID 11585 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43576/tests/kraken/driver.html?testName=audio-beat-detection) 14:43:11 INFO - PID 11585 | RSS: Main: 244936704 14:43:11 INFO - PID 11585 | 14:43:14 INFO - PID 11585 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43576/tests/kraken/driver.html?testName=audio-dft) 14:43:15 INFO - PID 11585 | RSS: Main: 205856768 14:43:15 INFO - PID 11585 | 14:43:18 INFO - PID 11585 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43576/tests/kraken/driver.html?testName=audio-fft) 14:43:18 INFO - PID 11585 | RSS: Main: 290177024 14:43:18 INFO - PID 11585 | 14:43:21 INFO - PID 11585 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43576/tests/kraken/driver.html?testName=audio-oscillator) 14:43:21 INFO - PID 11585 | RSS: Main: 203100160 14:43:21 INFO - PID 11585 | 14:43:23 INFO - PID 11585 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43576/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:43:24 INFO - PID 11585 | RSS: Main: 204279808 14:43:24 INFO - PID 11585 | 14:43:27 INFO - PID 11585 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43576/tests/kraken/driver.html?testName=imaging-darkroom) 14:43:28 INFO - PID 11585 | RSS: Main: 265891840 14:43:28 INFO - PID 11585 | 14:43:31 INFO - PID 11585 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43576/tests/kraken/driver.html?testName=imaging-desaturate) 14:43:32 INFO - PID 11585 | RSS: Main: 263794688 14:43:32 INFO - PID 11585 | 14:43:35 INFO - PID 11585 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43576/tests/kraken/driver.html?testName=json-parse-financial) 14:43:35 INFO - PID 11585 | RSS: Main: 260960256 14:43:35 INFO - PID 11585 | 14:43:37 INFO - PID 11585 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43576/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:43:38 INFO - PID 11585 | RSS: Main: 226525184 14:43:38 INFO - PID 11585 | 14:43:39 INFO - PID 11585 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43576/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:43:40 INFO - PID 11585 | RSS: Main: 232288256 14:43:40 INFO - PID 11585 | 14:43:42 INFO - PID 11585 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43576/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:43:43 INFO - PID 11585 | RSS: Main: 242028544 14:43:43 INFO - PID 11585 | 14:43:45 INFO - PID 11585 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43576/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:43:46 INFO - PID 11585 | RSS: Main: 249663488 14:43:46 INFO - PID 11585 | 14:43:49 INFO - PID 11585 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43576/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:43:50 INFO - PID 11585 | RSS: Main: 225595392 14:43:50 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | Cycle 1(1): loaded http://localhost:43576/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43576/tests/kraken/driver.html?testName=ai-astar) 14:43:52 INFO - PID 11585 | RSS: Main: 294780928 14:43:52 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | __start_tp_report 14:43:52 INFO - PID 11585 | _x_x_mozilla_page_load 14:43:52 INFO - PID 11585 | _x_x_mozilla_page_load_details 14:43:52 INFO - PID 11585 | |i|pagename|runs| 14:43:52 INFO - PID 11585 | |0;ai-astar;107;111;111;112;110;111;111;110;111;111 14:43:52 INFO - PID 11585 | |1;audio-beat-detection;155;121;123;179;122;121;121;122;144;121 14:43:52 INFO - PID 11585 | |2;audio-dft;161;164;162;163;163;163;162;163;163;162 14:43:52 INFO - PID 11585 | |3;audio-fft;74;75;75;103;74;83;75;75;95;74 14:43:52 INFO - PID 11585 | |4;audio-oscillator;82;82;109;82;83;83;101;83;82;102 14:43:52 INFO - PID 11585 | |5;imaging-gaussian-blur;113;113;113;112;113;114;113;113;114;113 14:43:52 INFO - PID 11585 | |6;imaging-darkroom;148;149;148;148;148;149;150;149;150;149 14:43:52 INFO - PID 11585 | |7;imaging-desaturate;93;94;94;93;93;94;93;94;94;93 14:43:52 INFO - PID 11585 | |8;json-parse-financial;56;56;53;52;53;54;53;53;54;55 14:43:52 INFO - PID 11585 | |9;json-stringify-tinderbox;55;55;54;56;55;55;55;55;54;55 14:43:52 INFO - PID 11585 | |10;stanford-crypto-aes;81;81;80;81;81;80;80;80;81;80 14:43:52 INFO - PID 11585 | |11;stanford-crypto-ccm;131;137;128;129;136;127;127;127;174;135 14:43:52 INFO - PID 11585 | |12;stanford-crypto-pbkdf2;179;192;187;194;189;188;181;187;184;189 14:43:52 INFO - PID 11585 | |13;stanford-crypto-sha256-iterative;71;71;73;71;70;68;69;68;75;72 14:43:52 INFO - PID 11585 | __end_tp_report 14:43:52 INFO - PID 11585 | __start_cc_report 14:43:52 INFO - PID 11585 | _x_x_mozilla_cycle_collect,1999 14:43:52 INFO - PID 11585 | __end_cc_report 14:43:52 INFO - PID 11585 | __startTimestamp1493847832555__endTimestamp 14:43:52 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | ------- Summary: start ------- 14:43:52 INFO - PID 11585 | Number of tests: 14 14:43:52 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.35 (1.2%) stddev-sans-first:0.60 14:43:52 INFO - PID 11585 | Values: 107.0 111.0 111.0 112.0 110.0 111.0 111.0 110.0 111.0 111.0 14:43:52 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:122.50 stddev:20.11 (16.4%) stddev-sans-first:19.67 14:43:52 INFO - PID 11585 | Values: 155.0 121.0 123.0 179.0 122.0 121.0 121.0 122.0 144.0 121.0 14:43:52 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:0.84 (0.5%) stddev-sans-first:0.67 14:43:52 INFO - PID 11585 | Values: 161.0 164.0 162.0 163.0 163.0 163.0 162.0 163.0 163.0 162.0 14:43:52 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:10.38 (13.8%) stddev-sans-first:10.76 14:43:52 INFO - PID 11585 | Values: 74.0 75.0 75.0 103.0 74.0 83.0 75.0 75.0 95.0 74.0 14:43:52 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:82.00 stddev:10.63 (13.0%) stddev-sans-first:10.98 14:43:52 INFO - PID 11585 | Values: 82.0 82.0 109.0 82.0 83.0 83.0 101.0 83.0 82.0 102.0 14:43:52 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 14:43:52 INFO - PID 11585 | Values: 113.0 113.0 113.0 112.0 113.0 114.0 113.0 113.0 114.0 113.0 14:43:52 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 14:43:52 INFO - PID 11585 | Values: 148.0 149.0 148.0 148.0 148.0 149.0 150.0 149.0 150.0 149.0 14:43:52 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:94.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 14:43:52 INFO - PID 11585 | Values: 93.0 94.0 94.0 93.0 93.0 94.0 93.0 94.0 94.0 93.0 14:43:52 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.37 (2.5%) stddev-sans-first:1.22 14:43:52 INFO - PID 11585 | Values: 56.0 56.0 53.0 52.0 53.0 54.0 53.0 53.0 54.0 55.0 14:43:52 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:55.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 14:43:52 INFO - PID 11585 | Values: 55.0 55.0 54.0 56.0 55.0 55.0 55.0 55.0 54.0 55.0 14:43:52 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:81.00 stddev:0.53 (0.7%) stddev-sans-first:0.53 14:43:52 INFO - PID 11585 | Values: 81.0 81.0 80.0 81.0 81.0 80.0 80.0 80.0 81.0 80.0 14:43:52 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:133.00 stddev:14.22 (10.7%) stddev-sans-first:15.00 14:43:52 INFO - PID 11585 | Values: 131.0 137.0 128.0 129.0 136.0 127.0 127.0 127.0 174.0 135.0 14:43:52 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.00 Median:188.50 stddev:4.62 (2.5%) stddev-sans-first:3.89 14:43:52 INFO - PID 11585 | Values: 179.0 192.0 187.0 194.0 189.0 188.0 181.0 187.0 184.0 189.0 14:43:52 INFO - PID 11585 | 14:43:52 INFO - PID 11585 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:2.20 (3.1%) stddev-sans-first:2.33 14:43:52 INFO - PID 11585 | Values: 71.0 71.0 73.0 71.0 70.0 68.0 69.0 68.0 75.0 72.0 14:43:52 INFO - PID 11585 | -------- Summary: end -------- 14:43:52 INFO - PID 11585 | 14:43:53 INFO - TEST-INFO | 11585: exit 0 14:43:53 INFO - TEST-OK | kraken | took 64058ms 14:43:53 INFO - SUITE-END | took 1187s 14:43:54 INFO - Completed test suite (00:19:47) 14:43:54 INFO - javascript benchmark 14:43:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6639.642975242928, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2700.8514531700753, 2707.891684332627, 2747.6290700755403, 2750.9587356189672, 2762.074704973833, 5110.0, 5212.504812042859, 5231.973840130799, 5238.895222095556, 5285.524302812742, 5148.279240906276, 5153.149730294497, 5226.320578324812, 5231.267622532839, 5297.337832770903, 4362.5637436256275, 4579.267317229244, 4613.169629466703, 4721.126591580552, 4727.692699974491, 4664.510226426227, 4680.625549955996, 4691.507391723854, 4691.554302341272, 4709.62323014158, 4498.685092043558, 4502.954970450319, 4548.727076375428, 4628.583427491509, 4633.32816741574, 4628.421447319085, 4636.86089417318, 4637.837675681335, 4659.4175728034, 4700.482946875841, 4588.862334129982, 4609.884752881171, 4619.3994780678295, 4655.3947986761505, 4663.417072865892, 5062.443131255559, 5137.897242055175, 5138.7173705446185, 5148.6910785353, 5164.044651739403, 5588.385277619459, 5672.319321681383, 5723.771049158028, 5725.427457254283, 5728.226689396962, 5628.662280263197, 5628.859278518029, 5629.268195134607, 5635.520980716644, 5638.605297629168, 5167.767450464663, 5220.451852555427, 5225.425203227642, 5237.109691352479, 5282.920756188661, 5705.7147142643535, 5763.337216220189, 5857.560682948711, 5860.824175274749, 5863.091220860773, 5519.530839878575, 5545.362283337387, 5615.157726341082, 5622.269105016322, 5623.0159722048475, 5607.607467477237, 5647.548196144298, 5668.26312579362, 5673.489385955284, 5682.119271512922, 5520.530754885799, 5619.662820230799, 5621.522170615462, 5627.0, 5630.324361076697, 5571.749271282721, 5574.442555744474, 5574.637648552831, 5581.553475721932, 5583.190437386637, 4536.047430039728, 4625.32932724753, 4634.189016922025, 4634.768261586907, 4637.281221410687, 3991.341428664296, 4008.3586626139677, 4026.074002979273, 4077.653399461079, 4079.265732168179, 4765.523447655207, 4785.856424307207, 4786.497417771154, 4790.520947905182, 4855.5387238212315, 5529.30883639545, 5628.04323265046, 5646.350669672958, 5649.858753531194, 5694.629849059798, 4713.552212539803, 4743.335932969387, 4746.976265118721, 4811.735354555463, 4813.205821039559, 4997.575206107449, 4999.775010124553, 5001.199808030698, 5011.974940125276, 5048.469910659402, 5225.895482090261, 5259.342582177228, 5266.8419947401635, 5276.0, 5299.178627312773, 5511.807086751945, 5558.471945165203, 5636.408177141505, 5637.351704554028, 5681.744321505459, 5271.894562108813, 5272.367315922113, 5291.232771248225, 5317.1492561190025, 5324.440933702061, 5566.888662226814, 5567.693776842312, 5568.331800183842, 5578.470045345685, 5584.190292407659, 5549.944500555104, 5640.633358831663, 5646.3506696728755, 5648.293963254593, 5717.514011309086, 5308.840734777963, 5371.221172929982, 5371.301730775131, 5373.9731301343245, 5377.193420986883, 5319.0, 5359.785608575613, 5360.035193665178, 5363.249145119765, 5368.382635996911, 5291.1798671206025, 5300.787968481218, 5303.15149576066, 5303.36359636846, 5303.602229832701, 5403.108487099585, 5413.160960051198, 5415.458454154553, 5417.891642167214, 5444.918326225189, 5397.730113494388, 5405.216243644571, 5427.891442171213, 5449.945500544944, 5454.263674404064], "value": 5086.306416214818, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.1372925031461, 732.1945859554489, 1041.187873458702, 1081.6809041332806, 1085.489819784701, 30473.0, 33660.15849603761, 33662.0, 33754.83122584384, 33799.15502112448, 34941.47587786185, 35414.2917141657, 35431.4685279721, 35431.82284088576, 35473.0, 5242.135047717122, 6964.233934267239, 7115.39519140871, 7124.821879453003, 7125.465590080738, 5286.286351342558, 5408.0, 5408.107662235746, 6861.794146175623, 7036.296370362948, 7108.537945033582, 7136.678849451761, 7153.356197942184, 7153.6065516396575, 7153.6780844862105, 7088.929110708878, 7140.607266600335, 7142.178649455302, 7142.821429464253, 7144.0, 5259.684418934838, 5389.487998640123, 6846.486513511507, 6992.370686638227, 7035.824104397379, 32038.839805801053, 32377.676223237937, 32394.514082288784, 32414.351712965843, 32444.837775811207, 3048.8932887348838, 3087.7375423089065, 3089.691030896915, 3089.9691003089906, 3090.3201295714907, 24195.153169639154, 24204.636930446057, 24252.878735606384, 24272.0, 24288.0, 2916.0377075565225, 2953.438846619157, 2968.0205532174546, 2969.1834745445176, 2987.8954236601617, 143453.0, 143829.0, 143849.0, 144114.0, 144541.0, 35318.29363412717, 36246.83161436469, 41542.79228603838, 41710.582894171275, 41750.37374439325, 42640.36039459411, 43844.78077609655, 43909.341359879625, 43950.78024609856, 44057.339139912925, 12634.81047784284, 12711.110222284351, 12714.809277860839, 12744.872551274553, 12757.42591583381, 10245.026722461354, 10252.897471025344, 10270.845937310947, 10275.588976441008, 10315.381077135246, 11869.287842729464, 11932.582359617372, 11949.940250298692, 12016.279023258632, 12092.939535302266, 4895.0, 4974.801007959641, 4991.600671946236, 5051.747412629354, 5054.317667114966, 903.6520939438363, 926.1155596405416, 930.8045310484739, 935.934484586086, 961.0917682789697, 20554.79445205529, 21603.891980539996, 21627.459313517287, 21643.593166444447, 21759.12963481443, 1007.5264625625944, 1014.6245889020962, 1024.8770147582338, 1028.2185538990273, 1031.0617338222182, 11124.833127503094, 11143.052840508648, 11329.0, 11423.485943132579, 11500.53997840077, 161098.0, 161213.19393402958, 161345.0, 161397.0, 161726.0, 35705.46441803375, 35990.640093598726, 36025.45961810575, 36054.278914421564, 36188.45717314242, 1217.1054275107788, 1264.6016504800957, 1268.4862630634607, 1283.736833949038, 1285.5243559882715, 20060.69908951396, 20255.898720506302, 20884.164633414493, 21122.788772112082, 21450.892745536174, 29131.85434072901, 29193.270168245963, 29212.70787292185, 29299.0, 29300.56049159307, 145177.0, 145524.0, 145565.27217363846, 146153.0, 146513.0, 28463.288417788892, 28701.0, 28912.42175156443, 28944.7105528942, 28992.13023609295, 34138.82930585331, 34935.65064349324, 34938.30123397569, 35265.1183720409, 35416.64583354237, 25976.0, 26562.86718566395, 27098.0, 27414.451710966066, 27472.58791118175, 26890.596641050008, 27005.459890802467, 27311.863440682668, 27676.584851226846, 28260.576091359057, 30169.396612067198, 30311.0, 30324.24189395283, 30341.0, 30397.69602304037, 26561.203163905113, 26673.466530669666, 26780.59829102526, 27458.725412746415, 27837.0, 21200.7879921205, 21757.840809696365, 21949.122035119057, 22768.316950491513, 23431.297061088193], "value": 14303.27961194405, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.9456670632821, 424.1993832426945, 427.68137737385655, 436.2300539547698, 439.3322150331496, 17553.56116097098, 17646.38237661682, 18183.0, 18270.634587308246, 18352.0, 17526.82473175268, 17622.735658965124, 17643.91178044111, 17805.198766055528, 18668.813311866877, 5145.253938178962, 5335.386430560497, 5359.812406565771, 5362.410134885159, 5399.676019438826, 5217.530422261995, 5311.097113490716, 5346.358436987567, 5350.973245133769, 5351.785928562853, 5402.37872644647, 5419.566434685235, 5423.755930983115, 5425.104857698495, 5430.83707488776, 5263.710495922723, 5313.149896016657, 5415.187721841736, 5418.539424148932, 5420.457954204588, 4791.0, 4797.856064318076, 4806.951930480685, 4808.158572249878, 4809.687370320953, 21651.0, 21794.237201698023, 21831.235906743186, 22271.550129485742, 22465.213717519808, 1609.0828227910097, 1644.629958259394, 1650.983490165095, 1655.106242628991, 1658.5687721192455, 14218.28908554568, 14331.78502322466, 14655.193964331958, 14656.41374345025, 14813.851861481355, 2047.9590408191752, 2085.3326935380683, 2111.448085657041, 2118.1844989679084, 2133.679948007811, 70513.0, 88418.0, 91357.0, 93327.53336233276, 93447.0655293452, 10564.260501764957, 10577.418241996611, 10595.576176952836, 10732.463376831127, 10830.945845270724, 15196.088234705952, 15242.542723718307, 15244.695106097815, 15249.847501525064, 15268.3892644293, 7350.926490735131, 7418.258174182646, 7505.512141710771, 7694.422918281151, 7707.383409327353, 6687.465002799764, 6738.157730283715, 6744.696488658022, 6877.277885822016, 6913.827154321182, 6889.9644663519275, 6968.651567421609, 7031.437485001187, 7063.117110361205, 7173.533720308267, 1930.7296978423033, 1948.8928108954144, 1955.0, 1985.7815640279846, 2067.7311949446776, 880.366136381804, 902.3953950852945, 904.7150147703584, 912.8083102548406, 937.6404213889887, 16517.669646607, 16518.75221871673, 16680.833191667927, 17080.658386832194, 17422.21600028002, 863.5984267315729, 900.6937641202023, 906.9047749986288, 909.7225346269452, 912.8311262416474, 8667.523286219192, 9423.905760942303, 9455.149036586603, 9513.096255855682, 9606.375585586915, 391675.0, 395355.0, 405275.0, 405821.0, 407132.0, 81742.59128704318, 83678.0, 83855.0, 84194.15805841863, 84533.15466845376, 1065.338072606736, 1068.2735739696925, 1114.57089020726, 1120.1430905357245, 1123.8707548632012, 16926.238319275908, 17367.0, 17628.383006594708, 17821.287148513915, 17867.0, 39484.40773388344, 39734.40398394084, 39803.80098099491, 41637.167256654095, 42050.78974605107, 47516.52483475121, 47572.0, 47625.52374476349, 48724.26913596228, 49508.0, 8164.673413063411, 8168.142345053684, 8394.412391132562, 8519.91480085216, 8932.28541716674, 12656.810147847606, 12898.41957111951, 13043.934780326037, 13058.21650700961, 13097.803532947204, 11272.210945233755, 11273.098152147644, 11558.711032224262, 11649.0, 11729.824052639387, 10426.322289051188, 10462.581496740046, 10530.78938421212, 10596.258261921592, 10632.468376581295, 11063.612773552886, 11306.547738090714, 11381.317120972768, 11412.885871141183, 12032.458539365925, 8345.499270043816, 8420.957895210484, 8424.199701028392, 8600.913990860012, 8789.077146899483, 10623.415712135908, 11115.72210694739, 11268.154888383568, 11353.54585816558, 11417.942910285396], "value": 8885.167337758387, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1267.8668739782324, 1298.3186773128798, 1312.9146605470644, 1320.2012782266725, 1327.3495986966377, 9703.126718595326, 10085.899141008578, 10130.746731331712, 10133.847992280122, 10143.13783328418, 9751.366161199534, 10272.640457583986, 10312.535935882885, 10320.122789562896, 10324.174066074715, 2187.2016713899393, 2227.654713519399, 2227.888605569723, 2229.0, 2233.810126139272, 1872.7659042619673, 2115.2596591193114, 2197.461621902628, 2199.681046248293, 2207.87856667884, 1940.7380003699461, 2110.303599812058, 2198.6152423325852, 2199.285232299501, 2207.86752794832, 2096.1615353858424, 2115.217369573252, 2117.0050076464113, 2124.808767210951, 2125.4367592587823, 2057.609054279682, 2063.772984971652, 2064.7728749837506, 2067.0904801887123, 2068.834493240537, 9802.90197098027, 10030.9498452508, 10040.548175332127, 10044.296899217057, 10047.09576138151, 5459.12653975362, 5659.236003139565, 5660.009498337816, 5661.037623603997, 5662.745176467028, 3246.788958717676, 3389.74576906733, 3405.3529829332597, 3421.6578342165835, 3429.5027221053056, 1050.3960222871879, 1071.9410432426214, 1119.9888001119966, 1126.881677423867, 1127.4531852051748, 14546.781798273034, 14647.414103435744, 14667.266636668124, 14677.706445871023, 14696.632584185374, 4497.572730590654, 4607.6083532900075, 4751.073540659608, 4814.711117332901, 4832.106060378771, 10739.516721747541, 10772.622958196425, 10785.946070269756, 10786.083182929382, 10794.568217271379, 5631.324241091095, 5634.605577609528, 5639.295088113986, 5643.294588176478, 5649.293838270216, 4935.457099719028, 5019.548240658358, 5033.84898453047, 5050.570701490341, 5103.0, 3671.1923376857585, 3808.676262517717, 3823.3500304948225, 3828.502294701671, 3874.9806250968563, 1113.7104352868312, 1115.1079136690614, 1121.786860496503, 1136.4658610453073, 1139.9943000284945, 578.9102689083198, 617.4381313005143, 747.4207489195917, 754.6943487887414, 756.6481586062507, 6084.269887613426, 6101.542384321194, 6118.112873633388, 6151.2618485781095, 6304.968475157595, 857.9313654907593, 864.0365991918965, 871.3073106880046, 880.4673172730406, 881.0660699658255, 3513.2797776455764, 3569.232614987738, 3600.2439487707875, 3601.5318008658705, 3728.2729867676085, 13138.343082845819, 13360.331983400985, 13578.592642220749, 13585.932070339783, 13600.183988960496, 12906.612801615967, 13097.279649619171, 13314.06801523884, 13320.134191277535, 13448.260345681081, 7581.658825352873, 7613.124490683532, 7731.0, 7734.458587898793, 7743.845123097506, 5383.9192412114635, 5559.471850174227, 5585.720713964204, 6441.581297215666, 6542.149520562297, 11540.711482213012, 11715.707107322385, 11887.28676279426, 12047.036237101187, 12058.75882482363, 11663.125265605284, 11988.940055299669, 12058.638240852788, 12137.21108127969, 12265.202761820454, 7844.372450203856, 8081.232282933112, 8103.797405064684, 8120.83758324842, 8191.549464779494, 9215.815683686424, 9266.44401335922, 9400.15398614128, 9410.38832475887, 9491.810163796823, 7687.154413014452, 7700.768976930701, 7961.800954976172, 7961.840763184588, 8035.156308587748, 7816.7264145754625, 7830.33442157423, 7902.802429939067, 7984.321332686786, 8115.269625733712, 6859.176898772179, 6870.728915150713, 6955.617441040791, 6957.721691132298, 6960.79117626472, 4793.993261415142, 4839.322494850653, 4848.636352273523, 4957.82647607332, 4984.327115839315, 4815.085133824702, 4852.805887764591, 4925.729084900365, 4964.180910149929, 4993.500649934977], "value": 4677.676820034377, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.9369407200776, 388.3436991484392, 388.60944750525715, 394.33357625612695, 397.49716608490246, 5273.1035723926925, 5297.390800057985, 5309.522143007138, 5325.680459172448, 5343.0, 5031.0, 5155.329807125077, 5158.787684894047, 5188.118019936611, 5189.065968125736, 3964.326064569023, 3973.9667686401453, 3976.383660532622, 3979.3986442269647, 3991.8602848900296, 3989.601039896016, 3993.760374377532, 3996.3805610130476, 3998.0804414984573, 4001.0, 3766.435034744783, 3919.6668283195963, 3924.666403355704, 3929.0570263136783, 3953.327934251184, 3893.4743809585625, 3896.0649444133205, 3898.961010389902, 3902.5512066112333, 3915.8237879295502, 3403.285310084885, 3407.063057659139, 3408.7613867029318, 3409.7272218222483, 3413.6245013048547, 4898.951010489885, 5016.2224855147515, 5023.146065168893, 5037.0, 5076.847694569169, 4579.885502862422, 4588.449386073693, 4603.723776573416, 4605.907881842344, 4623.930641040387, 5486.753096110685, 5502.752376143083, 5514.117741161395, 5516.972415137899, 5517.44825517449, 3767.6059857852497, 3843.596422375638, 3843.98078009611, 3849.0185002824383, 3850.4416859555486, 5550.417206193332, 5687.658740475585, 5699.401562835926, 5719.285089363788, 5831.591788574801, 3878.631530004645, 3882.7282090253975, 3904.2386734586485, 3906.4179007502007, 3934.3508321127265, 3961.1483531040963, 3970.1067259866877, 3980.44273801668, 3981.5023122109737, 3989.3417586097967, 4354.129174165179, 4464.1071785643, 4480.61914737251, 4554.749488778149, 4587.3348364486965, 5555.722213889289, 5557.972210139004, 5559.6664200148125, 5574.9442505574425, 5577.637453565505, 1352.094096955023, 1367.7606418876658, 1368.3021658954005, 1369.8082268482422, 1377.5247539598822, 878.4114643188951, 915.5879854065697, 919.8114386550741, 920.0219528014821, 930.15356026016, 4853.611711063107, 4874.610031197496, 4886.657933944661, 4889.511048895082, 4900.705957642553, 5719.996002798058, 5737.540996720252, 5745.396733343023, 5748.252727145528, 5748.540116790647, 4711.858644240679, 4878.9512104878495, 4883.731394773251, 4919.877003074952, 4921.212605983025, 3018.2605261710582, 3031.77261705373, 3041.574179614856, 3047.8628461719277, 3055.801372910754, 5320.0, 5366.490183432567, 5403.35159780821, 5405.243325903817, 5415.83752487426, 5918.319393269743, 5938.673372964528, 5941.227640406806, 5952.196453478811, 5953.880922381528, 5404.729763511808, 5405.3513578369275, 5407.45925407464, 5412.945870541323, 5428.891422171534, 5597.80407685729, 5670.497318210595, 5694.345150307768, 5729.3984131665575, 5763.193152958505, 5356.919646205388, 5603.215549822947, 5628.943710563006, 5633.4084921082695, 5644.858878527905, 5070.4676009019995, 5254.500822421864, 5271.051210782096, 5273.551748101301, 5282.524572788468, 3818.1409182933617, 3861.343571592892, 3896.551896531935, 3910.6675932546054, 3911.491506104302, 5622.798911007384, 5709.714514274353, 5716.42835716425, 5747.1379293106365, 5770.422957704196, 5487.835364939058, 5487.917681234864, 5496.532794712494, 5508.91736623959, 5550.222968784454, 5505.174223866452, 5520.613557050968, 5532.695701736282, 5533.3083364579425, 5539.806106786405, 5238.4237733850005, 5432.864178395414, 5478.397376288525, 5507.311586051744, 5514.200440936122, 5618.550515958796, 5622.156676498558, 5629.943700562942, 5631.0, 5641.887162256649, 5356.919646205388, 5464.890702185855, 5477.342718873601, 5490.039243132356, 5501.587380946525], "value": 4135.742554437432, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.5704691279057, 762.9885551716728, 764.9655765490551, 770.0528350129341, 776.0377132355877, 13440.0, 14413.711725765479, 14424.350904209323, 14433.494827681034, 14515.0, 13801.792973105412, 14596.343164557595, 14643.487477938248, 14677.779833302482, 14801.851981480182, 893.6246776353947, 912.6623149434719, 915.3592485260311, 915.4827522449795, 916.0610374366262, 918.4305730447098, 919.1865199298635, 919.3518569408551, 919.7792529792869, 920.1166879795371, 973.1047436358567, 975.8975307592707, 975.9170470510015, 976.4678250353575, 976.9755756106118, 959.6976952260051, 960.0495509445668, 961.024560071528, 963.1764841060897, 969.6170012844957, 699.0632552379835, 705.2524324216347, 708.1077841919167, 708.4261747984149, 718.8885722712988, 14461.20463374514, 14596.562103136923, 14769.852301476954, 14774.0, 14777.630559236106, 15418.53744387659, 15447.382104715798, 15844.0, 15846.524604261775, 15926.681466370723, 12664.303463309514, 12921.0, 12950.0, 12955.417006234742, 12969.286689232089, 2910.2287893708185, 2984.0, 3007.6691563927952, 3020.41101985113, 3020.909372718822, 66501.0, 67050.0, 67461.0, 69118.65440672815, 69215.0, 12371.907023244188, 12424.06819488542, 12441.875581244252, 12477.875221247852, 12535.749285014248, 22874.771252287595, 23076.884615576815, 23417.297481075595, 23477.17829875946, 23484.0, 6034.577579569475, 6087.086936959403, 6096.9390306096375, 6102.206713127353, 6122.632642041492, 2547.3249588858966, 2605.0491570576605, 2608.765211131007, 2623.9081632142784, 2631.0659715801, 4151.252774500619, 4272.829086836492, 4293.3989241506215, 4293.463317085364, 4295.140971805651, 710.6837457331438, 733.4022771441258, 749.5427789048676, 749.5952185819706, 750.5159172333814, 578.8842231553706, 583.6760597868139, 591.8579540910237, 598.9071693887367, 611.9235095613049, 9263.0, 9465.195458386115, 10190.286679932333, 10206.0, 10524.684259472075, 608.327797783443, 618.9690515474208, 620.1008537620469, 625.7434451874709, 637.2162240444279, 4269.124829409963, 4352.564743525685, 4352.760598167131, 4379.58393952574, 4402.427684401007, 65611.0, 66240.33759662438, 66566.33433665698, 66866.33133668698, 67614.90043545455, 54174.187387189224, 55147.448525515036, 56498.717506412206, 57221.71389143028, 60338.69830650819, 38064.61935380666, 46815.531844681114, 47781.9999999993, 48079.75960120177, 48251.517484824704, 10129.442880641636, 10860.402677852793, 10963.0, 10974.945125274322, 10993.217950191693, 25497.745022549538, 25550.872245638653, 25869.0, 27153.0, 27276.31809204786, 30701.692983070778, 31023.224419389695, 31232.531512027792, 31712.36575268528, 31842.84078579592, 13161.0, 13257.469701211843, 13555.118917270345, 13567.660808479866, 13912.095713778572, 15085.773713394527, 15263.465778697693, 15459.149746763585, 15470.381184752483, 15773.763393549336, 13218.60344189676, 13321.33393330349, 13374.9331253347, 13506.729865402833, 13632.727345453233, 13944.302784860514, 14191.148531088167, 14212.502562410265, 14858.777118343018, 14932.552023439313, 12585.748285034066, 12735.299558523999, 13495.122817016863, 14077.577672669837, 14144.363503642566, 10736.409497477714, 10798.784024319313, 11017.83473247886, 11021.173411994292, 11028.5037173329, 10672.57309707603, 10850.511726972147, 11099.611513596985, 11195.72010699739, 11238.100951923663], "value": 6850.897756287116, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1512.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 111.0, 112.0, 110.0, 111.0, 111.0, 110.0, 111.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 121.0, 123.0, 179.0, 122.0, 121.0, 121.0, 122.0, 144.0, 121.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 162.0, 163.0, 163.0, 163.0, 162.0, 163.0, 163.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 103.0, 74.0, 83.0, 75.0, 75.0, 95.0, 74.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 109.0, 82.0, 83.0, 83.0, 101.0, 83.0, 82.0, 102.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 112.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 148.0, 148.0, 149.0, 150.0, 149.0, 150.0, 149.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 93.0, 93.0, 94.0, 93.0, 94.0, 94.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 53.0, 52.0, 53.0, 54.0, 53.0, 53.0, 54.0, 55.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 56.0, 55.0, 55.0, 55.0, 55.0, 54.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 80.0, 81.0, 81.0, 80.0, 80.0, 80.0, 81.0, 80.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 137.0, 128.0, 129.0, 136.0, 127.0, 127.0, 127.0, 174.0, 135.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 192.0, 187.0, 194.0, 189.0, 188.0, 181.0, 187.0, 184.0, 189.0], "value": 187.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 73.0, 71.0, 70.0, 68.0, 69.0, 68.0, 75.0, 72.0], "value": 70.8, "unit": "score"}]}]} 14:43:54 INFO - Return code: 0 14:43:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:43:54 INFO - # TBPL SUCCESS # 14:43:54 INFO - Running post-action listener: _resource_record_post_action 14:43:54 INFO - [mozharness: 2017-05-03 21:43:54.361851Z] Finished run-tests step (success) 14:43:54 INFO - Running post-run listener: _resource_record_post_run 14:43:54 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 351965184; Read time: 232; Write time: 313160 14:43:54 INFO - TinderboxPrint: CPU usage
13.0% 14:43:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 232 14:43:54 INFO - TinderboxPrint: I/O write bytes / time
351,965,184 / 313,160 14:43:54 INFO - TinderboxPrint: CPU idle
8,357.1 (87.0%) 14:43:54 INFO - TinderboxPrint: CPU user
1,199.9 (12.5%) 14:43:54 INFO - TinderboxPrint: Swap in / out
0 / 0 14:43:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 462848; Read time: 0; Write time: 44 14:43:54 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 330653696; Read time: 232; Write time: 309600 14:43:54 INFO - Running post-run listener: _upload_blobber_files 14:43:54 INFO - Blob upload gear active. 14:43:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:43:54 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 14:43:54 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'] 14:43:54 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 14:43:55 INFO - (blobuploader) - INFO - Open directory for files ... 14:43:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:43:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:43:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:56 INFO - (blobuploader) - INFO - Done attempting. 14:43:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:43:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:44:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:01 INFO - (blobuploader) - INFO - Done attempting. 14:44:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:44:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:44:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:01 INFO - (blobuploader) - INFO - Done attempting. 14:44:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:44:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:44:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:02 INFO - (blobuploader) - INFO - Done attempting. 14:44:02 INFO - (blobuploader) - INFO - Iteration through files over. 14:44:02 INFO - Return code: 0 14:44:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:44:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:44:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b926bdf0941fa973f4c2ce800e8a813dcede29d61179baa58127bdf76636980014e81faa09799efc328370915b42eadd702841bdddcb61c77604fe514561ce4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f5aa73ba154a79072ea11b60e2b3a71621d007118f56dba4ebd4507c50c436461b1d7577b2ddf838f939aafed4ec25e6ec8fb1d753a4097ebcf6d98d37df18e", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6dd8a312d092e83a4fa8443a2e6fd890e042f9c09d9b7c5142b97bdde1a4c97d0e1807eefff3fe960803fbebf7d16e9ba70605fad5498b0d227e96d401e377a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0780032f6ad3802fe4e076b40497910ca4a659d5480e410ad626556915e746bd41d288cd03ffa0aa5b70c1c7d4a0f40c09323b4da1b158587a4f74fdd00a277"} 14:44:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:44:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:44:02 INFO - Contents: 14:44:02 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b926bdf0941fa973f4c2ce800e8a813dcede29d61179baa58127bdf76636980014e81faa09799efc328370915b42eadd702841bdddcb61c77604fe514561ce4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f5aa73ba154a79072ea11b60e2b3a71621d007118f56dba4ebd4507c50c436461b1d7577b2ddf838f939aafed4ec25e6ec8fb1d753a4097ebcf6d98d37df18e", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6dd8a312d092e83a4fa8443a2e6fd890e042f9c09d9b7c5142b97bdde1a4c97d0e1807eefff3fe960803fbebf7d16e9ba70605fad5498b0d227e96d401e377a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0780032f6ad3802fe4e076b40497910ca4a659d5480e410ad626556915e746bd41d288cd03ffa0aa5b70c1c7d4a0f40c09323b4da1b158587a4f74fdd00a277"} 14:44:02 INFO - Running post-run listener: copy_logs_to_upload_dir 14:44:02 INFO - Copying logs to upload dir... 14:44:02 INFO - mkdir: /builds/slave/test/build/upload/logs 14:44:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.070156 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-03 14:44:02.384240) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 14:44:02.388580) ========= 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=9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b926bdf0941fa973f4c2ce800e8a813dcede29d61179baa58127bdf76636980014e81faa09799efc328370915b42eadd702841bdddcb61c77604fe514561ce4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f5aa73ba154a79072ea11b60e2b3a71621d007118f56dba4ebd4507c50c436461b1d7577b2ddf838f939aafed4ec25e6ec8fb1d753a4097ebcf6d98d37df18e", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6dd8a312d092e83a4fa8443a2e6fd890e042f9c09d9b7c5142b97bdde1a4c97d0e1807eefff3fe960803fbebf7d16e9ba70605fad5498b0d227e96d401e377a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0780032f6ad3802fe4e076b40497910ca4a659d5480e410ad626556915e746bd41d288cd03ffa0aa5b70c1c7d4a0f40c09323b4da1b158587a4f74fdd00a277"} build_url:https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/QYt3XzFASXWxISA0iLjPUg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b926bdf0941fa973f4c2ce800e8a813dcede29d61179baa58127bdf76636980014e81faa09799efc328370915b42eadd702841bdddcb61c77604fe514561ce4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f5aa73ba154a79072ea11b60e2b3a71621d007118f56dba4ebd4507c50c436461b1d7577b2ddf838f939aafed4ec25e6ec8fb1d753a4097ebcf6d98d37df18e", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6dd8a312d092e83a4fa8443a2e6fd890e042f9c09d9b7c5142b97bdde1a4c97d0e1807eefff3fe960803fbebf7d16e9ba70605fad5498b0d227e96d401e377a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0780032f6ad3802fe4e076b40497910ca4a659d5480e410ad626556915e746bd41d288cd03ffa0aa5b70c1c7d4a0f40c09323b4da1b158587a4f74fdd00a277"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 14:44:02.416882) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 14:44:02.417203) ========= 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=9bfb7e13875ed353a705960e000001c0-1493846582.815787-982187640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 14:44:02.495944) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 14:44:02.499264) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 14:44:02.499550) ========= ========= Total master_lag: 0.16 =========