builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1486398732.65 results: success (0) revision: 65e5f8c2d8160bb7a078726ccad358f647418959 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:12.649806) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:12.650318) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:12.650603) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:12.667006) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:12.667453) ========= 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=1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-06 08:32:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 110M=0s 2017-02-06 08:32:12 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105187 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:12.786109) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:12.786415) ========= 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=1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019194 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:12.836752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:12.837233) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 65e5f8c2d8160bb7a078726ccad358f647418959 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 65e5f8c2d8160bb7a078726ccad358f647418959 --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=1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-06 08:32:12,873 truncating revision to first 12 chars 2017-02-06 08:32:12,873 Setting DEBUG logging. 2017-02-06 08:32:12,873 attempt 1/10 2017-02-06 08:32:12,873 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/65e5f8c2d816?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 08:32:13,460 unpacking tar archive at: mozilla-aurora-65e5f8c2d816/testing/mozharness/ program finished with exit code 0 elapsedTime=0.904423 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:13.757136) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:13.757674) ========= script_repo_revision: 65e5f8c2d8160bb7a078726ccad358f647418959 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:13.758293) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:13.758776) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:13.768505) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-06 08:32:13.768798) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:32:13 INFO - MultiFileLogger online at 20170206 08:32:13 in /builds/slave/test 08:32:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:32:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:32:13 INFO - {'append_to_log': False, 08:32:13 INFO - 'base_work_dir': '/builds/slave/test', 08:32:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:32:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:32:13 INFO - 'branch': 'Mozilla-Aurora', 08:32:13 INFO - 'buildbot_json_path': 'buildprops.json', 08:32:13 INFO - 'config_files': ('talos/linux_config.py',), 08:32:13 INFO - 'default_actions': ('clobber', 08:32:13 INFO - 'read-buildbot-config', 08:32:13 INFO - 'download-and-extract', 08:32:13 INFO - 'populate-webroot', 08:32:13 INFO - 'create-virtualenv', 08:32:13 INFO - 'install', 08:32:13 INFO - 'run-tests'), 08:32:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:32:13 INFO - 'download_minidump_stackwalk': True, 08:32:13 INFO - 'download_symbols': 'ondemand', 08:32:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:32:13 INFO - 'tooltool.py': '/tools/tooltool.py', 08:32:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:32:13 INFO - '/tools/misc-python/virtualenv.py')}, 08:32:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:32:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:32:13 INFO - 'installer_path': 'installer.exe', 08:32:13 INFO - 'log_level': 'info', 08:32:13 INFO - 'log_name': 'talos', 08:32:13 INFO - 'log_to_console': True, 08:32:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:32:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:32:13 INFO - 'opt_config_files': (), 08:32:13 INFO - 'pip_index': False, 08:32:13 INFO - 'sps_profile': False, 08:32:13 INFO - 'sps_profile_interval': 0, 08:32:13 INFO - 'suite': 'dromaeojs', 08:32:13 INFO - 'system_bits': '32', 08:32:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:32:13 INFO - 'title': 'talos-linux64-ix-027', 08:32:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:32:13 INFO - 'use_talos_json': True, 08:32:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:32:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:32:13 INFO - 'work_dir': 'build'} 08:32:13 INFO - [mozharness: 2017-02-06 16:32:13.912173Z] Running clobber step. 08:32:13 INFO - Running pre-action listener: _resource_record_pre_action 08:32:13 INFO - Running main action method: clobber 08:32:13 INFO - rmtree: /builds/slave/test/build 08:32:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:32:14 INFO - Running post-action listener: _resource_record_post_action 08:32:14 INFO - [mozharness: 2017-02-06 16:32:14.382965Z] Finished clobber step (success) 08:32:14 INFO - [mozharness: 2017-02-06 16:32:14.383066Z] Running read-buildbot-config step. 08:32:14 INFO - Running pre-action listener: _resource_record_pre_action 08:32:14 INFO - Running main action method: read_buildbot_config 08:32:14 INFO - Using buildbot properties: 08:32:14 INFO - { 08:32:14 INFO - "project": "", 08:32:14 INFO - "product": "firefox", 08:32:14 INFO - "who": "cbook@mozilla.com", 08:32:14 INFO - "installer_path": "public/build/target.tar.bz2", 08:32:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:32:14 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 08:32:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:32:14 INFO - "stage_platform": "linux64-pgo", 08:32:14 INFO - "basedir": "/builds/slave/test", 08:32:14 INFO - "buildnumber": 733, 08:32:14 INFO - "platform": "ubuntu64_hw", 08:32:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:32:14 INFO - "slavebuilddir": "test", 08:32:14 INFO - "taskId": "B7Z1IPgBRT-JLU65xh-Qtw", 08:32:14 INFO - "branch": "mozilla-aurora", 08:32:14 INFO - "script_repo_revision": "production", 08:32:14 INFO - "revision": "65e5f8c2d8160bb7a078726ccad358f647418959", 08:32:14 INFO - "slavename": "talos-linux64-ix-027", 08:32:14 INFO - "repo_path": "releases/mozilla-aurora" 08:32:14 INFO - } 08:32:14 INFO - Finding installer, test and symbols from parent task. 08:32:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B7Z1IPgBRT-JLU65xh-Qtw'}, attempt #1 08:32:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B7Z1IPgBRT-JLU65xh-Qtw'}, attempt #1 08:32:15 INFO - Task dependencies: SmjeCZ6rQPyECWrHrnO2bA 08:32:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA'}, attempt #1 08:32:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.tar.bz2 08:32:15 INFO - Set test_url: https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/test_packages.json 08:32:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.crashreporter-symbols.zip 08:32:15 INFO - Running post-action listener: _resource_record_post_action 08:32:15 INFO - [mozharness: 2017-02-06 16:32:15.791313Z] Finished read-buildbot-config step (success) 08:32:15 INFO - [mozharness: 2017-02-06 16:32:15.791529Z] Running download-and-extract step. 08:32:15 INFO - Running pre-action listener: _resource_record_pre_action 08:32:15 INFO - Running main action method: download_and_extract 08:32:15 INFO - mkdir: /builds/slave/test/build/tests 08:32:15 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')]} 08:32:15 INFO - trying https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.test_packages.json 08:32:15 INFO - Downloading https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:32:16 INFO - Downloaded 896 bytes. 08:32:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:32:16 INFO - Using the following test package requirements: 08:32:16 INFO - {u'common': [u'target.common.tests.zip'], 08:32:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:32:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:32:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:32:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:32:16 INFO - u'mozbase': [u'target.common.tests.zip'], 08:32:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:32:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:32:16 INFO - u'web-platform': [u'target.common.tests.zip', 08:32:16 INFO - u'target.web-platform.tests.zip'], 08:32:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:32:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:32:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.common.tests.zip 08:32:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:32:16 INFO - Fetch https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.common.tests.zip into memory 08:32:17 INFO - Expected file size: 21854975 08:32:17 INFO - Obtained file size: 21854975 08:32:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:32:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.common.tests.zip 08:32:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:32:21 INFO - Fetch https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.common.tests.zip into memory 08:32:22 INFO - Expected file size: 21854975 08:32:22 INFO - Obtained file size: 21854975 08:32:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.talos.tests.zip 08:32:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:32:26 INFO - Fetch https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.talos.tests.zip into memory 08:32:27 INFO - Expected file size: 14403485 08:32:27 INFO - Obtained file size: 14403485 08:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:27 INFO - trying https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.tar.bz2 08:32:27 INFO - Downloading https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:32:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:32:28 INFO - Downloaded 66037096 bytes. 08:32:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.tar.bz2 08:32:28 INFO - mkdir: /builds/slave/test/properties 08:32:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:32:28 INFO - Writing to file /builds/slave/test/properties/build_url 08:32:28 INFO - Contents: 08:32:28 INFO - build_url:https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.tar.bz2 08:32:28 INFO - Running post-action listener: _resource_record_post_action 08:32:28 INFO - Running post-action listener: set_extra_try_arguments 08:32:28 INFO - [mozharness: 2017-02-06 16:32:28.774534Z] Finished download-and-extract step (success) 08:32:28 INFO - [mozharness: 2017-02-06 16:32:28.774631Z] Running populate-webroot step. 08:32:28 INFO - Running pre-action listener: _resource_record_pre_action 08:32:28 INFO - Running main action method: populate_webroot 08:32:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:32:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:32:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:32:28 INFO - '--tppagecycles', 08:32:28 INFO - '7'], 08:32:28 INFO - 'tests': ['tsvgm']}}, 08:32:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:32:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:32:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:32:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:32:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:32:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:32:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:32:28 INFO - 'talos_options': ['--disable-e10s'], 08:32:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:32:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:32:28 INFO - 'talos_options': ['--disable-e10s'], 08:32:28 INFO - 'tests': ['damp', 'tps']}, 08:32:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:32:28 INFO - 'tests': ['damp', 'tps']}, 08:32:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:32:28 INFO - 'tests': ['dromaeo_dom']}, 08:32:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:32:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:32:28 INFO - 'tests': ['basic_compositor_video']}, 08:32:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:32:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:32:28 INFO - 'tests': ['a11yr', 08:32:28 INFO - 'ts_paint', 08:32:28 INFO - 'tpaint', 08:32:28 INFO - 'sessionrestore', 08:32:28 INFO - 'sessionrestore_no_auto_restore', 08:32:28 INFO - 'tabpaint']}, 08:32:28 INFO - 'other-e10s': {'tests': ['a11yr', 08:32:28 INFO - 'ts_paint', 08:32:28 INFO - 'tpaint', 08:32:28 INFO - 'sessionrestore', 08:32:28 INFO - 'sessionrestore_no_auto_restore', 08:32:28 INFO - 'tabpaint']}, 08:32:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:32:28 INFO - 'ts_paint', 08:32:28 INFO - 'tpaint', 08:32:28 INFO - 'sessionrestore', 08:32:28 INFO - 'sessionrestore_no_auto_restore', 08:32:28 INFO - 'tabpaint']}, 08:32:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:32:28 INFO - 'ts_paint', 08:32:28 INFO - 'tpaint', 08:32:28 INFO - 'sessionrestore', 08:32:28 INFO - 'sessionrestore_no_auto_restore', 08:32:28 INFO - 'tabpaint']}, 08:32:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:32:28 INFO - 'tests': ['a11yr', 08:32:28 INFO - 'ts_paint', 08:32:28 INFO - 'tpaint', 08:32:28 INFO - 'sessionrestore', 08:32:28 INFO - 'sessionrestore_no_auto_restore', 08:32:28 INFO - 'tabpaint']}, 08:32:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:32:28 INFO - 'tests': ['a11yr', 08:32:28 INFO - 'ts_paint', 08:32:28 INFO - 'tpaint', 08:32:28 INFO - 'sessionrestore', 08:32:28 INFO - 'sessionrestore_no_auto_restore', 08:32:28 INFO - 'tabpaint']}, 08:32:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:32:28 INFO - 'tests': ['tsvgx', 08:32:28 INFO - 'tsvgr_opacity', 08:32:28 INFO - 'tart', 08:32:28 INFO - 'tscrollx', 08:32:28 INFO - 'cart', 08:32:28 INFO - 'tsvg_static']}, 08:32:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:32:28 INFO - 'tsvgr_opacity', 08:32:28 INFO - 'tart', 08:32:28 INFO - 'tscrollx', 08:32:28 INFO - 'cart', 08:32:28 INFO - 'tsvg_static']}, 08:32:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:32:28 INFO - 'talos_options': ['--disable-e10s'], 08:32:28 INFO - 'tests': ['tp5o']}, 08:32:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:32:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:32:28 INFO - 'talos_options': ['--disable-e10s', 08:32:28 INFO - '--xperf_path', 08:32:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:28 INFO - 'tests': ['tp5n']}, 08:32:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:32:28 INFO - 'talos_options': ['--xperf_path', 08:32:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:28 INFO - 'tests': ['tp5n']}}, 08:32:28 INFO - 'talos.zip': {'path': '', 08:32:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:32:28 INFO - Running post-action listener: _resource_record_post_action 08:32:28 INFO - [mozharness: 2017-02-06 16:32:28.787618Z] Finished populate-webroot step (success) 08:32:28 INFO - [mozharness: 2017-02-06 16:32:28.787708Z] Running create-virtualenv step. 08:32:28 INFO - Running pre-action listener: _resource_record_pre_action 08:32:28 INFO - Running main action method: create_virtualenv 08:32:28 INFO - Creating virtualenv /builds/slave/test/build/venv 08:32:28 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 08:32:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:32:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:32:28 INFO - Using real prefix '/usr' 08:32:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:32:29 INFO - Installing distribute.............................................................................................................................................................................................done. 08:32:31 INFO - Installing pip.................done. 08:32:31 INFO - Return code: 0 08:32:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:32:31 INFO - Reading from file tmpfile_stdout 08:32:31 INFO - Output received: 08:32:31 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) 08:32:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064850>, '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 0x1fd96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9b60>, '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': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', '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 08:32:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:32:31 INFO - Using env: {'DISPLAY': ':0', 08:32:31 INFO - 'HOME': '/home/cltbld', 08:32:31 INFO - 'LANG': 'en_US.UTF-8', 08:32:31 INFO - 'LANGUAGE': 'en_US:en', 08:32:31 INFO - 'LOGNAME': 'cltbld', 08:32:31 INFO - 'MAIL': '/var/mail/cltbld', 08:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:31 INFO - 'MOZ_NO_REMOTE': '1', 08:32:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:31 INFO - 'NO_EM_RESTART': '1', 08:32:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:31 INFO - 'PWD': '/builds/slave/test', 08:32:31 INFO - 'SHELL': '/bin/bash', 08:32:31 INFO - 'SHLVL': '1', 08:32:31 INFO - 'TERM': 'linux', 08:32:31 INFO - 'TMOUT': '86400', 08:32:31 INFO - 'USER': 'cltbld', 08:32:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', 08:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:31 INFO - '_': '/tools/buildbot/bin/python'} 08:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:31 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 08:32:31 INFO - Cleaning up... 08:32:31 INFO - Return code: 0 08:32:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064850>, '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 0x1fd96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9b60>, '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': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', '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 08:32:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:32:31 INFO - Using env: {'DISPLAY': ':0', 08:32:31 INFO - 'HOME': '/home/cltbld', 08:32:31 INFO - 'LANG': 'en_US.UTF-8', 08:32:31 INFO - 'LANGUAGE': 'en_US:en', 08:32:31 INFO - 'LOGNAME': 'cltbld', 08:32:31 INFO - 'MAIL': '/var/mail/cltbld', 08:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:31 INFO - 'MOZ_NO_REMOTE': '1', 08:32:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:31 INFO - 'NO_EM_RESTART': '1', 08:32:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:31 INFO - 'PWD': '/builds/slave/test', 08:32:31 INFO - 'SHELL': '/bin/bash', 08:32:31 INFO - 'SHLVL': '1', 08:32:31 INFO - 'TERM': 'linux', 08:32:31 INFO - 'TMOUT': '86400', 08:32:31 INFO - 'USER': 'cltbld', 08:32:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', 08:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:31 INFO - '_': '/tools/buildbot/bin/python'} 08:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:31 INFO - Downloading/unpacking psutil>=3.1.1 08:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:32:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:34 INFO - Installing collected packages: psutil 08:32:34 INFO - Running setup.py install for psutil 08:32:34 INFO - building 'psutil._psutil_linux' extension 08:32:34 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 08:32:34 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 08:32:34 INFO - building 'psutil._psutil_posix' extension 08:32:34 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 08:32:34 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 08:32:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:34 INFO - Successfully installed psutil 08:32:34 INFO - Cleaning up... 08:32:34 INFO - Return code: 0 08:32:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:32:34 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')]} 08:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:34 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')]} 08:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:34 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 0x1c691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064850>, '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 0x1fd96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9b60>, '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': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', '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 08:32:34 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 08:32:34 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 08:32:34 INFO - Using env: {'DISPLAY': ':0', 08:32:34 INFO - 'HOME': '/home/cltbld', 08:32:34 INFO - 'LANG': 'en_US.UTF-8', 08:32:34 INFO - 'LANGUAGE': 'en_US:en', 08:32:34 INFO - 'LOGNAME': 'cltbld', 08:32:34 INFO - 'MAIL': '/var/mail/cltbld', 08:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:34 INFO - 'MOZ_NO_REMOTE': '1', 08:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:34 INFO - 'NO_EM_RESTART': '1', 08:32:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:34 INFO - 'PWD': '/builds/slave/test', 08:32:34 INFO - 'SHELL': '/bin/bash', 08:32:34 INFO - 'SHLVL': '1', 08:32:34 INFO - 'TERM': 'linux', 08:32:34 INFO - 'TMOUT': '86400', 08:32:34 INFO - 'USER': 'cltbld', 08:32:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', 08:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:34 INFO - '_': '/tools/buildbot/bin/python'} 08:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:32:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:32:36 INFO - Installing collected packages: mozsystemmonitor 08:32:36 INFO - Running setup.py install for mozsystemmonitor 08:32:36 INFO - Successfully installed mozsystemmonitor 08:32:36 INFO - Cleaning up... 08:32:37 INFO - Return code: 0 08:32:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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', '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 0x1c691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064850>, '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 0x1fd96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9b60>, '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': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', '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 08:32: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:32: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 jsonschema==2.5.1 08:32:37 INFO - Using env: {'DISPLAY': ':0', 08:32:37 INFO - 'HOME': '/home/cltbld', 08:32:37 INFO - 'LANG': 'en_US.UTF-8', 08:32:37 INFO - 'LANGUAGE': 'en_US:en', 08:32:37 INFO - 'LOGNAME': 'cltbld', 08:32:37 INFO - 'MAIL': '/var/mail/cltbld', 08:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:37 INFO - 'MOZ_NO_REMOTE': '1', 08:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:37 INFO - 'NO_EM_RESTART': '1', 08:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:37 INFO - 'PWD': '/builds/slave/test', 08:32:37 INFO - 'SHELL': '/bin/bash', 08:32:37 INFO - 'SHLVL': '1', 08:32:37 INFO - 'TERM': 'linux', 08:32:37 INFO - 'TMOUT': '86400', 08:32:37 INFO - 'USER': 'cltbld', 08:32:37 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', 08:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:37 INFO - '_': '/tools/buildbot/bin/python'} 08:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:37 INFO - Downloading/unpacking jsonschema==2.5.1 08:32:37 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 08:32:37 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 08:32:37 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 08:32:37 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 08:32:37 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 08:32:37 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 08:32:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:32:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32:39 INFO - Downloading functools32-3.2.3-2.tar.gz 08:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:32:39 INFO - warning: no files found matching '*.txt' 08:32:39 INFO - no previously-included directories found matching 'build' 08:32:39 INFO - no previously-included directories found matching 'dist' 08:32:39 INFO - no previously-included directories found matching '.git*' 08:32:39 INFO - Installing collected packages: jsonschema, functools32 08:32:39 INFO - Running setup.py install for functools32 08:32:39 INFO - warning: no files found matching '*.txt' 08:32:39 INFO - no previously-included directories found matching 'build' 08:32:39 INFO - no previously-included directories found matching 'dist' 08:32:39 INFO - no previously-included directories found matching '.git*' 08:32:39 INFO - Successfully installed jsonschema functools32 08:32:39 INFO - Cleaning up... 08:32:39 INFO - Return code: 0 08:32:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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', '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 0x1c691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064850>, '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 0x1fd96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9b60>, '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': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', '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 08:32: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:32: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 functools32==3.2.3-2 08:32:39 INFO - Using env: {'DISPLAY': ':0', 08:32:39 INFO - 'HOME': '/home/cltbld', 08:32:39 INFO - 'LANG': 'en_US.UTF-8', 08:32:39 INFO - 'LANGUAGE': 'en_US:en', 08:32:39 INFO - 'LOGNAME': 'cltbld', 08:32:39 INFO - 'MAIL': '/var/mail/cltbld', 08:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:39 INFO - 'MOZ_NO_REMOTE': '1', 08:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:39 INFO - 'NO_EM_RESTART': '1', 08:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:39 INFO - 'PWD': '/builds/slave/test', 08:32:39 INFO - 'SHELL': '/bin/bash', 08:32:39 INFO - 'SHLVL': '1', 08:32:39 INFO - 'TERM': 'linux', 08:32:39 INFO - 'TMOUT': '86400', 08:32:39 INFO - 'USER': 'cltbld', 08:32:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', 08:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:39 INFO - '_': '/tools/buildbot/bin/python'} 08:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:32:39 INFO - Cleaning up... 08:32:39 INFO - Return code: 0 08:32:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:40 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 0x1c691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064850>, '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 0x1fd96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9b60>, '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': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', '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 08:32:40 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 08:32:40 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 08:32:40 INFO - Using env: {'DISPLAY': ':0', 08:32:40 INFO - 'HOME': '/home/cltbld', 08:32:40 INFO - 'LANG': 'en_US.UTF-8', 08:32:40 INFO - 'LANGUAGE': 'en_US:en', 08:32:40 INFO - 'LOGNAME': 'cltbld', 08:32:40 INFO - 'MAIL': '/var/mail/cltbld', 08:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:40 INFO - 'MOZ_NO_REMOTE': '1', 08:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:40 INFO - 'NO_EM_RESTART': '1', 08:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:40 INFO - 'PWD': '/builds/slave/test', 08:32:40 INFO - 'SHELL': '/bin/bash', 08:32:40 INFO - 'SHLVL': '1', 08:32:40 INFO - 'TERM': 'linux', 08:32:40 INFO - 'TMOUT': '86400', 08:32:40 INFO - 'USER': 'cltbld', 08:32:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', 08:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:40 INFO - '_': '/tools/buildbot/bin/python'} 08:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:40 INFO - Downloading/unpacking blobuploader==1.2.4 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32:42 INFO - Downloading blobuploader-1.2.4.tar.gz 08:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:32:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:32:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32:42 INFO - Downloading docopt-0.6.1.tar.gz 08:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:32:43 INFO - Installing collected packages: blobuploader, requests, docopt 08:32:43 INFO - Running setup.py install for blobuploader 08:32:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:32:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:32:43 INFO - Running setup.py install for requests 08:32:43 INFO - Running setup.py install for docopt 08:32:43 INFO - Successfully installed blobuploader requests docopt 08:32:43 INFO - Cleaning up... 08:32:43 INFO - Return code: 0 08:32:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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 0x1c691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064850>, '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 0x1fd96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9b60>, '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': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', '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 08:32: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 08:32: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 08:32:43 INFO - Using env: {'DISPLAY': ':0', 08:32:43 INFO - 'HOME': '/home/cltbld', 08:32:43 INFO - 'LANG': 'en_US.UTF-8', 08:32:43 INFO - 'LANGUAGE': 'en_US:en', 08:32:43 INFO - 'LOGNAME': 'cltbld', 08:32:43 INFO - 'MAIL': '/var/mail/cltbld', 08:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:43 INFO - 'MOZ_NO_REMOTE': '1', 08:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:43 INFO - 'NO_EM_RESTART': '1', 08:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:43 INFO - 'PWD': '/builds/slave/test', 08:32:43 INFO - 'SHELL': '/bin/bash', 08:32:43 INFO - 'SHLVL': '1', 08:32:43 INFO - 'TERM': 'linux', 08:32:43 INFO - 'TMOUT': '86400', 08:32:43 INFO - 'USER': 'cltbld', 08:32:43 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', 08:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:43 INFO - '_': '/tools/buildbot/bin/python'} 08:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:43 INFO - Running setup.py (path:/tmp/pip-BP3j2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:43 INFO - Running setup.py (path:/tmp/pip-o2nIZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:43 INFO - Running setup.py (path:/tmp/pip-ZCtzXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:44 INFO - Running setup.py (path:/tmp/pip-0Tj_7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:44 INFO - Running setup.py (path:/tmp/pip-dRCKdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:44 INFO - Running setup.py (path:/tmp/pip-d00aTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:44 INFO - Running setup.py (path:/tmp/pip-VhBZHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:44 INFO - Running setup.py (path:/tmp/pip-XPK2o4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:44 INFO - Running setup.py (path:/tmp/pip-mygrwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:44 INFO - Running setup.py (path:/tmp/pip-hxboHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:44 INFO - Running setup.py (path:/tmp/pip-I2kBRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:44 INFO - Running setup.py (path:/tmp/pip-LtObeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:44 INFO - Running setup.py (path:/tmp/pip-fxJ5IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:44 INFO - Running setup.py (path:/tmp/pip-dA50YY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:44 INFO - Running setup.py (path:/tmp/pip-Q5ZvqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:44 INFO - Running setup.py (path:/tmp/pip-IzaqGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:44 INFO - Running setup.py (path:/tmp/pip-KNfKCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:32:45 INFO - Running setup.py install for manifestparser 08:32:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:32:45 INFO - Running setup.py install for mozcrash 08:32:45 INFO - Running setup.py install for mozdebug 08:32:45 INFO - Running setup.py install for mozdevice 08:32:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:32:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:32:45 INFO - Running setup.py install for mozfile 08:32:45 INFO - Running setup.py install for mozhttpd 08:32:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:32:45 INFO - Running setup.py install for mozinfo 08:32:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:32:45 INFO - Running setup.py install for mozInstall 08:32:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:32:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:32:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:32:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:32:45 INFO - Running setup.py install for mozleak 08:32:45 INFO - Running setup.py install for mozlog 08:32:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:32:46 INFO - Running setup.py install for moznetwork 08:32:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:32:46 INFO - Running setup.py install for mozprocess 08:32:46 INFO - Running setup.py install for mozprofile 08:32:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:32:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:32:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:32:46 INFO - Running setup.py install for mozrunner 08:32:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:32:46 INFO - Running setup.py install for mozscreenshot 08:32:46 INFO - Running setup.py install for moztest 08:32:46 INFO - Running setup.py install for mozversion 08:32:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:32:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:32:46 INFO - Cleaning up... 08:32:46 INFO - Return code: 0 08:32:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:46 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')]} 08:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:46 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')]} 08:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:46 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 0x1c691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064850>, '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 0x1fd96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9b60>, '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': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', '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 08:32:46 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 08:32:46 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 08:32:46 INFO - Using env: {'DISPLAY': ':0', 08:32:46 INFO - 'HOME': '/home/cltbld', 08:32:46 INFO - 'LANG': 'en_US.UTF-8', 08:32:46 INFO - 'LANGUAGE': 'en_US:en', 08:32:46 INFO - 'LOGNAME': 'cltbld', 08:32:46 INFO - 'MAIL': '/var/mail/cltbld', 08:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:46 INFO - 'MOZ_NO_REMOTE': '1', 08:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:46 INFO - 'NO_EM_RESTART': '1', 08:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:46 INFO - 'PWD': '/builds/slave/test', 08:32:46 INFO - 'SHELL': '/bin/bash', 08:32:46 INFO - 'SHLVL': '1', 08:32:46 INFO - 'TERM': 'linux', 08:32:46 INFO - 'TMOUT': '86400', 08:32:46 INFO - 'USER': 'cltbld', 08:32:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', 08:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:46 INFO - '_': '/tools/buildbot/bin/python'} 08:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:47 INFO - Running setup.py (path:/tmp/pip-LKGe7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32: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)) 08:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:47 INFO - Running setup.py (path:/tmp/pip-HWudqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32: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)) 08:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:47 INFO - Running setup.py (path:/tmp/pip-SnSubC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32: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)) 08:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:47 INFO - Running setup.py (path:/tmp/pip-JgWGxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:47 INFO - Running setup.py (path:/tmp/pip-DDWxVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32: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)) 08:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:47 INFO - Running setup.py (path:/tmp/pip-YBRLYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32: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)) 08:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:47 INFO - Running setup.py (path:/tmp/pip-ZDPMgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32: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)) 08:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:47 INFO - Running setup.py (path:/tmp/pip-vWMDJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32: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)) 08:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:47 INFO - Running setup.py (path:/tmp/pip-7RmJQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32: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)) 08:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:47 INFO - Running setup.py (path:/tmp/pip-oyWw1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:47 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)) 08:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:47 INFO - Running setup.py (path:/tmp/pip-cjd8wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:47 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)) 08:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:47 INFO - Running setup.py (path:/tmp/pip-kFSlZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 08:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:48 INFO - Running setup.py (path:/tmp/pip-kwB6gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32: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)) 08:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:48 INFO - Running setup.py (path:/tmp/pip-3UYJr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32: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)) 08:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:48 INFO - Running setup.py (path:/tmp/pip-3iKxhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32: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)) 08:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:48 INFO - Running setup.py (path:/tmp/pip-AMpvBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32: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)) 08:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:48 INFO - Running setup.py (path:/tmp/pip-O6QBth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32: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)) 08:32: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)) 08:32: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)) 08:32: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)) 08:32: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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:32: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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:32:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32:50 INFO - Downloading blessings-1.6.tar.gz 08:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:32:50 INFO - Installing collected packages: blessings 08:32:50 INFO - Running setup.py install for blessings 08:32:50 INFO - Successfully installed blessings 08:32:50 INFO - Cleaning up... 08:32:50 INFO - Return code: 0 08:32:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:32:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:32:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:32:50 INFO - Reading from file tmpfile_stdout 08:32:50 INFO - Current package versions: 08:32:50 INFO - argparse == 1.2.1 08:32:50 INFO - blessings == 1.6 08:32:50 INFO - blobuploader == 1.2.4 08:32:50 INFO - docopt == 0.6.1 08:32:50 INFO - functools32 == 3.2.3-2 08:32:50 INFO - jsonschema == 2.5.1 08:32:50 INFO - manifestparser == 1.1 08:32:50 INFO - mozInstall == 1.12 08:32:50 INFO - mozcrash == 1.0 08:32:50 INFO - mozdebug == 0.1 08:32:50 INFO - mozdevice == 0.49 08:32:50 INFO - mozfile == 1.2 08:32:50 INFO - mozhttpd == 0.7 08:32:50 INFO - mozinfo == 0.9 08:32:50 INFO - mozleak == 0.1 08:32:50 INFO - mozlog == 3.4 08:32:50 INFO - moznetwork == 0.27 08:32:50 INFO - mozprocess == 0.24 08:32:50 INFO - mozprofile == 0.28 08:32:50 INFO - mozrunner == 6.13 08:32:50 INFO - mozscreenshot == 0.1 08:32:50 INFO - mozsystemmonitor == 0.3 08:32:50 INFO - moztest == 0.8 08:32:50 INFO - mozversion == 1.4 08:32:50 INFO - psutil == 3.1.1 08:32:50 INFO - requests == 1.2.3 08:32:50 INFO - wsgiref == 0.1.2 08:32:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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 0x1c691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064850>, '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 0x1fd96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9b60>, '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': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', '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 08:32: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 08:32: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 08:32:50 INFO - Using env: {'DISPLAY': ':0', 08:32:50 INFO - 'HOME': '/home/cltbld', 08:32:50 INFO - 'LANG': 'en_US.UTF-8', 08:32:50 INFO - 'LANGUAGE': 'en_US:en', 08:32:50 INFO - 'LOGNAME': 'cltbld', 08:32:50 INFO - 'MAIL': '/var/mail/cltbld', 08:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:50 INFO - 'MOZ_NO_REMOTE': '1', 08:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:50 INFO - 'NO_EM_RESTART': '1', 08:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:50 INFO - 'PWD': '/builds/slave/test', 08:32:50 INFO - 'SHELL': '/bin/bash', 08:32:50 INFO - 'SHLVL': '1', 08:32:50 INFO - 'TERM': 'linux', 08:32:50 INFO - 'TMOUT': '86400', 08:32:50 INFO - 'USER': 'cltbld', 08:32:50 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', 08:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:50 INFO - '_': '/tools/buildbot/bin/python'} 08:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:51 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)) 08:32:51 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)) 08:32:51 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)) 08:32:51 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)) 08:32:51 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)) 08:32:51 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)) 08:32:51 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)) 08:32:51 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)) 08:32:51 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)) 08:32:51 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)) 08:32:51 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)) 08:32:51 INFO - Cleaning up... 08:32:51 INFO - Return code: 0 08:32:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:32:51 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')]} 08:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:51 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')]} 08:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:51 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 0x1c691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d79a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064850>, '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 0x1fd96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9b60>, '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': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', '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 08:32:51 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 08:32:51 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 08:32:51 INFO - Using env: {'DISPLAY': ':0', 08:32:51 INFO - 'HOME': '/home/cltbld', 08:32:51 INFO - 'LANG': 'en_US.UTF-8', 08:32:51 INFO - 'LANGUAGE': 'en_US:en', 08:32:51 INFO - 'LOGNAME': 'cltbld', 08:32:51 INFO - 'MAIL': '/var/mail/cltbld', 08:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:51 INFO - 'MOZ_NO_REMOTE': '1', 08:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:51 INFO - 'NO_EM_RESTART': '1', 08:32:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:51 INFO - 'PWD': '/builds/slave/test', 08:32:51 INFO - 'SHELL': '/bin/bash', 08:32:51 INFO - 'SHLVL': '1', 08:32:51 INFO - 'TERM': 'linux', 08:32:51 INFO - 'TMOUT': '86400', 08:32:51 INFO - 'USER': 'cltbld', 08:32:51 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', 08:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:51 INFO - '_': '/tools/buildbot/bin/python'} 08:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:32:51 INFO - Cleaning up... 08:32:51 INFO - Return code: 0 08:32:51 INFO - Running post-action listener: _resource_record_post_action 08:32:51 INFO - Running post-action listener: _start_resource_monitoring 08:32:51 INFO - Starting resource monitoring. 08:32:51 INFO - [mozharness: 2017-02-06 16:32:51.305504Z] Finished create-virtualenv step (success) 08:32:51 INFO - [mozharness: 2017-02-06 16:32:51.305944Z] Running install step. 08:32:51 INFO - Running pre-action listener: _resource_record_pre_action 08:32:51 INFO - Running main action method: install 08:32:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:32:51 INFO - Reading from file tmpfile_stdout 08:32:51 INFO - Detecting whether we're running mozinstall >=1.0... 08:32:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:32:51 INFO - Reading from file tmpfile_stdout 08:32:51 INFO - Output received: 08:32:51 INFO - Usage: mozinstall [options] installer 08:32:51 INFO - Options: 08:32:51 INFO - -h, --help show this help message and exit 08:32:51 INFO - -d DEST, --destination=DEST 08:32:51 INFO - Directory to install application into. [default: 08:32:51 INFO - "/builds/slave/test"] 08:32:51 INFO - --app=APP Application being installed. [default: firefox] 08:32:51 INFO - mkdir: /builds/slave/test/build/application 08:32:51 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'] 08:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:33:08 INFO - Reading from file tmpfile_stdout 08:33:08 INFO - Output received: 08:33:08 INFO - /builds/slave/test/build/application/firefox/firefox 08:33:08 INFO - Running post-action listener: _resource_record_post_action 08:33:08 INFO - [mozharness: 2017-02-06 16:33:08.060180Z] Finished install step (success) 08:33:08 INFO - [mozharness: 2017-02-06 16:33:08.060455Z] Running run-tests step. 08:33:08 INFO - Running pre-action listener: _resource_record_pre_action 08:33:08 INFO - Running main action method: run_tests 08:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:33:08 INFO - Python 2.7.3 08:33:08 INFO - Return code: 0 08:33:08 INFO - grabbing minidump binary from tooltool 08:33: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')]} 08:33:08 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 0x2064850>, '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 0x1fd96d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:33:08 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 08:33:08 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 08:33:08 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 08:33:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:33:08 INFO - Return code: 0 08:33:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:33:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:33:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:33:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:33:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 08:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 08:33:08 INFO - Using env: {'DISPLAY': ':0', 08:33:08 INFO - 'HOME': '/home/cltbld', 08:33:08 INFO - 'LANG': 'en_US.UTF-8', 08:33:08 INFO - 'LANGUAGE': 'en_US:en', 08:33:08 INFO - 'LOGNAME': 'cltbld', 08:33:08 INFO - 'MAIL': '/var/mail/cltbld', 08:33:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:33:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:08 INFO - 'MOZ_NO_REMOTE': '1', 08:33:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:08 INFO - 'NO_EM_RESTART': '1', 08:33:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:08 INFO - 'PWD': '/builds/slave/test', 08:33:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:33:08 INFO - 'SHELL': '/bin/bash', 08:33:08 INFO - 'SHLVL': '1', 08:33:08 INFO - 'TERM': 'linux', 08:33:08 INFO - 'TMOUT': '86400', 08:33:08 INFO - 'USER': 'cltbld', 08:33:08 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196', 08:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:08 INFO - '_': '/tools/buildbot/bin/python'} 08:33:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 08:33:08 INFO - mozversion application_buildid: 20170206152735 08:33:08 INFO - mozversion application_changeset: 65e5f8c2d8160bb7a078726ccad358f647418959 08:33:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:33:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:33:08 INFO - mozversion application_name: Firefox 08:33:08 INFO - mozversion application_remotingname: firefox-dev 08:33:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:33:08 INFO - mozversion application_vendor: Mozilla 08:33:08 INFO - mozversion application_version: 53.0a2 08:33:08 INFO - mozversion platform_buildid: 20170206152735 08:33:08 INFO - mozversion platform_changeset: 65e5f8c2d8160bb7a078726ccad358f647418959 08:33:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:33:08 INFO - mozversion platform_version: 53.0a2 08:33:08 INFO - using testdate: 1486398788 08:33:08 INFO - actual date: 1486398788 08:33:08 INFO - starting webserver on 'localhost:44330' 08:33:08 INFO - SUITE-START | Running 2 tests 08:33:08 INFO - TEST-START | dromaeo_css 08:33:08 INFO - operating with platform_type : linux_ 08:33:08 INFO - Initialising browser for dromaeo_css test... 08:33:08 INFO - TEST-INFO | started process 9807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA9L5X7/profile http://localhost:44330/getInfo.html) 08:33:12 INFO - PROCESS | 9807 | __metrics Screen width/height:1600/1200 08:33:12 INFO - PROCESS | 9807 | colorDepth:24 08:33:12 INFO - PROCESS | 9807 | Browser inner width/height: 1024/697 08:33:12 INFO - PROCESS | 9807 | __metrics 08:33:12 INFO - PROCESS | 9807 | 1486398792668 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 08:33:12 INFO - PROCESS | 9807 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:33:12 INFO - PROCESS | 9807 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:13 INFO - PROCESS | 9807 | console.error: PushService: 08:33:13 INFO - PROCESS | 9807 | stateChangeProcessEnqueue: Error transitioning state 08:33:13 INFO - PROCESS | 9807 | UnknownError 08:33:13 INFO - TEST-INFO | 9807: exit 0 08:33:13 INFO - Browser initialized. 08:33:13 INFO - Running cycle 1/1 for dromaeo_css test... 08:33:13 INFO - TEST-INFO | started process 9899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA9L5X7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:25 INFO - PROCESS | 9899 | RSS: Main: 138100736 08:33:25 INFO - PROCESS | 9899 | 08:36:26 INFO - PROCESS | 9899 | Cycle 1(1): loaded http://localhost:44330/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44330/tests/dromaeo/cssquery-ext.html) 08:36:27 INFO - PROCESS | 9899 | RSS: Main: 243896320 08:36:27 INFO - PROCESS | 9899 | 08:38:15 INFO - PROCESS | 9899 | ************************* 08:38:15 INFO - PROCESS | 9899 | A coding exception was thrown and uncaught in a Task. 08:38:15 INFO - PROCESS | 9899 | 08:38:15 ERROR - PROCESS | 9899 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:38:15 INFO - PROCESS | 9899 | Full stack: 08:38:15 INFO - PROCESS | 9899 | ************************* 08:39:29 INFO - PROCESS | 9899 | Cycle 1(1): loaded http://localhost:44330/tests/dromaeo/cssquery-ext.html (next: http://localhost:44330/tests/dromaeo/cssquery-jquery.html) 08:39:30 INFO - PROCESS | 9899 | RSS: Main: 230400000 08:39:30 INFO - PROCESS | 9899 | 08:42:31 INFO - PROCESS | 9899 | Cycle 1(1): loaded http://localhost:44330/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44330/tests/dromaeo/cssquery-mootools.html) 08:42:32 INFO - PROCESS | 9899 | RSS: Main: 170467328 08:42:32 INFO - PROCESS | 9899 | 08:45:34 INFO - PROCESS | 9899 | Cycle 1(1): loaded http://localhost:44330/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44330/tests/dromaeo/cssquery-prototype.html) 08:45:35 INFO - PROCESS | 9899 | RSS: Main: 212803584 08:45:35 INFO - PROCESS | 9899 | 08:48:37 INFO - PROCESS | 9899 | Cycle 1(1): loaded http://localhost:44330/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44330/tests/dromaeo/cssquery-yui.html) 08:48:38 INFO - PROCESS | 9899 | RSS: Main: 170938368 08:48:38 INFO - PROCESS | 9899 | 08:51:40 INFO - PROCESS | 9899 | Cycle 1(1): loaded http://localhost:44330/tests/dromaeo/cssquery-yui.html (next: http://localhost:44330/tests/dromaeo/cssquery-dojo.html) 08:51:41 INFO - PROCESS | 9899 | RSS: Main: 263254016 08:51:41 INFO - PROCESS | 9899 | 08:51:41 INFO - PROCESS | 9899 | __start_tp_report 08:51:41 INFO - PROCESS | 9899 | _x_x_mozilla_page_load 08:51:41 INFO - PROCESS | 9899 | _x_x_mozilla_page_load_details 08:51:41 INFO - PROCESS | 9899 | |i|pagename|runs| 08:51:41 INFO - PROCESS | 9899 | |0;dojo.html;3272.525483804848;3309.553210316608;3322.5348451216832;3329.650386709397;3363.6468170842063;5412.215228791828;5483;5495.725213739307;5509.090999984997;5517.337919449662;5475.917861232085;5509.614326997112;5525.613207075507;5534.4742249486335;5566.165075238716;4935.555799977992;4944.777485013183;4971.403431588196;5019.874503137415;5048.9495105048845;4741.028089241714;4790.257510085925;4973.825916092937;5016.29771831942;5021.196608542634;4847.345608342882;4874.610031197496;4899.6325275604295;4965.975170124144;4993.201087825949;5018.824341148061;5021.347224860763;5021.49785021495;5021.949780502221;5036.320096786923;4819.783109760069;4964.453910069889;4980.252962055684;4990.675606085593;5012.04771093491;5294.41761406245;5316.813911513117;5359.196120581944;5390.19147127934;5446.101393270105;5817.447342502455;5819.7090145492975;5824.912626310609;5828.621139625953;5828.941710582924;5812.244408226946;5846.619969701956;5878.177055212231;5878.353381128072;5889.528837692974;5346.625736198468;5359.624826262163;5421;5544.085225937756;5553.583481238923;5964.642121472725;5983.790567330123;5988.401159883977;5994.6403215807195;5995.730192141364;5747.48272655463;5768.105943578752;5778.162166485836;5780.682062486603;5781.19063331134;5605.019121653694;5649.463300986482;5812.418758124239;5826.41735826414;5887.941120588739;5640.210370548127;5689.886202275931;5695.572832037614;5727.11229759388;5734.827955161351;5698.487136157766;5700.8004719835435;5701.515371193495;5702.258706368146;5704.942950570441;4441.244988351988;4478.328250762412;4481.3726078349055;4487.640988720895;4514.706544074625;3947.9605203948167;4036.1524079943542;4038;4057.3711074783455;4061.593840615915;5607.607467477237;5610.32676078865;5610.49505544503;5624.409437009055;5626.915596266059;5612.663240205601;5641.943580564224;5811.070228763462;5873.73568189424;5919.911201331984;5744.942550574441;5748.741306641211;5758.078707406795;5771.480566749013;5783.0457974434585;5100.0819852426175;5108.56577190943;5109.3613298337705;5110.616703747234;5117.130087885069;5887.735051922674;5911.349751527328;5961.672108033927;6178.382161783876;6181.072839074175;5798.391168927202;5922.111683247547;5930.347661757117;5946.989011867906;5961.105834124916;6078.72645730952;6083.148359229623;6096.817095487142;6097.420745029215;6135;5591.077472217039;5610.691411972218;5796;5846.853828654148;5849;5823.94176058234;5833.679147646751;5872.354041055395;5879.676617786063;5957.731902064331;5757.827265182052;5777.62445441045;5789.536837052941;5792.884142317046;5793.739281732248;5611.607187496999;5775.826725198251;5776.7111644418455;5783.681897495678;5798.188253644577;5570.637908536094;5639.492445679908;5643.576731745217;5654.180143879197;5753.079507278815;5715.685637289989;5726;5728.112142617901;5737.770489180386;5738.024535829002;5568.638038527482;5573.080441727069;5579.2746942897165;5582.804601838916;5587.189857470563 08:51:41 INFO - PROCESS | 9899 | |1;ext.html;559.772107014084;585.1924344404721;619.3001907844136;623.2178615837124;653.8921078022126;36326.81836590817;48313.75843120784;49258.999999999956;49285;53322.73338633311;52242.21636675444;52520.474795252034;52650.999999999905;52736.20895686558;52744.73627631857;8964.686235981742;9434.528273586344;9625.518724063804;9635.132838044574;9637.807243855119;8896;11247.66257012291;11467.254628449124;11490.8276375854;11880.287182769018;11587.42062896856;11678.824817627743;11690.415479226047;11690.883091169108;11696.18126731129;11584.536618535249;11621.128415368798;11626.476808543635;11635.476403561775;11640.30158190507;11516.193866429354;11522.769544609144;11550.768984620261;11595.188336816425;11598.130140239431;48559.27161092551;49034.50965490335;49111.26333105006;49180;49258.75370623124;4589.518100599423;4616.422947131608;4665.930011049837;4718.764061796896;4757.738324392157;35329.82335088334;35688.82155589206;35777.284454311026;36087.639123608955;37537.24925501474;4494.73031618104;4569.2003899317815;4591.678582499227;4604.470485894098;4644.7213167210075;359413;359416;359569;360981;361254;70796.29203708;71093;71277;71277;71361.28638713546;73706.63146684233;73929.6303518479;74131.25868741244;74479;74521;19720.21119155218;20305.086271117834;20309.28917487881;20321.390358289274;20337.593248134956;14339.856601433852;14684.779728304084;14862.777058344134;14890.776638350433;15284;19266;19753.50616234577;19822.60354792896;20009.299674511323;20081.698774518394;6635.236947750974;6758.729650814011;6765.8646827063185;6965;6976.6860491277;953.4565297780338;971.771633666088;972.7519482531909;1005.1406047829147;1012.8784545854397;33380.499292510634;34570.308593827984;35019.124521886646;35106.47340289898;35494.290114197574;1049.2707568240153;1147.2313549921573;1162.2561560601223;1171.262104873941;1181.9468123934444;18368.724469132972;18659;18670.159842807105;18747.437576872715;18845.434636960912;518277;519925;522495;522539;525431;69796.30203697999;70277;70385;70449.2955070453;70486.29513704797;1511.1159971416625;1527.0608575726071;1569.536986588959;1576.204016971422;1579.0762403993792;33265.667343326255;34778.82610586931;34835.12912177216;34977.8251108753;35163.472547912315;58727.4127258739;59333;59359.1096133567;59381;59392.109118364126;424899;425390;426149;426952;427187;40588.59411405966;42777.358339625556;45727;45991.77004114958;46217.76891115657;52598;53001.46998529966;53392.733036336125;53960.19059714186;54673;44288;45339.77330113328;45626;45965.540344597466;47100;44251.557484424746;45883.54116458793;46281;46398;47117.52882471131;44775;45325;45377;45865.54134458746;46316.536834631224;38372.61627383802;39435.40846887356;39682.40476392799;40270.79864600658;40732.59267407288;29220.26949326284;29281.26796830011;29311.85344073266;29490.410191795614;29691.257718557208 08:51:41 INFO - PROCESS | 9899 | |2;jquery.html;445.38759206091623;448.3521311704586;453.31323045585935;453.87972187370343;459.53586877253963;19661.50846228845;20361.49096272594;21500.354989350304;21642.24252151175;21676.458088547795;21452.57094858102;21973.340799775993;22176.11295548176;22380.776192238074;22573;6037.184980027706;6038.215032045839;6269;6274.121622972787;6276.278228003769;6051.546134039942;6082.726277317532;6136.877262454748;6140.201773769404;6146.508279337642;5918.763249470016;6068.726907289182;6114.480269177126;6119.173911521954;6120.785772497963;6100.938990610081;6137.324894261627;6149.754009839601;6155;6155.476784473325;5468.070428027205;5519.862003449905;5549.19536667185;5550.91673624896;5553.750081246354;25159.49681006388;25206.747932520808;25207.36981575457;25211.243662690147;25605.48789024228;2964.5404962230887;3027.424789290028;3070.293832418556;3077.8461076946287;3110.315730539278;15966.680666386606;16158.27287772053;16202.189890505428;16206.83793162065;16222.918885405616;2003.7495313085865;2040.540878302385;2056.7737548869763;2058.6294466995937;2143.6570148776123;60587;75723;76026.6198669003;87407.56296218478;89891;10896.78206435867;11384.48769805344;11730.88269117315;11894.167408281337;12286.877131228752;16936.068516231724;16961.406350777663;17003.14984250807;17053.658926821394;17060.57348566271;9096;9176.357654964222;9476.052394760469;9514;9516.809663806685;8985.236254918274;8994.965578958503;9020.368574199743;9167.908320916706;9243.90756092444;5390.353157621033;5430.402655707869;5458.652779304857;5460.781568737286;5668.631538949955;2008.2970960164118;2218.678291647702;2257.4469255032295;2281.851679640818;2302.6085565453914;933.2953620016843;940.8071345374182;947.9004704506066;949.0367277213634;953.0517135450272;20267.087981040888;21472.712900034156;21597.67603485949;21684.674729879065;21710.782892170875;945.0927109974501;947.3747326764302;950.2160717408166;966.8598053282235;968.7093871838421;11850.525978960917;11851;11869.46587403569;11988.400579971141;12091.45588448522;684382;703215;712177;713949;721162;94933.5253323729;95151;96792.51603742078;112158;113559;1161.4470102042822;1173.8650055243756;1191.9821202681967;1201.2372143688647;1223.0215827338093;19057.714134288275;19196.80803192006;19249.807501925363;19306.32427865018;19460;45225.773871130434;45385.31922021238;46591;47232.7638361806;47884.04231915412;65321.67339163464;65701;65813.34186658073;66883.33116668771;67470;9177.632894684139;9276.907230927603;9336.53317334117;9388.765280868032;9437.764055898657;10442.957693933711;14203;14479.565613031626;14559.563213103624;14687.706245875237;12041.976432003028;12119.575814846437;12337.753244935231;12600.87399125997;12619.621411357673;12122.393880306126;12165.20926139798;12485.500579977062;12624;12652.810207847073;11172.950954207301;12463.563775268185;12521.624351269476;12546.309952952675;12871.485140594272;8000.679972801256;8322.250997410261;8379.874301885598;8495.915040849512;9123.406978546373;9207.125323094295;10078.949605251926;12003.219790713576;12665.493380264686;12958.935205323913 08:51:41 INFO - PROCESS | 9899 | |3;mootools.html;1495.3569964915089;1518.8481151884812;1525.4473715674942;1530.1125347298569;1537.2313843078455;8337.166283371667;8695.91304086959;8703.99904011039;8710.346723995694;8719.346049046324;7726.806829829257;7941.841163176733;8156.632951517181;8444.95777521113;8546.40175187737;2375.07372124871;2406.1217655555683;2406.939826504343;2422.709274887016;2424.212131057405;2396.9280921572295;2433.7809597136256;2447.486027934136;2468.950620987579;2469.1604854349516;2371.2530552875874;2378.63131214662;2398.8560686358787;2408.51829634073;2416.2751174647624;2313.2366319114653;2321.303608917318;2322.442613772691;2348.58899692554;2352.4706940938154;2296.1389478945393;2305.619572770491;2358.811295096388;2362.7282862470865;2366.6568347589673;8603;8662.783430414227;8676.652933882637;8685.869711954325;8775.956120219422;5179.948200517984;5252.264682944353;5302.92045619316;5304.814331498379;5314;3138.8744450222193;3239.983800081008;3282.425575524274;3284.6715328467203;3309.1396236978317;1428.0860249440263;1442.0554536778427;1463.787750776142;1492.4254162147543;1512.7730840373922;11253.437328133643;11580.884191158066;11595.94202028993;11632;11650.359230242333;4452.265376212888;4630.884227894262;4668.836590719308;4711.246200607886;4728.621710263171;9456.432614043179;9476.573554190078;9531.428114313163;9533.094356036165;9546.474943878015;5312.07038768214;5321.068812957717;5328.4671532846405;5353;5359.169328754049;4538.909221815546;4552.7495987720995;4968.627352948543;5007.073691367109;5058.165402708585;4154.608206250879;4160.812763425653;4207.537170911197;4264.850730224427;4275.273203555403;1360.081944687332;1383.2184815579164;1384.1556650443222;1392.234271150863;1393.143216921586;1022.9079382855579;1030.6753372687579;1039.1790485516508;1044.3577200022085;1046.99476502617;5763.106718458645;5956.225690660186;5975.970120149458;6041.879162416815;6374.362563743589;1042.2599954032721;1082.4778266638714;1084.2301965604508;1131.643532287327;1132.5696235430485;4085.4688890444054;4093.3859921012086;4114.136031433372;4121.649659778893;4172.687048471377;10240.129588984872;10278.794424111476;10343.63797267092;10374.325668831501;10468.424236666904;9684.46735429544;10198.286119971532;10305.227107966932;10309.175265978854;10351.948240258751;7624.5425274482595;7899.210078992055;7912.4065695073095;7931.643076061591;7935.722249721348;5626.88746225065;5913.46778789911;5964.463198312173;6017.548683848817;6216.53375996793;9335.393199442015;9351.644011618413;9400.059994000545;9445.905540944503;9476.336656433983;9491.477968711511;9563.952180239054;9632.90367096348;9776.071273229032;9793.167580755431;6847.21257055445;7067.858642827217;7079.327463890922;7649.6557654904545;7816.06207255133;7647.579383133759;8033.317168040782;8235.547044912588;8324.042735085543;8455.450395724258;7383.446241532014;7469.365103966006;7590.962045189739;7777.650005749868;7813.492123011986;7516.5114267572435;7595.5822429766895;7639.121501027453;7760.379169666526;7807.726729564665;6221.875562488815;6270.874582508233;6285.874282514415;6292.402221788922;6303.275123360872;4723.480417154179;4891.584215341736;4964.652474326763;5069.163588008085;5128.153854613947;5146.665466744649;5177.974110129425;5206.167013277857;5299.682019078868;5429.375621803543 08:51:41 INFO - PROCESS | 9899 | |4;prototype.html;399.8643851461849;409.4922296352524;409.5378967097243;413.21489170575904;420.9221294060599;5261.842894263445;5309.867253318665;5350.571954243661;5370.248165256862;5370.355557333126;5031.27046578246;5180.585553155748;5192.948070519303;5199.324087868581;5301.734913254341;4074.9388759168637;4170.895727606811;4208.936865947013;4234.099641745399;4239.152169566084;4247.193033323674;4250.277452833026;4250.553691862357;4252.659787217015;4272.739541835151;4144.316187829019;4257.893552661178;4264.978675106636;4271.654428854917;4289.914201715964;4264.125854199912;4266.549373213107;4278.807453664593;4284.421603083606;4292.377605247253;3919.2161567686576;3926.175503144343;3928.705347098979;3928.8409919073943;3929.6070392960473;5073.188289873602;5201.427842937273;5271.973640131775;5274.868128296824;5278.261043453919;4955.578775804061;4961.437147298626;4964.453910069889;4966.453690094087;4967;5576.605848537865;5583.6928968906695;5592.4407559244155;5595;5631.014572449805;4136.276151673475;4333.9133217335475;4344.89137771555;4346.391505189276;4354;5786.623869448515;5794.217780599607;5806.403239109237;5813.331466881278;5827.621204621729;4456.866294011184;4461.375407442961;4468.754218517947;4477;4483.3947417098925;4238.385434112037;4426.454788496628;4540.2293105688805;4540.545945405433;4545.431821022372;4905.435874874363;4927.77824997876;4937.28409380645;4961.7271050092595;4964.304997300381;5613.578981576398;5666.291713535808;5683.54531637468;5687.630304030225;5721.342045664802;1462.1738717624507;1466.4354223623768;1475.7417451945867;1500.6698526324192;1519.6276912156593;1081.4646749858714;1109.5561775289948;1111.5164903267105;1115.9776804463866;1118.2619471149003;5271.868203294948;5336.439673834269;5360.91958620621;5392.514673679388;5396.622236443412;5412.56699464042;5476.67139971595;5511.5039646432015;5530.225768392428;5595.726499997547;5112.3865136183895;5210.140326846104;5288.471152884681;5362;5369.677819330853;2904;2933.618629578184;2945.9705402946124;2957.5508001079315;3002.4295383876993;5768.3654797972185;5782.248307720053;5804.385513516764;5857.4435428634215;5861.9706901465215;5570.025245582007;5860.238169037998;5862.179294898718;5865.765369385262;5880.323762767251;5925.333999250843;5941.405859414111;5943.405659434022;5948.910766338508;5995.250593675791;5520.337559492887;5678.261825962599;5694.800681976111;5723.771049158154;5748.48263656273;5683.829485115453;5684.7157642118555;5687.516561092353;5697.259356283656;5698.572607054404;5880.764769409176;5967.31375891778;5968.612040217372;5998.550108741774;6001.489873360813;4009.7995100245453;4132.1529086537785;4177.749335039907;4181.372794080912;4183.66530677539;5480.314960629921;5507.394186639546;5584.664920104807;5683.119116536944;5698;5539.864327812869;5563.666180029211;5571.359293681278;5590.245316882331;5608.775648973995;5342.7061511615675;5588;5626.831195064155;5636.943630563642;5637.43625637433;5490.149026900836;5601.579881508822;5605;5618.6628802272;5625.831225063254;5586.441355864381;5590.385057643574;5633.8309850704545;5660.433956604306;5663.773449061991;5217.791288348423;5445.564354851682;5468.277492589821;5471.562275018068;5492.340919089735 08:51:41 INFO - PROCESS | 9899 | |5;yui.html;702.3362922038675;708.4297140801656;716.9068021157252;741.1735914455384;755.3239850333952;15749;16157;16192.028478291297;16203.513894583151;16219.351225950963;16059.759103613454;16283.918580407082;16300.918495407535;16303.673926521462;16308.918455407706;806.9596520173997;827.7847759582522;834.7662654456761;841.146236569882;841.4194205997873;849.5412477262271;849.9702510412137;850.5789634131114;851.9701810436636;852.2925971443718;890.2210565754964;891.2513488669516;896.730980705789;896.7668406214366;896.892372915251;886.0784783824814;892.7411050795262;895.476146454325;895.9238464730506;896.2919293757924;645.8966565349522;645.9289478157399;645.9386358295955;646.114822692909;646.2180761278859;17325.220365083474;17617.55956101095;17625.911870440694;17713;18007;15424.460143895021;15505.767413488808;15531.844681553153;15778.842211577852;15794.919990601837;11975.76677771059;12259.69350766229;12268.693282667915;12377.62867113988;12438;3922.88231353057;3980.383040628707;3992.960070399317;4002.8598999035185;4035.656969157625;78886.60556697237;79335.6033219836;79986.6000669993;80904.19095809084;82171.17828821695;11803.586874459354;11944.343061131722;11966.760664786656;12058.577949771716;12100.81848772269;24304.75695243025;24323;24392.146274880648;24527.386815329402;24922.37694057627;8128.715494957648;8302.667893284322;8312.584370781437;8388.664453421918;8506.149385061568;4497.64018878489;4627.490975992638;4684.625229981593;4825.083234185494;5019.598432125421;3623.7644553103964;3725.068732816796;3726.049857286375;3726.4224045273027;3729.869454569077;614.2874265851591;619.4889216396491;619.9380061993854;620.3021600699213;640.7501074580917;709.5175280808996;711.5766119159092;717.989230161548;729.5476804381211;738.5384134915678;9559.235261179088;9588.712338629713;9649.639849346124;9727.951360243154;9738.90261097394;654.7086546486768;672.5628341577916;684.2985939412142;694.7498900395854;710.982225444368;4570.177368073712;4820.783064762094;4822.758862056953;4835.323054772335;4839.540243676845;84567.5771621138;85002.14997850066;85370.57314713387;88071;90520;47468.05063898703;55856.16215756767;56502;61738.382616173265;74568;61579.38420615737;62051.37948620456;62347;62350.37649623446;63790.72418551603;10122;10308.175345972455;10431.739206519898;10515.894841051797;10613.469326533797;42384.36423453589;42598;43741;43820;44201.77899110484;51947.48052519427;52224;52530.21204681856;53351;54541.72729136329;13235.205887646773;13247.867521324664;13253.80119298192;13271.66820829487;13384.063115581816;14544.41822327095;14557.490487832874;14602.926985365006;14666.193359365338;14746.63133421673;13847.79228311556;13954.860451395356;13983.021188516706;14313.28433578296;14498;13478.123921945042;13496.932515337361;13587.116837405538;13602.52391166344;13814.37835297394;13900;14019.789703154665;14081.718365632834;14115;14804.62988425298;10562.407449737218;10937.507812148313;10973.615923442641;11061;11100.61147859821;10891.376036774449;11050.944745276222;11115.166362522681;11202.103831693283;11205.159613029218 08:51:41 INFO - PROCESS | 9899 | __end_tp_report 08:51:41 INFO - PROCESS | 9899 | __start_cc_report 08:51:41 INFO - PROCESS | 9899 | _x_x_mozilla_cycle_collect,1001 08:51:41 INFO - PROCESS | 9899 | __end_cc_report 08:51:41 INFO - PROCESS | 9899 | __startTimestamp1486399901026__endTimestamp 08:51:41 INFO - PROCESS | 9899 | 08:51:41 INFO - PROCESS | 9899 | ------- Summary: start ------- 08:51:41 INFO - PROCESS | 9899 | Number of tests: 6 08:51:41 INFO - PROCESS | 9899 | 08:51:41 INFO - PROCESS | 9899 | [#0] dojo.html Cycles:165 Average:5436.95 Median:5640.21 stddev:596.42 (10.6%) stddev-sans-first:573.57 08:51:41 INFO - PROCESS | 9899 | Values: 3272.5 3309.6 3322.5 3329.7 3363.6 5412.2 5483.0 5495.7 5509.1 5517.3 5475.9 5509.6 5525.6 5534.5 5566.2 4935.6 4944.8 4971.4 5019.9 5048.9 4741.0 4790.3 4973.8 5016.3 5021.2 4847.3 4874.6 4899.6 4966.0 4993.2 5018.8 5021.3 5021.5 5021.9 5036.3 4819.8 4964.5 4980.3 4990.7 5012.0 5294.4 5316.8 5359.2 5390.2 5446.1 5817.4 5819.7 5824.9 5828.6 5828.9 5812.2 5846.6 5878.2 5878.4 5889.5 5346.6 5359.6 5421.0 5544.1 5553.6 5964.6 5983.8 5988.4 5994.6 5995.7 5747.5 5768.1 5778.2 5780.7 5781.2 5605.0 5649.5 5812.4 5826.4 5887.9 5640.2 5689.9 5695.6 5727.1 5734.8 5698.5 5700.8 5701.5 5702.3 5704.9 4441.2 4478.3 4481.4 4487.6 4514.7 3948.0 4036.2 4038.0 4057.4 4061.6 5607.6 5610.3 5610.5 5624.4 5626.9 5612.7 5641.9 5811.1 5873.7 5919.9 5744.9 5748.7 5758.1 5771.5 5783.0 5100.1 5108.6 5109.4 5110.6 5117.1 5887.7 5911.3 5961.7 6178.4 6181.1 5798.4 5922.1 5930.3 5947.0 5961.1 6078.7 6083.1 6096.8 6097.4 6135.0 5591.1 5610.7 5796.0 5846.9 5849.0 5823.9 5833.7 5872.4 5879.7 5957.7 5757.8 5777.6 5789.5 5792.9 5793.7 5611.6 5775.8 5776.7 5783.7 5798.2 5570.6 5639.5 5643.6 5654.2 5753.1 5715.7 5726.0 5728.1 5737.8 5738.0 5568.6 5573.1 5579.3 5582.8 5587.2 08:51:41 INFO - PROCESS | 9899 | 08:51:41 INFO - PROCESS | 9899 | [#1] ext.html Cycles:180 Average:63619.45 Median:44531.50 stddev:116219.66 (261.0%) stddev-sans-first:116449.24 08:51:41 INFO - PROCESS | 9899 | Values: 559.8 585.2 619.3 623.2 653.9 36326.8 48313.8 49259.0 49285.0 53322.7 52242.2 52520.5 52651.0 52736.2 52744.7 8964.7 9434.5 9625.5 9635.1 9637.8 8896.0 11247.7 11467.3 11490.8 11880.3 11587.4 11678.8 11690.4 11690.9 11696.2 11584.5 11621.1 11626.5 11635.5 11640.3 11516.2 11522.8 11550.8 11595.2 11598.1 48559.3 49034.5 49111.3 49180.0 49258.8 4589.5 4616.4 4665.9 4718.8 4757.7 35329.8 35688.8 35777.3 36087.6 37537.2 4494.7 4569.2 4591.7 4604.5 4644.7 359413.0 359416.0 359569.0 360981.0 361254.0 70796.3 71093.0 71277.0 71277.0 71361.3 73706.6 73929.6 74131.3 74479.0 74521.0 19720.2 20305.1 20309.3 20321.4 20337.6 14339.9 14684.8 14862.8 14890.8 15284.0 19266.0 19753.5 19822.6 20009.3 20081.7 6635.2 6758.7 6765.9 6965.0 6976.7 953.5 971.8 972.8 1005.1 1012.9 33380.5 34570.3 35019.1 35106.5 35494.3 1049.3 1147.2 1162.3 1171.3 1181.9 18368.7 18659.0 18670.2 18747.4 18845.4 518277.0 519925.0 522495.0 522539.0 525431.0 69796.3 70277.0 70385.0 70449.3 70486.3 1511.1 1527.1 1569.5 1576.2 1579.1 33265.7 34778.8 34835.1 34977.8 35163.5 58727.4 59333.0 59359.1 59381.0 59392.1 424899.0 425390.0 426149.0 426952.0 427187.0 40588.6 42777.4 45727.0 45991.8 46217.8 52598.0 53001.5 53392.7 53960.2 54673.0 44288.0 45339.8 45626.0 45965.5 47100.0 44251.6 45883.5 46281.0 46398.0 47117.5 44775.0 45325.0 45377.0 45865.5 46316.5 38372.6 39435.4 39682.4 40270.8 40732.6 29220.3 29281.3 29311.9 29490.4 29691.3 08:51:41 INFO - PROCESS | 9899 | 08:51:41 INFO - PROCESS | 9899 | [#2] jquery.html Cycles:180 Average:36403.75 Median:1777.85 stddev:115809.50 (6514.0%) stddev-sans-first:116102.90 08:51:41 INFO - PROCESS | 9899 | Values: 445.4 448.4 453.3 453.9 459.5 19661.5 20361.5 21500.4 21642.2 21676.5 21452.6 21973.3 22176.1 22380.8 22573.0 6037.2 6038.2 6269.0 6274.1 6276.3 6051.5 6082.7 6136.9 6140.2 6146.5 5918.8 6068.7 6114.5 6119.2 6120.8 6100.9 6137.3 6149.8 6155.0 6155.5 5468.1 5519.9 5549.2 5550.9 5553.8 25159.5 25206.7 25207.4 25211.2 25605.5 2964.5 3027.4 3070.3 3077.8 3110.3 15966.7 16158.3 16202.2 16206.8 16222.9 2003.7 2040.5 2056.8 2058.6 2143.7 60587.0 75723.0 76026.6 87407.6 89891.0 10896.8 11384.5 11730.9 11894.2 12286.9 16936.1 16961.4 17003.1 17053.7 17060.6 9096.0 9176.4 9476.1 9514.0 9516.8 8985.2 8995.0 9020.4 9167.9 9243.9 5390.4 5430.4 5458.7 5460.8 5668.6 2008.3 2218.7 2257.4 2281.9 2302.6 933.3 940.8 947.9 949.0 953.1 20267.1 21472.7 21597.7 21684.7 21710.8 945.1 947.4 950.2 966.9 968.7 11850.5 11851.0 11869.5 11988.4 12091.5 684382.0 703215.0 712177.0 713949.0 721162.0 94933.5 95151.0 96792.5 112158.0 113559.0 1161.4 1173.9 1192.0 1201.2 1223.0 19057.7 19196.8 19249.8 19306.3 19460.0 45225.8 45385.3 46591.0 47232.8 47884.0 65321.7 65701.0 65813.3 66883.3 67470.0 9177.6 9276.9 9336.5 9388.8 9437.8 10443.0 14203.0 14479.6 14559.6 14687.7 12042.0 12119.6 12337.8 12600.9 12619.6 12122.4 12165.2 12485.5 12624.0 12652.8 11173.0 12463.6 12521.6 12546.3 12871.5 8000.7 8322.3 8379.9 8495.9 9123.4 9207.1 10078.9 12003.2 12665.5 12958.9 08:51:41 INFO - PROCESS | 9899 | 08:51:41 INFO - PROCESS | 9899 | [#3] mootools.html Cycles:180 Average:5643.78 Median:5032.62 stddev:3038.02 (60.4%) stddev-sans-first:3030.54 08:51:41 INFO - PROCESS | 9899 | Values: 1495.4 1518.8 1525.4 1530.1 1537.2 8337.2 8695.9 8704.0 8710.3 8719.3 7726.8 7941.8 8156.6 8445.0 8546.4 2375.1 2406.1 2406.9 2422.7 2424.2 2396.9 2433.8 2447.5 2469.0 2469.2 2371.3 2378.6 2398.9 2408.5 2416.3 2313.2 2321.3 2322.4 2348.6 2352.5 2296.1 2305.6 2358.8 2362.7 2366.7 8603.0 8662.8 8676.7 8685.9 8776.0 5179.9 5252.3 5302.9 5304.8 5314.0 3138.9 3240.0 3282.4 3284.7 3309.1 1428.1 1442.1 1463.8 1492.4 1512.8 11253.4 11580.9 11595.9 11632.0 11650.4 4452.3 4630.9 4668.8 4711.2 4728.6 9456.4 9476.6 9531.4 9533.1 9546.5 5312.1 5321.1 5328.5 5353.0 5359.2 4538.9 4552.7 4968.6 5007.1 5058.2 4154.6 4160.8 4207.5 4264.9 4275.3 1360.1 1383.2 1384.2 1392.2 1393.1 1022.9 1030.7 1039.2 1044.4 1047.0 5763.1 5956.2 5976.0 6041.9 6374.4 1042.3 1082.5 1084.2 1131.6 1132.6 4085.5 4093.4 4114.1 4121.6 4172.7 10240.1 10278.8 10343.6 10374.3 10468.4 9684.5 10198.3 10305.2 10309.2 10351.9 7624.5 7899.2 7912.4 7931.6 7935.7 5626.9 5913.5 5964.5 6017.5 6216.5 9335.4 9351.6 9400.1 9445.9 9476.3 9491.5 9564.0 9632.9 9776.1 9793.2 6847.2 7067.9 7079.3 7649.7 7816.1 7647.6 8033.3 8235.5 8324.0 8455.5 7383.4 7469.4 7591.0 7777.7 7813.5 7516.5 7595.6 7639.1 7760.4 7807.7 6221.9 6270.9 6285.9 6292.4 6303.3 4723.5 4891.6 4964.7 5069.2 5128.2 5146.7 5178.0 5206.2 5299.7 5429.4 08:51:41 INFO - PROCESS | 9899 | 08:51:41 INFO - PROCESS | 9899 | [#4] prototype.html Cycles:180 Average:4758.70 Median:5305.80 stddev:1338.90 (25.2%) stddev-sans-first:1302.07 08:51:41 INFO - PROCESS | 9899 | Values: 399.9 409.5 409.5 413.2 420.9 5261.8 5309.9 5350.6 5370.2 5370.4 5031.3 5180.6 5192.9 5199.3 5301.7 4074.9 4170.9 4208.9 4234.1 4239.2 4247.2 4250.3 4250.6 4252.7 4272.7 4144.3 4257.9 4265.0 4271.7 4289.9 4264.1 4266.5 4278.8 4284.4 4292.4 3919.2 3926.2 3928.7 3928.8 3929.6 5073.2 5201.4 5272.0 5274.9 5278.3 4955.6 4961.4 4964.5 4966.5 4967.0 5576.6 5583.7 5592.4 5595.0 5631.0 4136.3 4333.9 4344.9 4346.4 4354.0 5786.6 5794.2 5806.4 5813.3 5827.6 4456.9 4461.4 4468.8 4477.0 4483.4 4238.4 4426.5 4540.2 4540.5 4545.4 4905.4 4927.8 4937.3 4961.7 4964.3 5613.6 5666.3 5683.5 5687.6 5721.3 1462.2 1466.4 1475.7 1500.7 1519.6 1081.5 1109.6 1111.5 1116.0 1118.3 5271.9 5336.4 5360.9 5392.5 5396.6 5412.6 5476.7 5511.5 5530.2 5595.7 5112.4 5210.1 5288.5 5362.0 5369.7 2904.0 2933.6 2946.0 2957.6 3002.4 5768.4 5782.2 5804.4 5857.4 5862.0 5570.0 5860.2 5862.2 5865.8 5880.3 5925.3 5941.4 5943.4 5948.9 5995.3 5520.3 5678.3 5694.8 5723.8 5748.5 5683.8 5684.7 5687.5 5697.3 5698.6 5880.8 5967.3 5968.6 5998.6 6001.5 4009.8 4132.2 4177.7 4181.4 4183.7 5480.3 5507.4 5584.7 5683.1 5698.0 5539.9 5563.7 5571.4 5590.2 5608.8 5342.7 5588.0 5626.8 5636.9 5637.4 5490.1 5601.6 5605.0 5618.7 5625.8 5586.4 5590.4 5633.8 5660.4 5663.8 5217.8 5445.6 5468.3 5471.6 5492.3 08:51:41 INFO - PROCESS | 9899 | 08:51:41 INFO - PROCESS | 9899 | [#5] yui.html Cycles:180 Average:17875.12 Median:4533.91 stddev:22529.08 (496.9%) stddev-sans-first:22555.37 08:51:41 INFO - PROCESS | 9899 | Values: 702.3 708.4 716.9 741.2 755.3 15749.0 16157.0 16192.0 16203.5 16219.4 16059.8 16283.9 16300.9 16303.7 16308.9 807.0 827.8 834.8 841.1 841.4 849.5 850.0 850.6 852.0 852.3 890.2 891.3 896.7 896.8 896.9 886.1 892.7 895.5 895.9 896.3 645.9 645.9 645.9 646.1 646.2 17325.2 17617.6 17625.9 17713.0 18007.0 15424.5 15505.8 15531.8 15778.8 15794.9 11975.8 12259.7 12268.7 12377.6 12438.0 3922.9 3980.4 3993.0 4002.9 4035.7 78886.6 79335.6 79986.6 80904.2 82171.2 11803.6 11944.3 11966.8 12058.6 12100.8 24304.8 24323.0 24392.1 24527.4 24922.4 8128.7 8302.7 8312.6 8388.7 8506.1 4497.6 4627.5 4684.6 4825.1 5019.6 3623.8 3725.1 3726.0 3726.4 3729.9 614.3 619.5 619.9 620.3 640.8 709.5 711.6 718.0 729.5 738.5 9559.2 9588.7 9649.6 9728.0 9738.9 654.7 672.6 684.3 694.7 711.0 4570.2 4820.8 4822.8 4835.3 4839.5 84567.6 85002.1 85370.6 88071.0 90520.0 47468.1 55856.2 56502.0 61738.4 74568.0 61579.4 62051.4 62347.0 62350.4 63790.7 10122.0 10308.2 10431.7 10515.9 10613.5 42384.4 42598.0 43741.0 43820.0 44201.8 51947.5 52224.0 52530.2 53351.0 54541.7 13235.2 13247.9 13253.8 13271.7 13384.1 14544.4 14557.5 14602.9 14666.2 14746.6 13847.8 13954.9 13983.0 14313.3 14498.0 13478.1 13496.9 13587.1 13602.5 13814.4 13900.0 14019.8 14081.7 14115.0 14804.6 10562.4 10937.5 10973.6 11061.0 11100.6 10891.4 11050.9 11115.2 11202.1 11205.2 08:51:41 INFO - PROCESS | 9899 | -------- Summary: end -------- 08:51:41 INFO - PROCESS | 9899 | 08:51:41 INFO - TEST-INFO | 9899: exit 0 08:51:41 INFO - TEST-OK | dromaeo_css | took 1113417ms 08:51:41 INFO - TEST-START | kraken 08:51:41 INFO - operating with platform_type : linux_ 08:51:41 INFO - Initialising browser for kraken test... 08:51:41 INFO - TEST-INFO | started process 10218 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaJMR5X/profile http://localhost:44330/getInfo.html) 08:51:45 INFO - PROCESS | 10218 | __metrics Screen width/height:1600/1200 08:51:45 INFO - PROCESS | 10218 | colorDepth:24 08:51:45 INFO - PROCESS | 10218 | Browser inner width/height: 1024/697 08:51:45 INFO - PROCESS | 10218 | __metrics 08:51:46 INFO - PROCESS | 10218 | 1486399906117 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 08:51:46 INFO - PROCESS | 10218 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:51:46 INFO - PROCESS | 10218 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:51:46 INFO - PROCESS | 10218 | console.error: PushService: 08:51:46 INFO - PROCESS | 10218 | stateChangeProcessEnqueue: Error transitioning state 08:51:46 INFO - PROCESS | 10218 | UnknownError 08:51:47 INFO - TEST-INFO | 10218: exit 0 08:51:47 INFO - Browser initialized. 08:51:47 INFO - Running cycle 1/1 for kraken test... 08:51:47 INFO - TEST-INFO | started process 10310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaJMR5X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:51:59 INFO - PROCESS | 10310 | RSS: Main: 141688832 08:51:59 INFO - PROCESS | 10310 | 08:52:01 INFO - PROCESS | 10310 | Cycle 1(1): loaded http://localhost:44330/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44330/tests/kraken/driver.html?testName=audio-beat-detection) 08:52:02 INFO - PROCESS | 10310 | RSS: Main: 187940864 08:52:02 INFO - PROCESS | 10310 | 08:52:04 INFO - PROCESS | 10310 | Cycle 1(1): loaded http://localhost:44330/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44330/tests/kraken/driver.html?testName=audio-dft) 08:52:05 INFO - PROCESS | 10310 | RSS: Main: 175677440 08:52:05 INFO - PROCESS | 10310 | 08:52:08 INFO - PROCESS | 10310 | Cycle 1(1): loaded http://localhost:44330/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44330/tests/kraken/driver.html?testName=audio-fft) 08:52:08 INFO - PROCESS | 10310 | RSS: Main: 266850304 08:52:08 INFO - PROCESS | 10310 | 08:52:11 INFO - PROCESS | 10310 | Cycle 1(1): loaded http://localhost:44330/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44330/tests/kraken/driver.html?testName=audio-oscillator) 08:52:11 INFO - PROCESS | 10310 | RSS: Main: 173142016 08:52:11 INFO - PROCESS | 10310 | 08:52:13 INFO - PROCESS | 10310 | Cycle 1(1): loaded http://localhost:44330/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44330/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:52:14 INFO - PROCESS | 10310 | RSS: Main: 175935488 08:52:14 INFO - PROCESS | 10310 | 08:52:17 INFO - PROCESS | 10310 | Cycle 1(1): loaded http://localhost:44330/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44330/tests/kraken/driver.html?testName=imaging-darkroom) 08:52:17 INFO - PROCESS | 10310 | RSS: Main: 214368256 08:52:17 INFO - PROCESS | 10310 | 08:52:21 INFO - PROCESS | 10310 | Cycle 1(1): loaded http://localhost:44330/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44330/tests/kraken/driver.html?testName=imaging-desaturate) 08:52:21 INFO - PROCESS | 10310 | RSS: Main: 212946944 08:52:21 INFO - PROCESS | 10310 | 08:52:24 INFO - PROCESS | 10310 | Cycle 1(1): loaded http://localhost:44330/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44330/tests/kraken/driver.html?testName=json-parse-financial) 08:52:25 INFO - PROCESS | 10310 | RSS: Main: 211898368 08:52:25 INFO - PROCESS | 10310 | 08:52:26 INFO - PROCESS | 10310 | Cycle 1(1): loaded http://localhost:44330/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44330/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:52:27 INFO - PROCESS | 10310 | RSS: Main: 173875200 08:52:27 INFO - PROCESS | 10310 | 08:52:28 INFO - PROCESS | 10310 | Cycle 1(1): loaded http://localhost:44330/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44330/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:52:29 INFO - PROCESS | 10310 | RSS: Main: 181248000 08:52:29 INFO - PROCESS | 10310 | 08:52:31 INFO - PROCESS | 10310 | Cycle 1(1): loaded http://localhost:44330/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44330/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:52:32 INFO - PROCESS | 10310 | RSS: Main: 186970112 08:52:32 INFO - PROCESS | 10310 | 08:52:34 INFO - PROCESS | 10310 | Cycle 1(1): loaded http://localhost:44330/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:52:35 INFO - PROCESS | 10310 | RSS: Main: 196661248 08:52:35 INFO - PROCESS | 10310 | 08:52:38 INFO - PROCESS | 10310 | Cycle 1(1): loaded http://localhost:44330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:52:38 INFO - PROCESS | 10310 | RSS: Main: 193458176 08:52:38 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | Cycle 1(1): loaded http://localhost:44330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44330/tests/kraken/driver.html?testName=ai-astar) 08:52:40 INFO - PROCESS | 10310 | RSS: Main: 245776384 08:52:40 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | __start_tp_report 08:52:40 INFO - PROCESS | 10310 | _x_x_mozilla_page_load 08:52:40 INFO - PROCESS | 10310 | _x_x_mozilla_page_load_details 08:52:40 INFO - PROCESS | 10310 | |i|pagename|runs| 08:52:40 INFO - PROCESS | 10310 | |0;ai-astar;113;110;111;110;111;112;112;111;112;111 08:52:40 INFO - PROCESS | 10310 | |1;audio-beat-detection;139;117;119;160;123;119;120;122;142;118 08:52:40 INFO - PROCESS | 10310 | |2;audio-dft;159;162;159;161;160;161;162;158;160;159 08:52:40 INFO - PROCESS | 10310 | |3;audio-fft;74;75;75;121;75;76;76;75;92;75 08:52:40 INFO - PROCESS | 10310 | |4;audio-oscillator;82;82;107;83;83;82;105;82;81;108 08:52:40 INFO - PROCESS | 10310 | |5;imaging-gaussian-blur;118;117;117;116;117;118;116;117;117;117 08:52:40 INFO - PROCESS | 10310 | |6;imaging-darkroom;147;146;146;146;147;147;147;148;146;146 08:52:40 INFO - PROCESS | 10310 | |7;imaging-desaturate;96;95;96;95;96;96;96;96;96;96 08:52:40 INFO - PROCESS | 10310 | |8;json-parse-financial;50;49;49;48;49;49;48;49;49;49 08:52:40 INFO - PROCESS | 10310 | |9;json-stringify-tinderbox;64;64;63;63;68;64;64;63;66;64 08:52:40 INFO - PROCESS | 10310 | |10;stanford-crypto-aes;80;76;75;76;75;76;76;85;75;82 08:52:40 INFO - PROCESS | 10310 | |11;stanford-crypto-ccm;123;122;123;121;122;121;124;119;166;126 08:52:40 INFO - PROCESS | 10310 | |12;stanford-crypto-pbkdf2;168;157;165;155;155;154;157;156;158;156 08:52:40 INFO - PROCESS | 10310 | |13;stanford-crypto-sha256-iterative;62;62;60;63;61;62;61;60;60;59 08:52:40 INFO - PROCESS | 10310 | __end_tp_report 08:52:40 INFO - PROCESS | 10310 | __start_cc_report 08:52:40 INFO - PROCESS | 10310 | _x_x_mozilla_cycle_collect,1541 08:52:40 INFO - PROCESS | 10310 | __end_cc_report 08:52:40 INFO - PROCESS | 10310 | __startTimestamp1486399960569__endTimestamp 08:52:40 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | ------- Summary: start ------- 08:52:40 INFO - PROCESS | 10310 | Number of tests: 14 08:52:40 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.50 stddev:0.95 (0.9%) stddev-sans-first:0.78 08:52:40 INFO - PROCESS | 10310 | Values: 113.0 110.0 111.0 110.0 111.0 112.0 112.0 111.0 112.0 111.0 08:52:40 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:122.50 stddev:14.33 (11.7%) stddev-sans-first:14.63 08:52:40 INFO - PROCESS | 10310 | Values: 139.0 117.0 119.0 160.0 123.0 119.0 120.0 122.0 142.0 118.0 08:52:40 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:1.37 (0.9%) stddev-sans-first:1.39 08:52:40 INFO - PROCESS | 10310 | Values: 159.0 162.0 159.0 161.0 160.0 161.0 162.0 158.0 160.0 159.0 08:52:40 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:14.90 (19.9%) stddev-sans-first:15.56 08:52:40 INFO - PROCESS | 10310 | Values: 74.0 75.0 75.0 121.0 75.0 76.0 76.0 75.0 92.0 75.0 08:52:40 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:82.00 stddev:11.88 (14.5%) stddev-sans-first:12.29 08:52:40 INFO - PROCESS | 10310 | Values: 82.0 82.0 107.0 83.0 83.0 82.0 105.0 82.0 81.0 108.0 08:52:40 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 08:52:40 INFO - PROCESS | 10310 | Values: 118.0 117.0 117.0 116.0 117.0 118.0 116.0 117.0 117.0 117.0 08:52:40 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 08:52:40 INFO - PROCESS | 10310 | Values: 147.0 146.0 146.0 146.0 147.0 147.0 147.0 148.0 146.0 146.0 08:52:40 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:52:40 INFO - PROCESS | 10310 | Values: 96.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 08:52:40 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | [#8] json-parse-financial Cycles:10 Average:48.90 Median:49.00 stddev:0.57 (1.2%) stddev-sans-first:0.44 08:52:40 INFO - PROCESS | 10310 | Values: 50.0 49.0 49.0 48.0 49.0 49.0 48.0 49.0 49.0 49.0 08:52:40 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:1.57 (2.4%) stddev-sans-first:1.66 08:52:40 INFO - PROCESS | 10310 | Values: 64.0 64.0 63.0 63.0 68.0 64.0 64.0 63.0 66.0 64.0 08:52:40 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:76.00 stddev:3.50 (4.6%) stddev-sans-first:3.61 08:52:40 INFO - PROCESS | 10310 | Values: 80.0 76.0 75.0 76.0 75.0 76.0 76.0 85.0 75.0 82.0 08:52:40 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:123.00 stddev:13.94 (11.3%) stddev-sans-first:14.72 08:52:40 INFO - PROCESS | 10310 | Values: 123.0 122.0 123.0 121.0 122.0 121.0 124.0 119.0 166.0 126.0 08:52:40 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:157.00 stddev:4.63 (2.9%) stddev-sans-first:3.24 08:52:40 INFO - PROCESS | 10310 | Values: 168.0 157.0 165.0 155.0 155.0 154.0 157.0 156.0 158.0 156.0 08:52:40 INFO - PROCESS | 10310 | 08:52:40 INFO - PROCESS | 10310 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.00 Median:61.50 stddev:1.25 (2.0%) stddev-sans-first:1.27 08:52:40 INFO - PROCESS | 10310 | Values: 62.0 62.0 60.0 63.0 61.0 62.0 61.0 60.0 60.0 59.0 08:52:40 INFO - PROCESS | 10310 | -------- Summary: end -------- 08:52:40 INFO - PROCESS | 10310 | 08:52:41 INFO - TEST-INFO | 10310: exit 0 08:52:41 INFO - TEST-OK | kraken | took 59974ms 08:52:41 INFO - SUITE-END | took 1173s 08:52:42 INFO - Completed test suite (00:19:33) 08:52:42 INFO - javascript benchmark 08:52:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3272.525483804848, 3309.553210316608, 3322.5348451216832, 3329.650386709397, 3363.6468170842063, 5412.215228791828, 5483.0, 5495.725213739307, 5509.090999984997, 5517.337919449662, 5475.917861232085, 5509.614326997112, 5525.613207075507, 5534.4742249486335, 5566.165075238716, 4935.555799977992, 4944.777485013183, 4971.403431588196, 5019.874503137415, 5048.9495105048845, 4741.028089241714, 4790.257510085925, 4973.825916092937, 5016.29771831942, 5021.196608542634, 4847.345608342882, 4874.610031197496, 4899.6325275604295, 4965.975170124144, 4993.201087825949, 5018.824341148061, 5021.347224860763, 5021.49785021495, 5021.949780502221, 5036.320096786923, 4819.783109760069, 4964.453910069889, 4980.252962055684, 4990.675606085593, 5012.04771093491, 5294.41761406245, 5316.813911513117, 5359.196120581944, 5390.19147127934, 5446.101393270105, 5817.447342502455, 5819.7090145492975, 5824.912626310609, 5828.621139625953, 5828.941710582924, 5812.244408226946, 5846.619969701956, 5878.177055212231, 5878.353381128072, 5889.528837692974, 5346.625736198468, 5359.624826262163, 5421.0, 5544.085225937756, 5553.583481238923, 5964.642121472725, 5983.790567330123, 5988.401159883977, 5994.6403215807195, 5995.730192141364, 5747.48272655463, 5768.105943578752, 5778.162166485836, 5780.682062486603, 5781.19063331134, 5605.019121653694, 5649.463300986482, 5812.418758124239, 5826.41735826414, 5887.941120588739, 5640.210370548127, 5689.886202275931, 5695.572832037614, 5727.11229759388, 5734.827955161351, 5698.487136157766, 5700.8004719835435, 5701.515371193495, 5702.258706368146, 5704.942950570441, 4441.244988351988, 4478.328250762412, 4481.3726078349055, 4487.640988720895, 4514.706544074625, 3947.9605203948167, 4036.1524079943542, 4038.0, 4057.3711074783455, 4061.593840615915, 5607.607467477237, 5610.32676078865, 5610.49505544503, 5624.409437009055, 5626.915596266059, 5612.663240205601, 5641.943580564224, 5811.070228763462, 5873.73568189424, 5919.911201331984, 5744.942550574441, 5748.741306641211, 5758.078707406795, 5771.480566749013, 5783.0457974434585, 5100.0819852426175, 5108.56577190943, 5109.3613298337705, 5110.616703747234, 5117.130087885069, 5887.735051922674, 5911.349751527328, 5961.672108033927, 6178.382161783876, 6181.072839074175, 5798.391168927202, 5922.111683247547, 5930.347661757117, 5946.989011867906, 5961.105834124916, 6078.72645730952, 6083.148359229623, 6096.817095487142, 6097.420745029215, 6135.0, 5591.077472217039, 5610.691411972218, 5796.0, 5846.853828654148, 5849.0, 5823.94176058234, 5833.679147646751, 5872.354041055395, 5879.676617786063, 5957.731902064331, 5757.827265182052, 5777.62445441045, 5789.536837052941, 5792.884142317046, 5793.739281732248, 5611.607187496999, 5775.826725198251, 5776.7111644418455, 5783.681897495678, 5798.188253644577, 5570.637908536094, 5639.492445679908, 5643.576731745217, 5654.180143879197, 5753.079507278815, 5715.685637289989, 5726.0, 5728.112142617901, 5737.770489180386, 5738.024535829002, 5568.638038527482, 5573.080441727069, 5579.2746942897165, 5582.804601838916, 5587.189857470563], "value": 5398.92145283709, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.772107014084, 585.1924344404721, 619.3001907844136, 623.2178615837124, 653.8921078022126, 36326.81836590817, 48313.75843120784, 49258.999999999956, 49285.0, 53322.73338633311, 52242.21636675444, 52520.474795252034, 52650.999999999905, 52736.20895686558, 52744.73627631857, 8964.686235981742, 9434.528273586344, 9625.518724063804, 9635.132838044574, 9637.807243855119, 8896.0, 11247.66257012291, 11467.254628449124, 11490.8276375854, 11880.287182769018, 11587.42062896856, 11678.824817627743, 11690.415479226047, 11690.883091169108, 11696.18126731129, 11584.536618535249, 11621.128415368798, 11626.476808543635, 11635.476403561775, 11640.30158190507, 11516.193866429354, 11522.769544609144, 11550.768984620261, 11595.188336816425, 11598.130140239431, 48559.27161092551, 49034.50965490335, 49111.26333105006, 49180.0, 49258.75370623124, 4589.518100599423, 4616.422947131608, 4665.930011049837, 4718.764061796896, 4757.738324392157, 35329.82335088334, 35688.82155589206, 35777.284454311026, 36087.639123608955, 37537.24925501474, 4494.73031618104, 4569.2003899317815, 4591.678582499227, 4604.470485894098, 4644.7213167210075, 359413.0, 359416.0, 359569.0, 360981.0, 361254.0, 70796.29203708, 71093.0, 71277.0, 71277.0, 71361.28638713546, 73706.63146684233, 73929.6303518479, 74131.25868741244, 74479.0, 74521.0, 19720.21119155218, 20305.086271117834, 20309.28917487881, 20321.390358289274, 20337.593248134956, 14339.856601433852, 14684.779728304084, 14862.777058344134, 14890.776638350433, 15284.0, 19266.0, 19753.50616234577, 19822.60354792896, 20009.299674511323, 20081.698774518394, 6635.236947750974, 6758.729650814011, 6765.8646827063185, 6965.0, 6976.6860491277, 953.4565297780338, 971.771633666088, 972.7519482531909, 1005.1406047829147, 1012.8784545854397, 33380.499292510634, 34570.308593827984, 35019.124521886646, 35106.47340289898, 35494.290114197574, 1049.2707568240153, 1147.2313549921573, 1162.2561560601223, 1171.262104873941, 1181.9468123934444, 18368.724469132972, 18659.0, 18670.159842807105, 18747.437576872715, 18845.434636960912, 518277.0, 519925.0, 522495.0, 522539.0, 525431.0, 69796.30203697999, 70277.0, 70385.0, 70449.2955070453, 70486.29513704797, 1511.1159971416625, 1527.0608575726071, 1569.536986588959, 1576.204016971422, 1579.0762403993792, 33265.667343326255, 34778.82610586931, 34835.12912177216, 34977.8251108753, 35163.472547912315, 58727.4127258739, 59333.0, 59359.1096133567, 59381.0, 59392.109118364126, 424899.0, 425390.0, 426149.0, 426952.0, 427187.0, 40588.59411405966, 42777.358339625556, 45727.0, 45991.77004114958, 46217.76891115657, 52598.0, 53001.46998529966, 53392.733036336125, 53960.19059714186, 54673.0, 44288.0, 45339.77330113328, 45626.0, 45965.540344597466, 47100.0, 44251.557484424746, 45883.54116458793, 46281.0, 46398.0, 47117.52882471131, 44775.0, 45325.0, 45377.0, 45865.54134458746, 46316.536834631224, 38372.61627383802, 39435.40846887356, 39682.40476392799, 40270.79864600658, 40732.59267407288, 29220.26949326284, 29281.26796830011, 29311.85344073266, 29490.410191795614, 29691.257718557208], "value": 22729.813741412436, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.38759206091623, 448.3521311704586, 453.31323045585935, 453.87972187370343, 459.53586877253963, 19661.50846228845, 20361.49096272594, 21500.354989350304, 21642.24252151175, 21676.458088547795, 21452.57094858102, 21973.340799775993, 22176.11295548176, 22380.776192238074, 22573.0, 6037.184980027706, 6038.215032045839, 6269.0, 6274.121622972787, 6276.278228003769, 6051.546134039942, 6082.726277317532, 6136.877262454748, 6140.201773769404, 6146.508279337642, 5918.763249470016, 6068.726907289182, 6114.480269177126, 6119.173911521954, 6120.785772497963, 6100.938990610081, 6137.324894261627, 6149.754009839601, 6155.0, 6155.476784473325, 5468.070428027205, 5519.862003449905, 5549.19536667185, 5550.91673624896, 5553.750081246354, 25159.49681006388, 25206.747932520808, 25207.36981575457, 25211.243662690147, 25605.48789024228, 2964.5404962230887, 3027.424789290028, 3070.293832418556, 3077.8461076946287, 3110.315730539278, 15966.680666386606, 16158.27287772053, 16202.189890505428, 16206.83793162065, 16222.918885405616, 2003.7495313085865, 2040.540878302385, 2056.7737548869763, 2058.6294466995937, 2143.6570148776123, 60587.0, 75723.0, 76026.6198669003, 87407.56296218478, 89891.0, 10896.78206435867, 11384.48769805344, 11730.88269117315, 11894.167408281337, 12286.877131228752, 16936.068516231724, 16961.406350777663, 17003.14984250807, 17053.658926821394, 17060.57348566271, 9096.0, 9176.357654964222, 9476.052394760469, 9514.0, 9516.809663806685, 8985.236254918274, 8994.965578958503, 9020.368574199743, 9167.908320916706, 9243.90756092444, 5390.353157621033, 5430.402655707869, 5458.652779304857, 5460.781568737286, 5668.631538949955, 2008.2970960164118, 2218.678291647702, 2257.4469255032295, 2281.851679640818, 2302.6085565453914, 933.2953620016843, 940.8071345374182, 947.9004704506066, 949.0367277213634, 953.0517135450272, 20267.087981040888, 21472.712900034156, 21597.67603485949, 21684.674729879065, 21710.782892170875, 945.0927109974501, 947.3747326764302, 950.2160717408166, 966.8598053282235, 968.7093871838421, 11850.525978960917, 11851.0, 11869.46587403569, 11988.400579971141, 12091.45588448522, 684382.0, 703215.0, 712177.0, 713949.0, 721162.0, 94933.5253323729, 95151.0, 96792.51603742078, 112158.0, 113559.0, 1161.4470102042822, 1173.8650055243756, 1191.9821202681967, 1201.2372143688647, 1223.0215827338093, 19057.714134288275, 19196.80803192006, 19249.807501925363, 19306.32427865018, 19460.0, 45225.773871130434, 45385.31922021238, 46591.0, 47232.7638361806, 47884.04231915412, 65321.67339163464, 65701.0, 65813.34186658073, 66883.33116668771, 67470.0, 9177.632894684139, 9276.907230927603, 9336.53317334117, 9388.765280868032, 9437.764055898657, 10442.957693933711, 14203.0, 14479.565613031626, 14559.563213103624, 14687.706245875237, 12041.976432003028, 12119.575814846437, 12337.753244935231, 12600.87399125997, 12619.621411357673, 12122.393880306126, 12165.20926139798, 12485.500579977062, 12624.0, 12652.810207847073, 11172.950954207301, 12463.563775268185, 12521.624351269476, 12546.309952952675, 12871.485140594272, 8000.679972801256, 8322.250997410261, 8379.874301885598, 8495.915040849512, 9123.406978546373, 9207.125323094295, 10078.949605251926, 12003.219790713576, 12665.493380264686, 12958.935205323913], "value": 10168.06086405847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.3569964915089, 1518.8481151884812, 1525.4473715674942, 1530.1125347298569, 1537.2313843078455, 8337.166283371667, 8695.91304086959, 8703.99904011039, 8710.346723995694, 8719.346049046324, 7726.806829829257, 7941.841163176733, 8156.632951517181, 8444.95777521113, 8546.40175187737, 2375.07372124871, 2406.1217655555683, 2406.939826504343, 2422.709274887016, 2424.212131057405, 2396.9280921572295, 2433.7809597136256, 2447.486027934136, 2468.950620987579, 2469.1604854349516, 2371.2530552875874, 2378.63131214662, 2398.8560686358787, 2408.51829634073, 2416.2751174647624, 2313.2366319114653, 2321.303608917318, 2322.442613772691, 2348.58899692554, 2352.4706940938154, 2296.1389478945393, 2305.619572770491, 2358.811295096388, 2362.7282862470865, 2366.6568347589673, 8603.0, 8662.783430414227, 8676.652933882637, 8685.869711954325, 8775.956120219422, 5179.948200517984, 5252.264682944353, 5302.92045619316, 5304.814331498379, 5314.0, 3138.8744450222193, 3239.983800081008, 3282.425575524274, 3284.6715328467203, 3309.1396236978317, 1428.0860249440263, 1442.0554536778427, 1463.787750776142, 1492.4254162147543, 1512.7730840373922, 11253.437328133643, 11580.884191158066, 11595.94202028993, 11632.0, 11650.359230242333, 4452.265376212888, 4630.884227894262, 4668.836590719308, 4711.246200607886, 4728.621710263171, 9456.432614043179, 9476.573554190078, 9531.428114313163, 9533.094356036165, 9546.474943878015, 5312.07038768214, 5321.068812957717, 5328.4671532846405, 5353.0, 5359.169328754049, 4538.909221815546, 4552.7495987720995, 4968.627352948543, 5007.073691367109, 5058.165402708585, 4154.608206250879, 4160.812763425653, 4207.537170911197, 4264.850730224427, 4275.273203555403, 1360.081944687332, 1383.2184815579164, 1384.1556650443222, 1392.234271150863, 1393.143216921586, 1022.9079382855579, 1030.6753372687579, 1039.1790485516508, 1044.3577200022085, 1046.99476502617, 5763.106718458645, 5956.225690660186, 5975.970120149458, 6041.879162416815, 6374.362563743589, 1042.2599954032721, 1082.4778266638714, 1084.2301965604508, 1131.643532287327, 1132.5696235430485, 4085.4688890444054, 4093.3859921012086, 4114.136031433372, 4121.649659778893, 4172.687048471377, 10240.129588984872, 10278.794424111476, 10343.63797267092, 10374.325668831501, 10468.424236666904, 9684.46735429544, 10198.286119971532, 10305.227107966932, 10309.175265978854, 10351.948240258751, 7624.5425274482595, 7899.210078992055, 7912.4065695073095, 7931.643076061591, 7935.722249721348, 5626.88746225065, 5913.46778789911, 5964.463198312173, 6017.548683848817, 6216.53375996793, 9335.393199442015, 9351.644011618413, 9400.059994000545, 9445.905540944503, 9476.336656433983, 9491.477968711511, 9563.952180239054, 9632.90367096348, 9776.071273229032, 9793.167580755431, 6847.21257055445, 7067.858642827217, 7079.327463890922, 7649.6557654904545, 7816.06207255133, 7647.579383133759, 8033.317168040782, 8235.547044912588, 8324.042735085543, 8455.450395724258, 7383.446241532014, 7469.365103966006, 7590.962045189739, 7777.650005749868, 7813.492123011986, 7516.5114267572435, 7595.5822429766895, 7639.121501027453, 7760.379169666526, 7807.726729564665, 6221.875562488815, 6270.874582508233, 6285.874282514415, 6292.402221788922, 6303.275123360872, 4723.480417154179, 4891.584215341736, 4964.652474326763, 5069.163588008085, 5128.153854613947, 5146.665466744649, 5177.974110129425, 5206.167013277857, 5299.682019078868, 5429.375621803543], "value": 4638.401283282471, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.8643851461849, 409.4922296352524, 409.5378967097243, 413.21489170575904, 420.9221294060599, 5261.842894263445, 5309.867253318665, 5350.571954243661, 5370.248165256862, 5370.355557333126, 5031.27046578246, 5180.585553155748, 5192.948070519303, 5199.324087868581, 5301.734913254341, 4074.9388759168637, 4170.895727606811, 4208.936865947013, 4234.099641745399, 4239.152169566084, 4247.193033323674, 4250.277452833026, 4250.553691862357, 4252.659787217015, 4272.739541835151, 4144.316187829019, 4257.893552661178, 4264.978675106636, 4271.654428854917, 4289.914201715964, 4264.125854199912, 4266.549373213107, 4278.807453664593, 4284.421603083606, 4292.377605247253, 3919.2161567686576, 3926.175503144343, 3928.705347098979, 3928.8409919073943, 3929.6070392960473, 5073.188289873602, 5201.427842937273, 5271.973640131775, 5274.868128296824, 5278.261043453919, 4955.578775804061, 4961.437147298626, 4964.453910069889, 4966.453690094087, 4967.0, 5576.605848537865, 5583.6928968906695, 5592.4407559244155, 5595.0, 5631.014572449805, 4136.276151673475, 4333.9133217335475, 4344.89137771555, 4346.391505189276, 4354.0, 5786.623869448515, 5794.217780599607, 5806.403239109237, 5813.331466881278, 5827.621204621729, 4456.866294011184, 4461.375407442961, 4468.754218517947, 4477.0, 4483.3947417098925, 4238.385434112037, 4426.454788496628, 4540.2293105688805, 4540.545945405433, 4545.431821022372, 4905.435874874363, 4927.77824997876, 4937.28409380645, 4961.7271050092595, 4964.304997300381, 5613.578981576398, 5666.291713535808, 5683.54531637468, 5687.630304030225, 5721.342045664802, 1462.1738717624507, 1466.4354223623768, 1475.7417451945867, 1500.6698526324192, 1519.6276912156593, 1081.4646749858714, 1109.5561775289948, 1111.5164903267105, 1115.9776804463866, 1118.2619471149003, 5271.868203294948, 5336.439673834269, 5360.91958620621, 5392.514673679388, 5396.622236443412, 5412.56699464042, 5476.67139971595, 5511.5039646432015, 5530.225768392428, 5595.726499997547, 5112.3865136183895, 5210.140326846104, 5288.471152884681, 5362.0, 5369.677819330853, 2904.0, 2933.618629578184, 2945.9705402946124, 2957.5508001079315, 3002.4295383876993, 5768.3654797972185, 5782.248307720053, 5804.385513516764, 5857.4435428634215, 5861.9706901465215, 5570.025245582007, 5860.238169037998, 5862.179294898718, 5865.765369385262, 5880.323762767251, 5925.333999250843, 5941.405859414111, 5943.405659434022, 5948.910766338508, 5995.250593675791, 5520.337559492887, 5678.261825962599, 5694.800681976111, 5723.771049158154, 5748.48263656273, 5683.829485115453, 5684.7157642118555, 5687.516561092353, 5697.259356283656, 5698.572607054404, 5880.764769409176, 5967.31375891778, 5968.612040217372, 5998.550108741774, 6001.489873360813, 4009.7995100245453, 4132.1529086537785, 4177.749335039907, 4181.372794080912, 4183.66530677539, 5480.314960629921, 5507.394186639546, 5584.664920104807, 5683.119116536944, 5698.0, 5539.864327812869, 5563.666180029211, 5571.359293681278, 5590.245316882331, 5608.775648973995, 5342.7061511615675, 5588.0, 5626.831195064155, 5636.943630563642, 5637.43625637433, 5490.149026900836, 5601.579881508822, 5605.0, 5618.6628802272, 5625.831225063254, 5586.441355864381, 5590.385057643574, 5633.8309850704545, 5660.433956604306, 5663.773449061991, 5217.791288348423, 5445.564354851682, 5468.277492589821, 5471.562275018068, 5492.340919089735], "value": 4358.763164055082, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.3362922038675, 708.4297140801656, 716.9068021157252, 741.1735914455384, 755.3239850333952, 15749.0, 16157.0, 16192.028478291297, 16203.513894583151, 16219.351225950963, 16059.759103613454, 16283.918580407082, 16300.918495407535, 16303.673926521462, 16308.918455407706, 806.9596520173997, 827.7847759582522, 834.7662654456761, 841.146236569882, 841.4194205997873, 849.5412477262271, 849.9702510412137, 850.5789634131114, 851.9701810436636, 852.2925971443718, 890.2210565754964, 891.2513488669516, 896.730980705789, 896.7668406214366, 896.892372915251, 886.0784783824814, 892.7411050795262, 895.476146454325, 895.9238464730506, 896.2919293757924, 645.8966565349522, 645.9289478157399, 645.9386358295955, 646.114822692909, 646.2180761278859, 17325.220365083474, 17617.55956101095, 17625.911870440694, 17713.0, 18007.0, 15424.460143895021, 15505.767413488808, 15531.844681553153, 15778.842211577852, 15794.919990601837, 11975.76677771059, 12259.69350766229, 12268.693282667915, 12377.62867113988, 12438.0, 3922.88231353057, 3980.383040628707, 3992.960070399317, 4002.8598999035185, 4035.656969157625, 78886.60556697237, 79335.6033219836, 79986.6000669993, 80904.19095809084, 82171.17828821695, 11803.586874459354, 11944.343061131722, 11966.760664786656, 12058.577949771716, 12100.81848772269, 24304.75695243025, 24323.0, 24392.146274880648, 24527.386815329402, 24922.37694057627, 8128.715494957648, 8302.667893284322, 8312.584370781437, 8388.664453421918, 8506.149385061568, 4497.64018878489, 4627.490975992638, 4684.625229981593, 4825.083234185494, 5019.598432125421, 3623.7644553103964, 3725.068732816796, 3726.049857286375, 3726.4224045273027, 3729.869454569077, 614.2874265851591, 619.4889216396491, 619.9380061993854, 620.3021600699213, 640.7501074580917, 709.5175280808996, 711.5766119159092, 717.989230161548, 729.5476804381211, 738.5384134915678, 9559.235261179088, 9588.712338629713, 9649.639849346124, 9727.951360243154, 9738.90261097394, 654.7086546486768, 672.5628341577916, 684.2985939412142, 694.7498900395854, 710.982225444368, 4570.177368073712, 4820.783064762094, 4822.758862056953, 4835.323054772335, 4839.540243676845, 84567.5771621138, 85002.14997850066, 85370.57314713387, 88071.0, 90520.0, 47468.05063898703, 55856.16215756767, 56502.0, 61738.382616173265, 74568.0, 61579.38420615737, 62051.37948620456, 62347.0, 62350.37649623446, 63790.72418551603, 10122.0, 10308.175345972455, 10431.739206519898, 10515.894841051797, 10613.469326533797, 42384.36423453589, 42598.0, 43741.0, 43820.0, 44201.77899110484, 51947.48052519427, 52224.0, 52530.21204681856, 53351.0, 54541.72729136329, 13235.205887646773, 13247.867521324664, 13253.80119298192, 13271.66820829487, 13384.063115581816, 14544.41822327095, 14557.490487832874, 14602.926985365006, 14666.193359365338, 14746.63133421673, 13847.79228311556, 13954.860451395356, 13983.021188516706, 14313.28433578296, 14498.0, 13478.123921945042, 13496.932515337361, 13587.116837405538, 13602.52391166344, 13814.37835297394, 13900.0, 14019.789703154665, 14081.718365632834, 14115.0, 14804.62988425298, 10562.407449737218, 10937.507812148313, 10973.615923442641, 11061.0, 11100.61147859821, 10891.376036774449, 11050.944745276222, 11115.166362522681, 11202.103831693283, 11205.159613029218], "value": 7427.979831517452, "unit": "score"}], "name": "dromaeo_css", "value": 7564.823657776, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 111.0, 110.0, 111.0, 112.0, 112.0, 111.0, 112.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 117.0, 119.0, 160.0, 123.0, 119.0, 120.0, 122.0, 142.0, 118.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 159.0, 161.0, 160.0, 161.0, 162.0, 158.0, 160.0, 159.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 121.0, 75.0, 76.0, 76.0, 75.0, 92.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 107.0, 83.0, 83.0, 82.0, 105.0, 82.0, 81.0, 108.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 148.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 48.0, 49.0, 49.0, 48.0, 49.0, 49.0, 49.0], "value": 48.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 68.0, 64.0, 64.0, 63.0, 66.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 75.0, 76.0, 75.0, 76.0, 76.0, 85.0, 75.0, 82.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 123.0, 121.0, 122.0, 121.0, 124.0, 119.0, 166.0, 126.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 157.0, 165.0, 155.0, 155.0, 154.0, 157.0, 156.0, 158.0, 156.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 60.0, 63.0, 61.0, 62.0, 61.0, 60.0, 60.0, 59.0], "value": 61.0, "unit": "score"}], "name": "kraken", "value": 1466.1999999999998, "alertThreshold": 2.0}]} 08:52:42 INFO - Return code: 0 08:52:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:52:42 ERROR - # TBPL SUCCESS # 08:52:42 INFO - Running post-action listener: _resource_record_post_action 08:52:42 INFO - [mozharness: 2017-02-06 16:52:42.361893Z] Finished run-tests step (success) 08:52:42 INFO - Running post-run listener: _resource_record_post_run 08:52:42 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 365297664; Read time: 16; Write time: 289008 08:52:42 INFO - TinderboxPrint: CPU usage
13.0% 08:52:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:52:42 INFO - TinderboxPrint: I/O write bytes / time
365,297,664 / 289,008 08:52:42 INFO - TinderboxPrint: CPU idle
8,270.8 (87.0%) 08:52:42 INFO - TinderboxPrint: CPU user
1,189.6 (12.5%) 08:52:42 INFO - TinderboxPrint: Swap in / out
0 / 0 08:52:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109281280; Read time: 0; Write time: 119336 08:52:42 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 255627264; Read time: 16; Write time: 169644 08:52:42 INFO - Running post-run listener: _upload_blobber_files 08:52:42 INFO - Blob upload gear active. 08:52:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:52:42 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 08:52:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:52:43 INFO - (blobuploader) - INFO - Open directory for files ... 08:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:52:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:44 INFO - (blobuploader) - INFO - Done attempting. 08:52:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:52:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:48 INFO - (blobuploader) - INFO - Done attempting. 08:52:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:52:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:52:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:49 INFO - (blobuploader) - INFO - Done attempting. 08:52:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:52:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:52:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:49 INFO - (blobuploader) - INFO - Done attempting. 08:52:49 INFO - (blobuploader) - INFO - Iteration through files over. 08:52:49 INFO - Return code: 0 08:52:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:52:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:52:49 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fe5115114210f4293fec24c289466be16dc1a93f6779fca5adfb9bd4ae1cd0c4eace68313c334c3c83c699135a901d286906ea76401a6639e4fcea54fc7d67e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ad6fee8eef20e45a31b74620e30678981b5c360cb724bbd215cec5a0f9e6eb31084a660f4952260549b963dec975db7ee0335b4012dcbc8cb845798f173966f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3dfc26b6bb5cb991f45e14ce5670c43fc970813afc1f238378929c4eebedf4af22510c2967b87b8866c2579062ee90f07daafb0523614b750c4cd9780d388d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9e433f4c9b00072fa823ca705423b3389965e6e23dd1acb56ac23da99f66437134c9f7ea8c6ede9f3f4c860996fcaa62d8f7a97d281115162c573e0761e33a6"} 08:52:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:52:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:52:49 INFO - Contents: 08:52:49 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fe5115114210f4293fec24c289466be16dc1a93f6779fca5adfb9bd4ae1cd0c4eace68313c334c3c83c699135a901d286906ea76401a6639e4fcea54fc7d67e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ad6fee8eef20e45a31b74620e30678981b5c360cb724bbd215cec5a0f9e6eb31084a660f4952260549b963dec975db7ee0335b4012dcbc8cb845798f173966f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3dfc26b6bb5cb991f45e14ce5670c43fc970813afc1f238378929c4eebedf4af22510c2967b87b8866c2579062ee90f07daafb0523614b750c4cd9780d388d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9e433f4c9b00072fa823ca705423b3389965e6e23dd1acb56ac23da99f66437134c9f7ea8c6ede9f3f4c860996fcaa62d8f7a97d281115162c573e0761e33a6"} 08:52:49 INFO - Running post-run listener: copy_logs_to_upload_dir 08:52:49 INFO - Copying logs to upload dir... 08:52:49 INFO - mkdir: /builds/slave/test/build/upload/logs 08:52:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.168252 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-06 08:52:49.957802) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 08:52:49.960967) ========= 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=1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fe5115114210f4293fec24c289466be16dc1a93f6779fca5adfb9bd4ae1cd0c4eace68313c334c3c83c699135a901d286906ea76401a6639e4fcea54fc7d67e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ad6fee8eef20e45a31b74620e30678981b5c360cb724bbd215cec5a0f9e6eb31084a660f4952260549b963dec975db7ee0335b4012dcbc8cb845798f173966f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3dfc26b6bb5cb991f45e14ce5670c43fc970813afc1f238378929c4eebedf4af22510c2967b87b8866c2579062ee90f07daafb0523614b750c4cd9780d388d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9e433f4c9b00072fa823ca705423b3389965e6e23dd1acb56ac23da99f66437134c9f7ea8c6ede9f3f4c860996fcaa62d8f7a97d281115162c573e0761e33a6"} build_url:https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011131 build_url: 'https://queue.taskcluster.net/v1/task/SmjeCZ6rQPyECWrHrnO2bA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fe5115114210f4293fec24c289466be16dc1a93f6779fca5adfb9bd4ae1cd0c4eace68313c334c3c83c699135a901d286906ea76401a6639e4fcea54fc7d67e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ad6fee8eef20e45a31b74620e30678981b5c360cb724bbd215cec5a0f9e6eb31084a660f4952260549b963dec975db7ee0335b4012dcbc8cb845798f173966f", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3dfc26b6bb5cb991f45e14ce5670c43fc970813afc1f238378929c4eebedf4af22510c2967b87b8866c2579062ee90f07daafb0523614b750c4cd9780d388d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9e433f4c9b00072fa823ca705423b3389965e6e23dd1acb56ac23da99f66437134c9f7ea8c6ede9f3f4c860996fcaa62d8f7a97d281115162c573e0761e33a6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 08:52:49.985005) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:52:49.985283) ========= 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=1f5564757af27664ca02d71f000001b0-1486398731.913746-180384196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004732 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:52:50.068200) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 08:52:50.068493) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 08:52:50.068775) ========= ========= Total master_lag: 0.17 =========