builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1486489505.66 results: success (0) revision: 514a5268030faf927430313a96a9e470e5c14c11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 09:45:05.656672) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 09:45:05.657242) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 09:45:05.657536) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 09:45:05.671899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 09:45:05.672263) ========= 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=ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-07 09:45:05-- 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% 222M=0s 2017-02-07 09:45:05 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111087 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 09:45:05.796951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 09:45:05.797565) ========= 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=ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015892 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 09:45:05.847615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 09:45:05.847990) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 514a5268030faf927430313a96a9e470e5c14c11 --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 514a5268030faf927430313a96a9e470e5c14c11 --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=ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-07 09:45:05,950 truncating revision to first 12 chars 2017-02-07 09:45:05,951 Setting DEBUG logging. 2017-02-07 09:45:05,951 attempt 1/10 2017-02-07 09:45:05,951 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/514a5268030f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-07 09:45:07,299 unpacking tar archive at: mozilla-aurora-514a5268030f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.620923 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 09:45:07.482345) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 09:45:07.482717) ========= script_repo_revision: 514a5268030faf927430313a96a9e470e5c14c11 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 09:45:07.483120) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 09:45:07.483398) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 09:45:07.491256) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-07 09:45:07.491634) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:45:07 INFO - MultiFileLogger online at 20170207 09:45:07 in /builds/slave/test 09:45:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:45:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:45:07 INFO - {'append_to_log': False, 09:45:07 INFO - 'base_work_dir': '/builds/slave/test', 09:45:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:45:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:45:07 INFO - 'branch': 'Mozilla-Aurora', 09:45:07 INFO - 'buildbot_json_path': 'buildprops.json', 09:45:07 INFO - 'config_files': ('talos/linux_config.py',), 09:45:07 INFO - 'default_actions': ('clobber', 09:45:07 INFO - 'read-buildbot-config', 09:45:07 INFO - 'download-and-extract', 09:45:07 INFO - 'populate-webroot', 09:45:07 INFO - 'create-virtualenv', 09:45:07 INFO - 'install', 09:45:07 INFO - 'run-tests'), 09:45:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:45:07 INFO - 'download_minidump_stackwalk': True, 09:45:07 INFO - 'download_symbols': 'ondemand', 09:45:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:45:07 INFO - 'tooltool.py': '/tools/tooltool.py', 09:45:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:45:07 INFO - '/tools/misc-python/virtualenv.py')}, 09:45:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:45:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:45:07 INFO - 'installer_path': 'installer.exe', 09:45:07 INFO - 'log_level': 'info', 09:45:07 INFO - 'log_name': 'talos', 09:45:07 INFO - 'log_to_console': True, 09:45:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:45:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:45:07 INFO - 'opt_config_files': (), 09:45:07 INFO - 'pip_index': False, 09:45:07 INFO - 'sps_profile': False, 09:45:07 INFO - 'sps_profile_interval': 0, 09:45:07 INFO - 'suite': 'dromaeojs-e10s', 09:45:07 INFO - 'system_bits': '32', 09:45:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:45:07 INFO - 'title': 'talos-linux64-ix-029', 09:45:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:45:07 INFO - 'use_talos_json': True, 09:45:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:45:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:45:07 INFO - 'work_dir': 'build'} 09:45:07 INFO - [mozharness: 2017-02-07 17:45:07.686177Z] Running clobber step. 09:45:07 INFO - Running pre-action listener: _resource_record_pre_action 09:45:07 INFO - Running main action method: clobber 09:45:07 INFO - rmtree: /builds/slave/test/build 09:45:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:45:08 INFO - Running post-action listener: _resource_record_post_action 09:45:08 INFO - [mozharness: 2017-02-07 17:45:08.708682Z] Finished clobber step (success) 09:45:08 INFO - [mozharness: 2017-02-07 17:45:08.708780Z] Running read-buildbot-config step. 09:45:08 INFO - Running pre-action listener: _resource_record_pre_action 09:45:08 INFO - Running main action method: read_buildbot_config 09:45:08 INFO - Using buildbot properties: 09:45:08 INFO - { 09:45:08 INFO - "project": "", 09:45:08 INFO - "product": "firefox", 09:45:08 INFO - "who": "ryanvm@gmail.com", 09:45:08 INFO - "installer_path": "public/build/target.tar.bz2", 09:45:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:45:08 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 09:45:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:45:08 INFO - "stage_platform": "linux64-pgo", 09:45:08 INFO - "basedir": "/builds/slave/test", 09:45:08 INFO - "buildnumber": 851, 09:45:08 INFO - "platform": "ubuntu64_hw", 09:45:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:45:08 INFO - "slavebuilddir": "test", 09:45:08 INFO - "taskId": "CctSfM6uS2GaFTJBy4rzrQ", 09:45:08 INFO - "branch": "mozilla-aurora", 09:45:08 INFO - "script_repo_revision": "production", 09:45:08 INFO - "revision": "514a5268030faf927430313a96a9e470e5c14c11", 09:45:08 INFO - "slavename": "talos-linux64-ix-029", 09:45:08 INFO - "repo_path": "releases/mozilla-aurora" 09:45:08 INFO - } 09:45:08 INFO - Finding installer, test and symbols from parent task. 09:45:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CctSfM6uS2GaFTJBy4rzrQ'}, attempt #1 09:45:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CctSfM6uS2GaFTJBy4rzrQ'}, attempt #1 09:45:09 INFO - Task dependencies: FCooJ0XkTKK_dRPbhIcWiA 09:45:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA'}, attempt #1 09:45:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.tar.bz2 09:45:10 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/test_packages.json 09:45:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.crashreporter-symbols.zip 09:45:10 INFO - Running post-action listener: _resource_record_post_action 09:45:10 INFO - [mozharness: 2017-02-07 17:45:10.167303Z] Finished read-buildbot-config step (success) 09:45:10 INFO - [mozharness: 2017-02-07 17:45:10.167521Z] Running download-and-extract step. 09:45:10 INFO - Running pre-action listener: _resource_record_pre_action 09:45:10 INFO - Running main action method: download_and_extract 09:45:10 INFO - mkdir: /builds/slave/test/build/tests 09:45:10 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')]} 09:45:10 INFO - trying https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.test_packages.json 09:45:10 INFO - Downloading https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:45:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:45:10 INFO - Downloaded 896 bytes. 09:45:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:45:10 INFO - Using the following test package requirements: 09:45:10 INFO - {u'common': [u'target.common.tests.zip'], 09:45:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:45:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:45:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:45:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:45:10 INFO - u'mozbase': [u'target.common.tests.zip'], 09:45:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:45:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:45:10 INFO - u'web-platform': [u'target.common.tests.zip', 09:45:10 INFO - u'target.web-platform.tests.zip'], 09:45:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:45:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:45:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.common.tests.zip 09:45:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:45:10 INFO - Fetch https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.common.tests.zip into memory 09:45:11 INFO - Expected file size: 21858384 09:45:11 INFO - Obtained file size: 21858384 09:45:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:45:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.common.tests.zip 09:45:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:45:15 INFO - Fetch https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.common.tests.zip into memory 09:45:16 INFO - Expected file size: 21858384 09:45:16 INFO - Obtained file size: 21858384 09:45:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.talos.tests.zip 09:45:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:45:21 INFO - Fetch https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.talos.tests.zip into memory 09:45:21 INFO - Expected file size: 14403485 09:45:21 INFO - Obtained file size: 14403485 09:45:22 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')]} 09:45:22 INFO - trying https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.tar.bz2 09:45:22 INFO - Downloading https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:45:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:45:23 INFO - Downloaded 66058176 bytes. 09:45:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.tar.bz2 09:45:23 INFO - mkdir: /builds/slave/test/properties 09:45:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:45:23 INFO - Writing to file /builds/slave/test/properties/build_url 09:45:23 INFO - Contents: 09:45:23 INFO - build_url:https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.tar.bz2 09:45:23 INFO - Running post-action listener: _resource_record_post_action 09:45:23 INFO - Running post-action listener: set_extra_try_arguments 09:45:23 INFO - [mozharness: 2017-02-07 17:45:23.205754Z] Finished download-and-extract step (success) 09:45:23 INFO - [mozharness: 2017-02-07 17:45:23.205854Z] Running populate-webroot step. 09:45:23 INFO - Running pre-action listener: _resource_record_pre_action 09:45:23 INFO - Running main action method: populate_webroot 09:45:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:23 INFO - '--tppagecycles', 09:45:23 INFO - '7'], 09:45:23 INFO - 'tests': ['tsvgm']}}, 09:45:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:45:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:45:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:45:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:45:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:45:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:45:23 INFO - 'talos_options': ['--disable-e10s'], 09:45:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:45:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:45:23 INFO - 'talos_options': ['--disable-e10s'], 09:45:23 INFO - 'tests': ['damp', 'tps']}, 09:45:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:45:23 INFO - 'tests': ['damp', 'tps']}, 09:45:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:45:23 INFO - 'tests': ['dromaeo_dom']}, 09:45:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:45:23 INFO - 'tests': ['basic_compositor_video']}, 09:45:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:45:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:45:23 INFO - 'tests': ['a11yr', 09:45:23 INFO - 'ts_paint', 09:45:23 INFO - 'tpaint', 09:45:23 INFO - 'sessionrestore', 09:45:23 INFO - 'sessionrestore_no_auto_restore', 09:45:23 INFO - 'tabpaint']}, 09:45:23 INFO - 'other-e10s': {'tests': ['a11yr', 09:45:23 INFO - 'ts_paint', 09:45:23 INFO - 'tpaint', 09:45:23 INFO - 'sessionrestore', 09:45:23 INFO - 'sessionrestore_no_auto_restore', 09:45:23 INFO - 'tabpaint']}, 09:45:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:45:23 INFO - 'ts_paint', 09:45:23 INFO - 'tpaint', 09:45:23 INFO - 'sessionrestore', 09:45:23 INFO - 'sessionrestore_no_auto_restore', 09:45:23 INFO - 'tabpaint']}, 09:45:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:45:23 INFO - 'ts_paint', 09:45:23 INFO - 'tpaint', 09:45:23 INFO - 'sessionrestore', 09:45:23 INFO - 'sessionrestore_no_auto_restore', 09:45:23 INFO - 'tabpaint']}, 09:45:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:45:23 INFO - 'tests': ['a11yr', 09:45:23 INFO - 'ts_paint', 09:45:23 INFO - 'tpaint', 09:45:23 INFO - 'sessionrestore', 09:45:23 INFO - 'sessionrestore_no_auto_restore', 09:45:23 INFO - 'tabpaint']}, 09:45:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:45:23 INFO - 'tests': ['a11yr', 09:45:23 INFO - 'ts_paint', 09:45:23 INFO - 'tpaint', 09:45:23 INFO - 'sessionrestore', 09:45:23 INFO - 'sessionrestore_no_auto_restore', 09:45:23 INFO - 'tabpaint']}, 09:45:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:45:23 INFO - 'tests': ['tsvgx', 09:45:23 INFO - 'tsvgr_opacity', 09:45:23 INFO - 'tart', 09:45:23 INFO - 'tscrollx', 09:45:23 INFO - 'cart', 09:45:23 INFO - 'tsvg_static']}, 09:45:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:45:23 INFO - 'tsvgr_opacity', 09:45:23 INFO - 'tart', 09:45:23 INFO - 'tscrollx', 09:45:23 INFO - 'cart', 09:45:23 INFO - 'tsvg_static']}, 09:45:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:45:23 INFO - 'talos_options': ['--disable-e10s'], 09:45:23 INFO - 'tests': ['tp5o']}, 09:45:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:45:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:45:23 INFO - 'talos_options': ['--disable-e10s', 09:45:23 INFO - '--xperf_path', 09:45:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:23 INFO - 'tests': ['tp5n']}, 09:45:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:45:23 INFO - 'talos_options': ['--xperf_path', 09:45:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:23 INFO - 'tests': ['tp5n']}}, 09:45:23 INFO - 'talos.zip': {'path': '', 09:45:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:23 INFO - Running post-action listener: _resource_record_post_action 09:45:23 INFO - [mozharness: 2017-02-07 17:45:23.218984Z] Finished populate-webroot step (success) 09:45:23 INFO - [mozharness: 2017-02-07 17:45:23.219074Z] Running create-virtualenv step. 09:45:23 INFO - Running pre-action listener: _resource_record_pre_action 09:45:23 INFO - Running main action method: create_virtualenv 09:45:23 INFO - Creating virtualenv /builds/slave/test/build/venv 09:45:23 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 09:45:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:45:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:23 INFO - Using real prefix '/usr' 09:45:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:45:23 INFO - Installing distribute.............................................................................................................................................................................................done. 09:45:25 INFO - Installing pip.................done. 09:45:25 INFO - Return code: 0 09:45:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:45:25 INFO - Reading from file tmpfile_stdout 09:45:25 INFO - Output received: 09:45:25 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) 09:45:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef820>, '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 0x19f0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f09b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', '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 09:45:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:45:25 INFO - Using env: {'DISPLAY': ':0', 09:45:25 INFO - 'HOME': '/home/cltbld', 09:45:25 INFO - 'LANG': 'en_US.UTF-8', 09:45:25 INFO - 'LANGUAGE': 'en_US:en', 09:45:25 INFO - 'LOGNAME': 'cltbld', 09:45:25 INFO - 'MAIL': '/var/mail/cltbld', 09:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:25 INFO - 'MOZ_NO_REMOTE': '1', 09:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:25 INFO - 'NO_EM_RESTART': '1', 09:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:25 INFO - 'PWD': '/builds/slave/test', 09:45:25 INFO - 'SHELL': '/bin/bash', 09:45:25 INFO - 'SHLVL': '1', 09:45:25 INFO - 'TERM': 'linux', 09:45:25 INFO - 'TMOUT': '86400', 09:45:25 INFO - 'USER': 'cltbld', 09:45:25 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', 09:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:25 INFO - '_': '/tools/buildbot/bin/python'} 09:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:26 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 09:45:26 INFO - Cleaning up... 09:45:26 INFO - Return code: 0 09:45:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef820>, '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 0x19f0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f09b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', '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 09:45:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:45:26 INFO - Using env: {'DISPLAY': ':0', 09:45:26 INFO - 'HOME': '/home/cltbld', 09:45:26 INFO - 'LANG': 'en_US.UTF-8', 09:45:26 INFO - 'LANGUAGE': 'en_US:en', 09:45:26 INFO - 'LOGNAME': 'cltbld', 09:45:26 INFO - 'MAIL': '/var/mail/cltbld', 09:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:26 INFO - 'MOZ_NO_REMOTE': '1', 09:45:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:26 INFO - 'NO_EM_RESTART': '1', 09:45:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:26 INFO - 'PWD': '/builds/slave/test', 09:45:26 INFO - 'SHELL': '/bin/bash', 09:45:26 INFO - 'SHLVL': '1', 09:45:26 INFO - 'TERM': 'linux', 09:45:26 INFO - 'TMOUT': '86400', 09:45:26 INFO - 'USER': 'cltbld', 09:45:26 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', 09:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:26 INFO - '_': '/tools/buildbot/bin/python'} 09:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:26 INFO - Downloading/unpacking psutil>=3.1.1 09:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:45:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:28 INFO - Installing collected packages: psutil 09:45:28 INFO - Running setup.py install for psutil 09:45:28 INFO - building 'psutil._psutil_linux' extension 09:45:28 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 09:45:28 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 09:45:28 INFO - building 'psutil._psutil_posix' extension 09:45:28 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 09:45:28 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 09:45:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:28 INFO - Successfully installed psutil 09:45:28 INFO - Cleaning up... 09:45:29 INFO - Return code: 0 09:45:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:45:29 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')]} 09:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:29 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')]} 09:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:29 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 0x16801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef820>, '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 0x19f0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f09b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', '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 09:45:29 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 09:45:29 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 09:45:29 INFO - Using env: {'DISPLAY': ':0', 09:45:29 INFO - 'HOME': '/home/cltbld', 09:45:29 INFO - 'LANG': 'en_US.UTF-8', 09:45:29 INFO - 'LANGUAGE': 'en_US:en', 09:45:29 INFO - 'LOGNAME': 'cltbld', 09:45:29 INFO - 'MAIL': '/var/mail/cltbld', 09:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:29 INFO - 'MOZ_NO_REMOTE': '1', 09:45:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:29 INFO - 'NO_EM_RESTART': '1', 09:45:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:29 INFO - 'PWD': '/builds/slave/test', 09:45:29 INFO - 'SHELL': '/bin/bash', 09:45:29 INFO - 'SHLVL': '1', 09:45:29 INFO - 'TERM': 'linux', 09:45:29 INFO - 'TMOUT': '86400', 09:45:29 INFO - 'USER': 'cltbld', 09:45:29 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', 09:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:29 INFO - '_': '/tools/buildbot/bin/python'} 09:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:45:29 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 09:45:29 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 09:45:29 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 09:45:29 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 09:45:29 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 09:45:29 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 09:45:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:45:31 INFO - Installing collected packages: mozsystemmonitor 09:45:31 INFO - Running setup.py install for mozsystemmonitor 09:45:31 INFO - Successfully installed mozsystemmonitor 09:45:31 INFO - Cleaning up... 09:45:31 INFO - Return code: 0 09:45:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:45: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')]} 09:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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', '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 0x16801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef820>, '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 0x19f0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f09b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', '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 09:45: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:45: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 jsonschema==2.5.1 09:45:31 INFO - Using env: {'DISPLAY': ':0', 09:45:31 INFO - 'HOME': '/home/cltbld', 09:45:31 INFO - 'LANG': 'en_US.UTF-8', 09:45:31 INFO - 'LANGUAGE': 'en_US:en', 09:45:31 INFO - 'LOGNAME': 'cltbld', 09:45:31 INFO - 'MAIL': '/var/mail/cltbld', 09:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:31 INFO - 'MOZ_NO_REMOTE': '1', 09:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:31 INFO - 'NO_EM_RESTART': '1', 09:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:31 INFO - 'PWD': '/builds/slave/test', 09:45:31 INFO - 'SHELL': '/bin/bash', 09:45:31 INFO - 'SHLVL': '1', 09:45:31 INFO - 'TERM': 'linux', 09:45:31 INFO - 'TMOUT': '86400', 09:45:31 INFO - 'USER': 'cltbld', 09:45:31 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', 09:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:31 INFO - '_': '/tools/buildbot/bin/python'} 09:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:31 INFO - Downloading/unpacking jsonschema==2.5.1 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:45:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:33 INFO - Downloading functools32-3.2.3-2.tar.gz 09:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:45:33 INFO - warning: no files found matching '*.txt' 09:45:33 INFO - no previously-included directories found matching 'build' 09:45:33 INFO - no previously-included directories found matching 'dist' 09:45:33 INFO - no previously-included directories found matching '.git*' 09:45:33 INFO - Installing collected packages: jsonschema, functools32 09:45:34 INFO - Running setup.py install for functools32 09:45:34 INFO - warning: no files found matching '*.txt' 09:45:34 INFO - no previously-included directories found matching 'build' 09:45:34 INFO - no previously-included directories found matching 'dist' 09:45:34 INFO - no previously-included directories found matching '.git*' 09:45:34 INFO - Successfully installed jsonschema functools32 09:45:34 INFO - Cleaning up... 09:45:34 INFO - Return code: 0 09:45:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:45: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')]} 09:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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', '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 0x16801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef820>, '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 0x19f0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f09b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', '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 09:45: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:45: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 functools32==3.2.3-2 09:45:34 INFO - Using env: {'DISPLAY': ':0', 09:45:34 INFO - 'HOME': '/home/cltbld', 09:45:34 INFO - 'LANG': 'en_US.UTF-8', 09:45:34 INFO - 'LANGUAGE': 'en_US:en', 09:45:34 INFO - 'LOGNAME': 'cltbld', 09:45:34 INFO - 'MAIL': '/var/mail/cltbld', 09:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:34 INFO - 'MOZ_NO_REMOTE': '1', 09:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:34 INFO - 'NO_EM_RESTART': '1', 09:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:34 INFO - 'PWD': '/builds/slave/test', 09:45:34 INFO - 'SHELL': '/bin/bash', 09:45:34 INFO - 'SHLVL': '1', 09:45:34 INFO - 'TERM': 'linux', 09:45:34 INFO - 'TMOUT': '86400', 09:45:34 INFO - 'USER': 'cltbld', 09:45:34 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', 09:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:34 INFO - '_': '/tools/buildbot/bin/python'} 09:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:45:34 INFO - Cleaning up... 09:45:34 INFO - Return code: 0 09:45:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:45: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')]} 09:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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', '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 0x16801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef820>, '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 0x19f0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f09b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', '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 09:45: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:45: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 blobuploader==1.2.4 09:45:34 INFO - Using env: {'DISPLAY': ':0', 09:45:34 INFO - 'HOME': '/home/cltbld', 09:45:34 INFO - 'LANG': 'en_US.UTF-8', 09:45:34 INFO - 'LANGUAGE': 'en_US:en', 09:45:34 INFO - 'LOGNAME': 'cltbld', 09:45:34 INFO - 'MAIL': '/var/mail/cltbld', 09:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:34 INFO - 'MOZ_NO_REMOTE': '1', 09:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:34 INFO - 'NO_EM_RESTART': '1', 09:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:34 INFO - 'PWD': '/builds/slave/test', 09:45:34 INFO - 'SHELL': '/bin/bash', 09:45:34 INFO - 'SHLVL': '1', 09:45:34 INFO - 'TERM': 'linux', 09:45:34 INFO - 'TMOUT': '86400', 09:45:34 INFO - 'USER': 'cltbld', 09:45:34 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', 09:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:34 INFO - '_': '/tools/buildbot/bin/python'} 09:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:34 INFO - Downloading/unpacking blobuploader==1.2.4 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:36 INFO - Downloading blobuploader-1.2.4.tar.gz 09:45:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:45:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:45:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:37 INFO - Downloading docopt-0.6.1.tar.gz 09:45:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:45:37 INFO - Installing collected packages: blobuploader, requests, docopt 09:45:37 INFO - Running setup.py install for blobuploader 09:45:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:45:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:45:37 INFO - Running setup.py install for requests 09:45:37 INFO - Running setup.py install for docopt 09:45:37 INFO - Successfully installed blobuploader requests docopt 09:45:37 INFO - Cleaning up... 09:45:38 INFO - Return code: 0 09:45:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:38 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 0x16801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef820>, '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 0x19f0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f09b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', '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 09:45:38 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 09:45:38 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 09:45:38 INFO - Using env: {'DISPLAY': ':0', 09:45:38 INFO - 'HOME': '/home/cltbld', 09:45:38 INFO - 'LANG': 'en_US.UTF-8', 09:45:38 INFO - 'LANGUAGE': 'en_US:en', 09:45:38 INFO - 'LOGNAME': 'cltbld', 09:45:38 INFO - 'MAIL': '/var/mail/cltbld', 09:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:38 INFO - 'MOZ_NO_REMOTE': '1', 09:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:38 INFO - 'NO_EM_RESTART': '1', 09:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:38 INFO - 'PWD': '/builds/slave/test', 09:45:38 INFO - 'SHELL': '/bin/bash', 09:45:38 INFO - 'SHLVL': '1', 09:45:38 INFO - 'TERM': 'linux', 09:45:38 INFO - 'TMOUT': '86400', 09:45:38 INFO - 'USER': 'cltbld', 09:45:38 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', 09:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:38 INFO - '_': '/tools/buildbot/bin/python'} 09:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:38 INFO - Running setup.py (path:/tmp/pip-FRaPRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:38 INFO - Running setup.py (path:/tmp/pip-lJLN1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:38 INFO - Running setup.py (path:/tmp/pip-JVl1zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:38 INFO - Running setup.py (path:/tmp/pip-SlW7sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:38 INFO - Running setup.py (path:/tmp/pip-K944Ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:38 INFO - Running setup.py (path:/tmp/pip-cho_6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:38 INFO - Running setup.py (path:/tmp/pip-8MqGtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:38 INFO - Running setup.py (path:/tmp/pip-JNXt4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:38 INFO - Running setup.py (path:/tmp/pip-dYNz6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:38 INFO - Running setup.py (path:/tmp/pip-S8hKBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:38 INFO - Running setup.py (path:/tmp/pip-zXFyFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:39 INFO - Running setup.py (path:/tmp/pip-ZM6Mfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:39 INFO - Running setup.py (path:/tmp/pip-IaR7yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:39 INFO - Running setup.py (path:/tmp/pip-99YB7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:39 INFO - Running setup.py (path:/tmp/pip-jAo4Qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:39 INFO - Running setup.py (path:/tmp/pip-ExWhNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:39 INFO - Running setup.py (path:/tmp/pip-T0DHGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:45:39 INFO - Running setup.py install for manifestparser 09:45:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:45:39 INFO - Running setup.py install for mozcrash 09:45:39 INFO - Running setup.py install for mozdebug 09:45:39 INFO - Running setup.py install for mozdevice 09:45:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:45:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:45:39 INFO - Running setup.py install for mozfile 09:45:39 INFO - Running setup.py install for mozhttpd 09:45:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Running setup.py install for mozinfo 09:45:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Running setup.py install for mozInstall 09:45:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Running setup.py install for mozleak 09:45:40 INFO - Running setup.py install for mozlog 09:45:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Running setup.py install for moznetwork 09:45:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Running setup.py install for mozprocess 09:45:40 INFO - Running setup.py install for mozprofile 09:45:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Running setup.py install for mozrunner 09:45:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Running setup.py install for mozscreenshot 09:45:41 INFO - Running setup.py install for moztest 09:45:41 INFO - Running setup.py install for mozversion 09:45:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:45:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:45:41 INFO - Cleaning up... 09:45:41 INFO - Return code: 0 09:45:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:41 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 0x16801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef820>, '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 0x19f0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f09b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', '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 09:45:41 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 09:45:41 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 09:45:41 INFO - Using env: {'DISPLAY': ':0', 09:45:41 INFO - 'HOME': '/home/cltbld', 09:45:41 INFO - 'LANG': 'en_US.UTF-8', 09:45:41 INFO - 'LANGUAGE': 'en_US:en', 09:45:41 INFO - 'LOGNAME': 'cltbld', 09:45:41 INFO - 'MAIL': '/var/mail/cltbld', 09:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:41 INFO - 'MOZ_NO_REMOTE': '1', 09:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:41 INFO - 'NO_EM_RESTART': '1', 09:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:41 INFO - 'PWD': '/builds/slave/test', 09:45:41 INFO - 'SHELL': '/bin/bash', 09:45:41 INFO - 'SHLVL': '1', 09:45:41 INFO - 'TERM': 'linux', 09:45:41 INFO - 'TMOUT': '86400', 09:45:41 INFO - 'USER': 'cltbld', 09:45:41 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', 09:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:41 INFO - '_': '/tools/buildbot/bin/python'} 09:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:41 INFO - Running setup.py (path:/tmp/pip-NK4XUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:41 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)) 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:41 INFO - Running setup.py (path:/tmp/pip-ZClD5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:41 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)) 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:41 INFO - Running setup.py (path:/tmp/pip-A40wa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:41 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)) 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:41 INFO - Running setup.py (path:/tmp/pip-42ZcOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:41 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)) 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:41 INFO - Running setup.py (path:/tmp/pip-WrrGYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:41 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)) 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:41 INFO - Running setup.py (path:/tmp/pip-JWj1W1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:41 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)) 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:41 INFO - Running setup.py (path:/tmp/pip-sL64lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:42 INFO - Running setup.py (path:/tmp/pip-gJRIbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:42 INFO - Running setup.py (path:/tmp/pip-e1kuFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:42 INFO - Running setup.py (path:/tmp/pip-lbzT1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:42 INFO - Running setup.py (path:/tmp/pip-foSP29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:42 INFO - Running setup.py (path:/tmp/pip-twxl0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:42 INFO - Running setup.py (path:/tmp/pip-t5Rf13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:42 INFO - Running setup.py (path:/tmp/pip-bj931Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:42 INFO - Running setup.py (path:/tmp/pip-XIPvNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:42 INFO - Running setup.py (path:/tmp/pip-JE6p2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:42 INFO - Running setup.py (path:/tmp/pip-irXf1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:42 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)) 09:45:42 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)) 09:45:42 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)) 09:45:42 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)) 09:45:42 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)) 09:45:42 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)) 09:45:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:44 INFO - Downloading blessings-1.6.tar.gz 09:45:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:45:44 INFO - Installing collected packages: blessings 09:45:44 INFO - Running setup.py install for blessings 09:45:44 INFO - Successfully installed blessings 09:45:44 INFO - Cleaning up... 09:45:45 INFO - Return code: 0 09:45:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:45:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:45 INFO - Reading from file tmpfile_stdout 09:45:45 INFO - Current package versions: 09:45:45 INFO - argparse == 1.2.1 09:45:45 INFO - blessings == 1.6 09:45:45 INFO - blobuploader == 1.2.4 09:45:45 INFO - docopt == 0.6.1 09:45:45 INFO - functools32 == 3.2.3-2 09:45:45 INFO - jsonschema == 2.5.1 09:45:45 INFO - manifestparser == 1.1 09:45:45 INFO - mozInstall == 1.12 09:45:45 INFO - mozcrash == 1.0 09:45:45 INFO - mozdebug == 0.1 09:45:45 INFO - mozdevice == 0.49 09:45:45 INFO - mozfile == 1.2 09:45:45 INFO - mozhttpd == 0.7 09:45:45 INFO - mozinfo == 0.9 09:45:45 INFO - mozleak == 0.1 09:45:45 INFO - mozlog == 3.4 09:45:45 INFO - moznetwork == 0.27 09:45:45 INFO - mozprocess == 0.24 09:45:45 INFO - mozprofile == 0.28 09:45:45 INFO - mozrunner == 6.13 09:45:45 INFO - mozscreenshot == 0.1 09:45:45 INFO - mozsystemmonitor == 0.3 09:45:45 INFO - moztest == 0.8 09:45:45 INFO - mozversion == 1.4 09:45:45 INFO - psutil == 3.1.1 09:45:45 INFO - requests == 1.2.3 09:45:45 INFO - wsgiref == 0.1.2 09:45:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:45 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')]} 09:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:45 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')]} 09:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:45 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 0x16801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef820>, '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 0x19f0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f09b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', '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 09:45:45 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 09:45:45 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 09:45:45 INFO - Using env: {'DISPLAY': ':0', 09:45:45 INFO - 'HOME': '/home/cltbld', 09:45:45 INFO - 'LANG': 'en_US.UTF-8', 09:45:45 INFO - 'LANGUAGE': 'en_US:en', 09:45:45 INFO - 'LOGNAME': 'cltbld', 09:45:45 INFO - 'MAIL': '/var/mail/cltbld', 09:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:45 INFO - 'MOZ_NO_REMOTE': '1', 09:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:45 INFO - 'NO_EM_RESTART': '1', 09:45:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:45 INFO - 'PWD': '/builds/slave/test', 09:45:45 INFO - 'SHELL': '/bin/bash', 09:45:45 INFO - 'SHLVL': '1', 09:45:45 INFO - 'TERM': 'linux', 09:45:45 INFO - 'TMOUT': '86400', 09:45:45 INFO - 'USER': 'cltbld', 09:45:45 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', 09:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:45 INFO - '_': '/tools/buildbot/bin/python'} 09:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:45 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)) 09:45:45 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)) 09:45:45 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)) 09:45:45 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)) 09:45:45 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)) 09:45:45 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)) 09:45:45 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)) 09:45:45 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)) 09:45:45 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)) 09:45:45 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)) 09:45:45 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)) 09:45:45 INFO - Cleaning up... 09:45:45 INFO - Return code: 0 09:45:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:45:45 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')]} 09:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:45 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')]} 09:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:45 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 0x16801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ef820>, '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 0x19f0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f09b0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', '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 09:45:45 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 09:45:45 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 09:45:45 INFO - Using env: {'DISPLAY': ':0', 09:45:45 INFO - 'HOME': '/home/cltbld', 09:45:45 INFO - 'LANG': 'en_US.UTF-8', 09:45:45 INFO - 'LANGUAGE': 'en_US:en', 09:45:45 INFO - 'LOGNAME': 'cltbld', 09:45:45 INFO - 'MAIL': '/var/mail/cltbld', 09:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:45 INFO - 'MOZ_NO_REMOTE': '1', 09:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:45 INFO - 'NO_EM_RESTART': '1', 09:45:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:45 INFO - 'PWD': '/builds/slave/test', 09:45:45 INFO - 'SHELL': '/bin/bash', 09:45:45 INFO - 'SHLVL': '1', 09:45:45 INFO - 'TERM': 'linux', 09:45:45 INFO - 'TMOUT': '86400', 09:45:45 INFO - 'USER': 'cltbld', 09:45:45 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', 09:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:45 INFO - '_': '/tools/buildbot/bin/python'} 09:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:45:45 INFO - Cleaning up... 09:45:45 INFO - Return code: 0 09:45:45 INFO - Running post-action listener: _resource_record_post_action 09:45:45 INFO - Running post-action listener: _start_resource_monitoring 09:45:45 INFO - Starting resource monitoring. 09:45:45 INFO - [mozharness: 2017-02-07 17:45:45.727964Z] Finished create-virtualenv step (success) 09:45:45 INFO - [mozharness: 2017-02-07 17:45:45.728446Z] Running install step. 09:45:45 INFO - Running pre-action listener: _resource_record_pre_action 09:45:45 INFO - Running main action method: install 09:45:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:45 INFO - Reading from file tmpfile_stdout 09:45:45 INFO - Detecting whether we're running mozinstall >=1.0... 09:45:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:45:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:45:46 INFO - Reading from file tmpfile_stdout 09:45:46 INFO - Output received: 09:45:46 INFO - Usage: mozinstall [options] installer 09:45:46 INFO - Options: 09:45:46 INFO - -h, --help show this help message and exit 09:45:46 INFO - -d DEST, --destination=DEST 09:45:46 INFO - Directory to install application into. [default: 09:45:46 INFO - "/builds/slave/test"] 09:45:46 INFO - --app=APP Application being installed. [default: firefox] 09:45:46 INFO - mkdir: /builds/slave/test/build/application 09:45:46 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'] 09:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:46:02 INFO - Reading from file tmpfile_stdout 09:46:02 INFO - Output received: 09:46:02 INFO - /builds/slave/test/build/application/firefox/firefox 09:46:02 INFO - Running post-action listener: _resource_record_post_action 09:46:02 INFO - [mozharness: 2017-02-07 17:46:02.412396Z] Finished install step (success) 09:46:02 INFO - [mozharness: 2017-02-07 17:46:02.412673Z] Running run-tests step. 09:46:02 INFO - Running pre-action listener: _resource_record_pre_action 09:46:02 INFO - Running main action method: run_tests 09:46:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:46:02 INFO - Python 2.7.3 09:46:02 INFO - Return code: 0 09:46:02 INFO - grabbing minidump binary from tooltool 09:46:02 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')]} 09:46:02 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 0x19ef820>, '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 0x19f0520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f09b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:46:02 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 09:46:02 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 09:46:02 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 09:46:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:46:02 INFO - Return code: 0 09:46:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:46:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:46:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:46:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:46:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:46:02 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:46:02 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:46:02 INFO - Using env: {'DISPLAY': ':0', 09:46:02 INFO - 'HOME': '/home/cltbld', 09:46:02 INFO - 'LANG': 'en_US.UTF-8', 09:46:02 INFO - 'LANGUAGE': 'en_US:en', 09:46:02 INFO - 'LOGNAME': 'cltbld', 09:46:02 INFO - 'MAIL': '/var/mail/cltbld', 09:46:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:46:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:02 INFO - 'MOZ_NO_REMOTE': '1', 09:46:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:02 INFO - 'NO_EM_RESTART': '1', 09:46:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:02 INFO - 'PWD': '/builds/slave/test', 09:46:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:46:02 INFO - 'SHELL': '/bin/bash', 09:46:02 INFO - 'SHLVL': '1', 09:46:02 INFO - 'TERM': 'linux', 09:46:02 INFO - 'TMOUT': '86400', 09:46:02 INFO - 'USER': 'cltbld', 09:46:02 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411', 09:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:02 INFO - '_': '/tools/buildbot/bin/python'} 09:46:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:46:02 INFO - mozversion application_buildid: 20170207163744 09:46:02 INFO - mozversion application_changeset: 514a5268030faf927430313a96a9e470e5c14c11 09:46:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:46:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:46:02 INFO - mozversion application_name: Firefox 09:46:02 INFO - mozversion application_remotingname: firefox-dev 09:46:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:46:02 INFO - mozversion application_vendor: Mozilla 09:46:02 INFO - mozversion application_version: 53.0a2 09:46:02 INFO - mozversion platform_buildid: 20170207163744 09:46:02 INFO - mozversion platform_changeset: 514a5268030faf927430313a96a9e470e5c14c11 09:46:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:46:02 INFO - mozversion platform_version: 53.0a2 09:46:02 INFO - using testdate: 1486489562 09:46:02 INFO - actual date: 1486489562 09:46:02 INFO - starting webserver on 'localhost:46881' 09:46:02 INFO - SUITE-START | Running 2 tests 09:46:02 INFO - TEST-START | dromaeo_css 09:46:02 INFO - operating with platform_type : linux_ 09:46:02 INFO - Initialising browser for dromaeo_css test... 09:46:02 INFO - TEST-INFO | started process 17343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNlnmmj/profile http://localhost:46881/getInfo.html) 09:46:07 INFO - PROCESS | 17343 | __metrics Screen width/height:1600/1200 09:46:07 INFO - PROCESS | 17343 | colorDepth:24 09:46:07 INFO - PROCESS | 17343 | Browser inner width/height: 1024/697 09:46:07 INFO - PROCESS | 17343 | __metrics 09:46:08 INFO - PROCESS | 17343 | 1486489568163 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 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpNlnmmj/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpNlnmmj/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpNlnmmj/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpNlnmmj/profile/extensions/talos-powers@TalosPowersService.js:55:9 09:46:08 ERROR - PROCESS | 17343 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 09:46:09 INFO - TEST-INFO | 17343: exit 0 09:46:09 INFO - Browser initialized. 09:46:09 INFO - Running cycle 1/1 for dromaeo_css test... 09:46:09 INFO - TEST-INFO | started process 17472 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNlnmmj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:20 INFO - PROCESS | 17472 | RSS: Main: 144580608 09:46:20 INFO - PROCESS | 17472 | 09:49:19 INFO - PROCESS | 17472 | Cycle 1(1): loaded http://localhost:46881/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46881/tests/dromaeo/cssquery-ext.html) 09:49:21 INFO - PROCESS | 17472 | RSS: Main: 152399872 09:49:21 INFO - PROCESS | 17472 | 09:51:09 INFO - PROCESS | 17472 | ************************* 09:51:09 INFO - PROCESS | 17472 | A coding exception was thrown and uncaught in a Task. 09:51:09 INFO - PROCESS | 17472 | 09:51:09 ERROR - PROCESS | 17472 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:51:09 INFO - PROCESS | 17472 | Full stack: 09:51:09 INFO - PROCESS | 17472 | ************************* 09:52:23 INFO - PROCESS | 17472 | Cycle 1(1): loaded http://localhost:46881/tests/dromaeo/cssquery-ext.html (next: http://localhost:46881/tests/dromaeo/cssquery-jquery.html) 09:52:23 INFO - PROCESS | 17472 | RSS: Main: 151953408 09:52:23 INFO - PROCESS | 17472 | 09:55:25 INFO - PROCESS | 17472 | Cycle 1(1): loaded http://localhost:46881/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46881/tests/dromaeo/cssquery-mootools.html) 09:55:26 INFO - PROCESS | 17472 | RSS: Main: 153448448 09:55:26 INFO - PROCESS | 17472 | 09:58:28 INFO - PROCESS | 17472 | Cycle 1(1): loaded http://localhost:46881/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46881/tests/dromaeo/cssquery-prototype.html) 09:58:28 INFO - PROCESS | 17472 | RSS: Main: 149688320 09:58:28 INFO - PROCESS | 17472 | 10:01:31 INFO - PROCESS | 17472 | Cycle 1(1): loaded http://localhost:46881/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46881/tests/dromaeo/cssquery-yui.html) 10:01:31 INFO - PROCESS | 17472 | RSS: Main: 153083904 10:01:31 INFO - PROCESS | 17472 | 10:04:33 INFO - PROCESS | 17472 | Cycle 1(1): loaded http://localhost:46881/tests/dromaeo/cssquery-yui.html (next: http://localhost:46881/tests/dromaeo/cssquery-dojo.html) 10:04:34 INFO - PROCESS | 17472 | RSS: Main: 156135424 10:04:34 INFO - PROCESS | 17472 | 10:04:34 INFO - PROCESS | 17472 | __start_tp_report 10:04:34 INFO - PROCESS | 17472 | _x_x_mozilla_page_load 10:04:34 INFO - PROCESS | 17472 | _x_x_mozilla_page_load_details 10:04:34 INFO - PROCESS | 17472 | |i|pagename|runs| 10:04:34 INFO - PROCESS | 17472 | |0;dojo.html;3192.3136525646987;3291.9177020574466;3321.153105957982;3330.4338262495376;3341.3317336532687;5406.810761623344;5423.593230507713;5441.673499590018;5474.589405794566;5492.972535137324;5519.503244707976;5558.805441809537;5561.888762224753;5571.665700057999;5586.385497595272;5035.723035233052;5073.289739436482;5090.872728181788;5096.286519887219;5148.6910785353;5089.491050894918;5142.845714628548;5148.176291793314;5157.948420515784;5192.143296356116;4931.358923339979;4933.605311575084;5134.358205224347;5141.331626888499;5152.871178220537;4971.45314015458;4999.250112483121;5058.367704036996;5109.182530795092;5125.103106956268;4986.700797952099;5078.97460512695;5087.109755792759;5089.541941225308;5120.743962801845;5228.686278823283;5426.674399536001;5478.534324582415;5535.114381698909;5549.944500554983;5643.351014633287;5654.858628534278;5715.971420142914;5779.913301300484;5882.411758824083;5845.298564172284;5851.444112809277;5852.531797456193;5884.382139875294;5887.322957859816;5458.972705136449;5465.152901300305;5473.0969390050195;5484.095124304525;5492.862678433071;5680.0627896397455;5715.9997000524745;5891.145783861316;5907.379725128885;5941.494972927263;5774.566907481955;5807.390224026501;5813.953488372049;5842.298924129132;5861.472467477947;5857.062869940874;5900.763969441175;5921.526277897758;5921.911171332434;5924.940750592526;5676.006698827771;5741.971290143606;5747.5114615257335;5783.103618939072;5869.647821130746;5847.532197424196;5853.678047707417;5862.736176872051;5877.941220587825;5899.380565040609;4499;4505.301678239878;4510.594046535827;4520.118576877478;4535.841245556456;3914.5106861642294;3947.624975627311;3993.341098718737;4007.7595344279434;4051.837926482967;5773.797917072882;5777.7977770777825;5787.594868359174;5834.620749651259;5837.970810145922;5895.086261629369;5905.970470147622;5948.405159484017;5949;5960.6721630309885;5515.062439385314;5546.972265138729;5698.886022279614;5791.7683292667825;5838.095095260242;5087.287779710843;5090.567301779391;5090.847274581694;5118.283440318359;5121.641485096007;6261.7182226799905;6268.1851359323;6271.874562508724;6281.59169653971;6288.056791481315;5684.289463817023;5725.227094342211;5862.149988251595;5974.253218347707;5983.551233657406;6213.316535181217;6268.623882567061;6277.905831412441;6281.59169653971;6288.402601752826;5770.711464426846;5777.335606405317;5820.76716931318;5824.970875145597;5837.854053648693;5804.303483581997;5839.766409343579;5858.326292476249;5891.1752354669525;5908.675022873783;5647.604667673223;5670.829875103754;5698.886022279614;5738.626989245686;5774.8845023098465;5708.771649133988;5728.627639203439;5730.197772311796;5733.9392212440835;5742.19609254713;5565.053940829987;5709.3719690834805;5730.541556675373;5733.455321744427;5754.856128596651;5610.831675049755;5687.971560142173;5757.3954734753925;5783.768649254151;5867.501262392574;5656.321241451053;5692.943070569241;5695.686737229492;5710.2576665033275;5710.3433105193435 10:04:34 INFO - PROCESS | 17472 | |1;ext.html;583.6643929740397;610.8839320529099;618.7494064903714;712.6009434716563;718.7053308143662;43932.34101488476;44711.552884471144;48753.51246487534;48798;49104.75447622766;49959;50921.49078509214;50972.23541646869;50998.49001509984;51105;9275.58259878307;11100.222984391095;11451.484683189277;11505.597304094359;11554.480048397842;11049.33703977764;11089.05743011841;11131.443427828617;11146.108311335074;11151.38667373294;11211.66365009051;11233.775324493505;11244.100471962265;11255;11267.21129520934;11001.61494347698;11068.169887258447;11079.390633515113;11101.944490277498;11122.55509779608;10975;11081.72295692606;11089.889101109047;11166.553337866557;11177.385243811586;42456.78771606153;42904;42961.35557966633;43058.56941430577;43071.35392969108;4410.867673969754;4449.7330160190495;4496.258117410656;4559.74921379324;4570.862874113782;31445.17390419758;31869;32242;32690.346193076242;32819.015429537154;4362.345648152771;4393.384926110315;4433.13553856998;4499;4555.385023021883;374919;376747;376963;378459.99999999726;379076;62490.375096248456;62847.68576157181;63089.36910630927;63302;63354;64920;65046.34953650403;65061;65141.34858651353;65373;15767.448139315298;16155.838441615668;16902.154892255337;17177;17229.65540689179;13017.934910325577;13308.600741977756;13331.733365332639;13949.372278247503;13963.930180349033;20058.896760678304;20368.69446958297;20485.795142048388;20527.692084618742;20531.38405847827;7283.963580182065;7340.797760671777;7344.155422126417;7440.925590744023;7544.283293087257;1005.4017859373661;1005.8994100590029;1016.7813920007234;1017.2065788684838;1037.6057098302597;33249.501257481155;33672.326553469284;33769.32461350759;34091.659083409344;34741.652583474344;1103.4593049405732;1173.239766548211;1183.6863231243726;1216.3735676126803;1216.6532538226563;17778.46664600064;17879.910600447176;17923.283068677367;18042.458726238234;18102.728459073125;545957;548713;552331;552412;552756;72327.6383618089;72490.63754681192;72707;72957.6352118236;73105;1561.8281988981203;1566.639672875245;1580.6759614279044;1605.2856478867025;1626.243796634547;32961.83519082485;33152;33367.16582085467;33599.16002099967;33899.66100338965;58949.41050589439;59030;59218.40781592129;59724.70137649284;60008.39991600028;325926;326318;327789;328544;328630;31809.840950795096;32944.67055329416;33048.50427243641;33124;33168.66831331656;47546.28680569863;47903;49599.752001241206;55227.44772552223;55459;41193;41378.1724365517;42196.367054493596;42812.57187428086;43242.35136472892;41573.168536628495;41610;41783.7910810444;42672.35991460068;42743.358849616656;41554.58445415507;42140.78929605455;42239.366409504495;42305.365419518115;42336.15327693367;34374;35594.46608300929;36210;36302.273954520235;36363.45454818233;27535.31161720973;27799.58300625533;27906.302342440787;28060;28250.71749282563 10:04:34 INFO - PROCESS | 17472 | |2;jquery.html;395.30623755309426;399.6483094876509;401.52619908507967;405.6754596322942;415.66396849704665;20036.59926801463;21500.56998860026;22061.779382206172;22079.779202207974;22108.115675373007;20399.592008159863;21263.14947402106;22780;23195.420114497145;23481.178158764447;5947.791827286046;6189.783357582485;6194.070889366586;6218.564700470969;6232.594881332699;5942.494887934531;5998.4001599839885;6013.939860601382;6043.728032238538;6075.665838378887;6000;6002;6004.5796794224425;6006.849828754294;6015.909761353583;5852.444017818321;5886.587938844261;5888.970555147197;5907.7046147692445;5918.319393269786;5230.895382092375;5244.449332820037;5264.552513036397;5267.657602255841;5275.446078161776;26031.479370412486;26128.73871261282;26345.20964371072;26377.3405664858;26390.944362225488;2708.8645567721537;2821.8306901585765;2851.201663534214;2857.6570811502543;3342.548755917944;11005.944970275097;11070.667879963614;11395.658130256106;11641.6507504775;16677.66644667112;2014.244658253155;2055.7019232211396;2092.435042538506;2096.423483542023;2100.432883121564;95403;99720.50139749255;101596.49201754018;101655.49172254092;102292;12040.518379264906;12309.815352769716;12385.504579816707;12481.375931203585;12523.373831308398;16899.57751056209;16952.321907123824;17079.231434585472;17084.97490150595;17093.059881706376;9266.305027122859;9362.25101991839;9403.106704863027;9420.19928306088;9590.136887680002;9281.118293762082;9329.440233586007;9350.111739384884;9468.431894086378;9512.571934262975;4922.778474968635;5073.188289873602;5104.285400043997;5154.974225128851;5249.081410753103;2093.5394213273057;2097.9790202097784;2117.650587653051;2137.2901678657013;2137.5511142659902;952.6379975609362;955.1022039283051;963.5134257200069;972.7276362618478;986.1716158426956;19874.50313742168;20578.38264852057;21661.67507487389;21732.456688582595;22120.557588848133;972.1396564040875;982.5578489679673;984.7931934293736;985.0987593943614;992.6376872441507;11649.76700465986;11792.764144717057;11920;12003.099767517471;12019.399030048462;308243;606741;662241;687167;722611;82858;110002;110529.1654455404;110721;112874.43562782134;1042.671558459083;1044.9477526123662;1066.5094056733835;1072.06730144773;1073.4525392050111;17613.03128327903;18404.35584754527;18535.53661158482;18881.527961801065;19388.4183474496;37471;43898.561014390725;44344.33483497686;48909.51090489049;50761.74619126881;60213.39786602078;61657;62503;64726;71926.28073719406;8567.485950842969;8936.46381217129;9030.45817250967;9058.773530661787;9176.403533770284;9841.655542055994;13560.525381611596;13599.184048957095;14265.215413152377;14364.640883977983;11331.490082946122;11356.659300221007;11404.885951140383;11567.363794991019;11823.349715765371;6195.969020155051;8827.337949653931;10500.684979450323;11351.602693905674;11390.772184556428;12417.19288246261;12423;12560.937195313965;12676.429560669976;12854.100212985375;7743.264389882952;7979.162187970412;8128;8465.068842427205;9206.401583897024;11344.319340839576;11713.531458741554;11763.882431169026;12106;12142.332171730639 10:04:34 INFO - PROCESS | 17472 | |3;mootools.html;1517.1049081042186;1518.7721841723737;1520.4146403634597;1530.3725472556248;1534.8081489813774;8116.431849770518;8288.336933045357;8453.070162282143;8793.076726943675;8805.691800786974;8643.049264580892;8758.124187581254;8767.868481972775;8776.297896168291;8777.34169937254;2336.2056900653815;2390.940226494343;2393.413613664655;2394.2936833634035;2405.6632071510003;2358.127492827656;2380;2390.3785015895905;2390.8326417150806;2391.8804059797026;2234.731832180141;2244.820414366855;2245.461089338555;2245.5396643688005;2257.7855103765196;2240.2047273217936;2261.072960086365;2273.874936878471;2276.146445083094;2277.3737222263926;2193.923212687564;2209.4697272654607;2228.2869481765842;2230.074519074582;2232.8883555822144;8658.567071646456;8737.519436430994;8769.912300876973;8777.517236551987;8788.472691638459;5154.123798954187;5249.86875328116;5250.05499010178;5289.841304760864;5292.100342941709;3126.624805023389;3130.2330928922333;3320.96679033209;3334.283129127225;3337.49812584338;1295.086963690596;1296.4814074370327;1300.2966114390085;1321.729045545661;1335.205552696154;11538.076953843673;11596.710082247926;11621.186516943817;11639.243449175861;11663.125265605113;4142.565030671796;4370.978145109254;4395.802188901507;4424.778761061998;4466.6203372713035;9096.681616143536;9145.176934075833;9150.725478235663;9203.35576509638;9214.308926830514;5158.0199762045095;5159.664621799571;5162.380514338229;5162.561182299547;5178.533931946143;4221.535631080578;4362.7818609070055;4678.789454474557;4701.905961880743;4890.682105663121;4009.1179940413062;4030.6170913763144;4153.293940030202;4168.979155104205;4180.059486615487;1285.2802430638872;1297.928613926243;1327.8406591209116;1328.0902581731546;1341.9396127174105;974.9853752193723;1000.6247657128577;1006.6677996261217;1012.9341592796445;1019.8164330420595;5565;5712.028955077563;5764.5676574257095;5842.357340692521;5983.521318294526;1031.742064483879;1037.5953378182514;1037.984430233547;1068.6954218047974;1114.2979922648842;3802.429635554689;3889.902752431212;3893.201893611803;3903.785291808978;3969.0871099647243;9606.807863842823;9725.173360264314;9801.754956126011;9852.310338276395;9957.80084398308;9752.366096203725;9788.510574471391;9810;9840.950795245977;9911.752206194902;7771.805704857424;8093.716719914774;8181.304589109992;8340.29107525867;8353.624086916103;5806.274215723035;5876.647401155944;5894.498967587631;5922.099554330523;5976.521878249817;8969.641214351353;9151.86272205904;9231.723048308562;9346.906530934875;9399.671011514563;9274.768130796783;9336.673216437392;9382.48396338208;9454.14912657864;9471.28965327617;7294.343509084208;7402.925970740439;7495.88756168647;7552.584607846401;7554.811129721801;8317.168283171635;8357.164283571594;8362.958185209034;8372.037215720271;8372.790680233044;7468.402527797872;7492.325690687864;7534.095908491016;7568.5458872467825;7725.188855170126;7408.073990751156;7473.364763995121;7487.5507469552;7502.137254215835;7539.0576177977755;6291.622502649856;6404.775832845828;6410.61536307823;6416.518761092843;6426.807195784134;5102.336696229467;5126.6923984561045;5145.536901678717;5147.433782284021;5300.681959082467;5032.370953630796;5041.949580504294;5092.6435149539175;5116.692998420107;5224.085784987688 10:04:34 INFO - PROCESS | 17472 | |4;prototype.html;350.62658268943574;355.1706764704415;365.1546669460198;372.96083911189334;378.3643478955355;5308.203769434577;5391.433899440561;5419.430959749228;5435.510804027636;5474.835754927349;5279.445658205881;5338.690012192446;5387.868547605008;5394.757235924383;5422.6475279106835;4241.660667146636;4243.257429949762;4260.254455470295;4265.722728022669;4271.295236286009;4068.8982775430554;4193.245215861144;4252.893677658068;4262.424572682679;4266.829326826939;4199.307114326132;4227.429297044906;4228.118487273165;4232.915341693164;4235.280002399584;4221.24017676818;4222.493300803892;4225.72532785368;4231.772785892088;4239.0885959518855;3742.6631603155847;3748.456473811282;3748.9437658435145;3757.812109394519;3766.679832214265;5179.766910489037;5283.1546952487415;5283.89038301957;5307.9734601326745;5376.166694162411;4835.468098509161;4851.757412129415;4856.150173719585;4858.230808439191;4876.561109500162;5479.671219726829;5662.235598194232;5686.943130568724;5696.316442026942;5727.167306461893;4069.2065047315787;4099.569545197771;4100.077482566428;4110.568390319033;4137.46212992309;5850;5862.38444963277;5869.148973398876;5887.528117970507;5922.97038514809;4142.544320124784;4168.374743788396;4186.853460128881;4206.053637931441;4243.42713733642;4073.348264277701;4145.606167414091;4188.790560471964;4197.286461301586;4238.766867822238;4790.712557246507;4791.952080479151;4806.903861922742;4840.661153719277;4868.123737727172;5625.662460252398;5690.4025077367105;5731.541476681856;5739.512141467939;5746.454086861741;1398.5594537720585;1426.1514398932618;1427.3300238720722;1430.3348942741675;1433.1114708880561;952.9047095290554;965.9517024148764;975.6195083917278;978.2174260591498;984.1437948984429;5438.362394238791;5458.617896747269;5467.890642187134;5492.972535137299;5524.861878452991;5553.278073850454;5647.458643610392;5668.149777533321;5669.469243304285;5683.431656834367;5204.947950520446;5482.451754824486;5502.58730595207;5504.779808807683;5511.696856672841;2985.7312841843905;2998.99067624692;3012.8041677290908;3044.9847750761105;3047.222958145703;5767.711614419262;5948.940510594925;6010.699465026732;6011.248593925759;6029.366916473795;5683;5757.9424205757405;5767.798127065533;5781.913271300934;5792.623479473821;5895.35151133375;5927.170196172539;5956.791512297049;5998.340182579913;6021.458068773743;5416.152543473648;5527.944720552743;5605.607607467438;5734.569907257056;5749.1663708762835;5599.860003499782;5609.325891541047;5612.522935550524;5633.943660563342;5687;5936.970315148569;5943.197668314895;5943.484411475046;6000.429959153874;6001.309849367379;3856.2480316338047;4042.514898212233;4103.651189648914;4200.957990420179;4212.7472351659;5841.561882858888;5849.181114643869;5856.150858125463;5865.882682346414;5898.233229680286;5765.221695071112;5778.913316300175;5783.884322313446;5786.94213057864;5795.768169273182;5593.300837395325;5714.657120572779;5745;5788.623739456922;5801.3038435388025;5638.830835074954;5683.630564013326;5700.401457846866;5779.306483221872;5789.334226563999;5510.5316048134755;5735.684537350486;5746.683932383759;5762.798302059407;5777.422257774189;5634.774609015757;5655.688937108499;5656.830295091154;5659.405762394889;5671.631343962629 10:04:34 INFO - PROCESS | 17472 | |5;yui.html;823.1973825520118;831.4553967151518;836.8200836820082;899.847026005579;903.4985583001434;15987.76018359724;16771.1614419279;17310.826891731096;17957.281708731636;18037.098145092725;17677.1161441928;17820.64358712825;18030;18031.72952405715;18141.365052223176;803.4135081390589;830.5099991005305;839.9790005249856;842.4945032980224;842.759813453166;844.8310337932438;847.6185716427632;851.2041241439243;851.8935133108362;852.0754980845759;872.9563521823915;880.067128843428;881.2685471059037;883.4919921045392;886.2776836877956;868.0234735922088;870.8650159225331;873.5937788928147;877.473515890467;877.6182360673064;641.0256410256384;642.0369445831253;643.6910283064155;644.391050457318;644.7388807532957;17320;17436.825631743774;17573.384931527464;17600.64798704019;17970.371037013643;16284.75572866408;16358.754618680729;16532.504024879152;16554.503364899072;16703.415380461745;12912.548060817826;12922.41849116792;12972.80540791889;13040.282784446852;13261.602151935362;4017.116234428421;4042.797860106983;4094.0583665756744;4095.2833254180696;4151.83392664293;84527.57736211341;84793.57603211944;85092.57453712691;86004.56997714972;86411;12375.133740638068;12532.749345013048;12545.560905368267;12588.937055314847;12595.307258100893;24724.505509889703;24750;24775.38061548476;25086.121985730413;25210.873945630156;8054.718084867001;8357.289630381363;8364.874526882102;8389.07720150783;8421.284190843724;5082.466341034212;5152;5160.122779127557;5220.634555581073;5288.286081378965;3800.657940785343;3826.215625796705;3837.5394952605866;3880.631340022693;3897.395903634941;596.6122020686502;600.8643663476033;602.5842168903442;605.4127496328555;617.102116420607;764.5680190692241;782.9664842407967;792.9286364227132;794.9046114466302;799.8720204767326;10805.567777288821;11221.270617410006;11299.435028248554;11345.773084538263;11928.642140735792;693.3101563943908;699.5592776550842;705.5696025424487;738.9224131466226;823.4318320358933;4978.2034874419915;5536.557075433956;5610.5231055360755;5623.550115990711;5671.6597004179885;60090.09864852031;73515.63242183861;73563.2643673567;76685;77241;65584;66343.66828165925;66996;67935;68083.3191668087;59110;59211.40788592145;59441;59644.40355596389;62403.37596624067;10363;10439.164866810788;10505;10623;11196.720081998015;39839.2032159361;40911.18177636371;42042;42516;44115.77942110269;54003.45996540142;55351.44648553463;55567.722161388934;55664.93842838683;55942.720286398304;13988.930055350065;14481.92759036198;14482.420703171754;14544.200068996306;14576.344064517334;15835.841641583898;15905.920470397574;15989.68020639604;15993.200339983186;16188.433404830774;15142;15308.464203752816;15500.767488487456;15521.611959701098;15572.68854622924;13569.457221711416;13619.25094119833;13648.86351136476;13662;13825;14924.253787310374;14957.700845983238;14968.47610333633;15113.395464181309;15242.923785381447;11500.769984600429;12303.69240768988;12808;12841.357932103545;12859.614211573667;11215.66353009411;11338.659840204808;11438.656840294805;11487.310761354345;11570.363630000431 10:04:34 INFO - PROCESS | 17472 | __end_tp_report 10:04:34 INFO - PROCESS | 17472 | __start_cc_report 10:04:34 INFO - PROCESS | 17472 | _x_x_mozilla_cycle_collect,314 10:04:34 INFO - PROCESS | 17472 | __end_cc_report 10:04:34 INFO - PROCESS | 17472 | __startTimestamp1486490674204__endTimestamp 10:04:34 INFO - PROCESS | 17472 | 10:04:34 INFO - PROCESS | 17472 | ------- Summary: start ------- 10:04:34 INFO - PROCESS | 17472 | Number of tests: 6 10:04:34 INFO - PROCESS | 17472 | 10:04:34 INFO - PROCESS | 17472 | [#0] dojo.html Cycles:165 Average:5486.57 Median:5708.77 stddev:607.87 (10.6%) stddev-sans-first:582.48 10:04:34 INFO - PROCESS | 17472 | Values: 3192.3 3291.9 3321.2 3330.4 3341.3 5406.8 5423.6 5441.7 5474.6 5493.0 5519.5 5558.8 5561.9 5571.7 5586.4 5035.7 5073.3 5090.9 5096.3 5148.7 5089.5 5142.8 5148.2 5157.9 5192.1 4931.4 4933.6 5134.4 5141.3 5152.9 4971.5 4999.3 5058.4 5109.2 5125.1 4986.7 5079.0 5087.1 5089.5 5120.7 5228.7 5426.7 5478.5 5535.1 5549.9 5643.4 5654.9 5716.0 5779.9 5882.4 5845.3 5851.4 5852.5 5884.4 5887.3 5459.0 5465.2 5473.1 5484.1 5492.9 5680.1 5716.0 5891.1 5907.4 5941.5 5774.6 5807.4 5814.0 5842.3 5861.5 5857.1 5900.8 5921.5 5921.9 5924.9 5676.0 5742.0 5747.5 5783.1 5869.6 5847.5 5853.7 5862.7 5877.9 5899.4 4499.0 4505.3 4510.6 4520.1 4535.8 3914.5 3947.6 3993.3 4007.8 4051.8 5773.8 5777.8 5787.6 5834.6 5838.0 5895.1 5906.0 5948.4 5949.0 5960.7 5515.1 5547.0 5698.9 5791.8 5838.1 5087.3 5090.6 5090.8 5118.3 5121.6 6261.7 6268.2 6271.9 6281.6 6288.1 5684.3 5725.2 5862.1 5974.3 5983.6 6213.3 6268.6 6277.9 6281.6 6288.4 5770.7 5777.3 5820.8 5825.0 5837.9 5804.3 5839.8 5858.3 5891.2 5908.7 5647.6 5670.8 5698.9 5738.6 5774.9 5708.8 5728.6 5730.2 5733.9 5742.2 5565.1 5709.4 5730.5 5733.5 5754.9 5610.8 5688.0 5757.4 5783.8 5867.5 5656.3 5692.9 5695.7 5710.3 5710.3 10:04:34 INFO - PROCESS | 17472 | 10:04:34 INFO - PROCESS | 17472 | [#1] ext.html Cycles:180 Average:60399.18 Median:35902.23 stddev:113495.84 (316.1%) stddev-sans-first:113725.37 10:04:34 INFO - PROCESS | 17472 | Values: 583.7 610.9 618.7 712.6 718.7 43932.3 44711.6 48753.5 48798.0 49104.8 49959.0 50921.5 50972.2 50998.5 51105.0 9275.6 11100.2 11451.5 11505.6 11554.5 11049.3 11089.1 11131.4 11146.1 11151.4 11211.7 11233.8 11244.1 11255.0 11267.2 11001.6 11068.2 11079.4 11101.9 11122.6 10975.0 11081.7 11089.9 11166.6 11177.4 42456.8 42904.0 42961.4 43058.6 43071.4 4410.9 4449.7 4496.3 4559.7 4570.9 31445.2 31869.0 32242.0 32690.3 32819.0 4362.3 4393.4 4433.1 4499.0 4555.4 374919.0 376747.0 376963.0 378460.0 379076.0 62490.4 62847.7 63089.4 63302.0 63354.0 64920.0 65046.3 65061.0 65141.3 65373.0 15767.4 16155.8 16902.2 17177.0 17229.7 13017.9 13308.6 13331.7 13949.4 13963.9 20058.9 20368.7 20485.8 20527.7 20531.4 7284.0 7340.8 7344.2 7440.9 7544.3 1005.4 1005.9 1016.8 1017.2 1037.6 33249.5 33672.3 33769.3 34091.7 34741.7 1103.5 1173.2 1183.7 1216.4 1216.7 17778.5 17879.9 17923.3 18042.5 18102.7 545957.0 548713.0 552331.0 552412.0 552756.0 72327.6 72490.6 72707.0 72957.6 73105.0 1561.8 1566.6 1580.7 1605.3 1626.2 32961.8 33152.0 33367.2 33599.2 33899.7 58949.4 59030.0 59218.4 59724.7 60008.4 325926.0 326318.0 327789.0 328544.0 328630.0 31809.8 32944.7 33048.5 33124.0 33168.7 47546.3 47903.0 49599.8 55227.4 55459.0 41193.0 41378.2 42196.4 42812.6 43242.4 41573.2 41610.0 41783.8 42672.4 42743.4 41554.6 42140.8 42239.4 42305.4 42336.2 34374.0 35594.5 36210.0 36302.3 36363.5 27535.3 27799.6 27906.3 28060.0 28250.7 10:04:34 INFO - PROCESS | 17472 | 10:04:34 INFO - PROCESS | 17472 | [#2] jquery.html Cycles:180 Average:33757.99 Median:2836.52 stddev:101673.85 (3584.5%) stddev-sans-first:101928.21 10:04:34 INFO - PROCESS | 17472 | Values: 395.3 399.6 401.5 405.7 415.7 20036.6 21500.6 22061.8 22079.8 22108.1 20399.6 21263.1 22780.0 23195.4 23481.2 5947.8 6189.8 6194.1 6218.6 6232.6 5942.5 5998.4 6013.9 6043.7 6075.7 6000.0 6002.0 6004.6 6006.8 6015.9 5852.4 5886.6 5889.0 5907.7 5918.3 5230.9 5244.4 5264.6 5267.7 5275.4 26031.5 26128.7 26345.2 26377.3 26390.9 2708.9 2821.8 2851.2 2857.7 3342.5 11005.9 11070.7 11395.7 11641.7 16677.7 2014.2 2055.7 2092.4 2096.4 2100.4 95403.0 99720.5 101596.5 101655.5 102292.0 12040.5 12309.8 12385.5 12481.4 12523.4 16899.6 16952.3 17079.2 17085.0 17093.1 9266.3 9362.3 9403.1 9420.2 9590.1 9281.1 9329.4 9350.1 9468.4 9512.6 4922.8 5073.2 5104.3 5155.0 5249.1 2093.5 2098.0 2117.7 2137.3 2137.6 952.6 955.1 963.5 972.7 986.2 19874.5 20578.4 21661.7 21732.5 22120.6 972.1 982.6 984.8 985.1 992.6 11649.8 11792.8 11920.0 12003.1 12019.4 308243.0 606741.0 662241.0 687167.0 722611.0 82858.0 110002.0 110529.2 110721.0 112874.4 1042.7 1044.9 1066.5 1072.1 1073.5 17613.0 18404.4 18535.5 18881.5 19388.4 37471.0 43898.6 44344.3 48909.5 50761.7 60213.4 61657.0 62503.0 64726.0 71926.3 8567.5 8936.5 9030.5 9058.8 9176.4 9841.7 13560.5 13599.2 14265.2 14364.6 11331.5 11356.7 11404.9 11567.4 11823.3 6196.0 8827.3 10500.7 11351.6 11390.8 12417.2 12423.0 12560.9 12676.4 12854.1 7743.3 7979.2 8128.0 8465.1 9206.4 11344.3 11713.5 11763.9 12106.0 12142.3 10:04:34 INFO - PROCESS | 17472 | 10:04:34 INFO - PROCESS | 17472 | [#3] mootools.html Cycles:180 Average:5572.20 Median:5162.47 stddev:3033.16 (58.8%) stddev-sans-first:3026.36 10:04:34 INFO - PROCESS | 17472 | Values: 1517.1 1518.8 1520.4 1530.4 1534.8 8116.4 8288.3 8453.1 8793.1 8805.7 8643.0 8758.1 8767.9 8776.3 8777.3 2336.2 2390.9 2393.4 2394.3 2405.7 2358.1 2380.0 2390.4 2390.8 2391.9 2234.7 2244.8 2245.5 2245.5 2257.8 2240.2 2261.1 2273.9 2276.1 2277.4 2193.9 2209.5 2228.3 2230.1 2232.9 8658.6 8737.5 8769.9 8777.5 8788.5 5154.1 5249.9 5250.1 5289.8 5292.1 3126.6 3130.2 3321.0 3334.3 3337.5 1295.1 1296.5 1300.3 1321.7 1335.2 11538.1 11596.7 11621.2 11639.2 11663.1 4142.6 4371.0 4395.8 4424.8 4466.6 9096.7 9145.2 9150.7 9203.4 9214.3 5158.0 5159.7 5162.4 5162.6 5178.5 4221.5 4362.8 4678.8 4701.9 4890.7 4009.1 4030.6 4153.3 4169.0 4180.1 1285.3 1297.9 1327.8 1328.1 1341.9 975.0 1000.6 1006.7 1012.9 1019.8 5565.0 5712.0 5764.6 5842.4 5983.5 1031.7 1037.6 1038.0 1068.7 1114.3 3802.4 3889.9 3893.2 3903.8 3969.1 9606.8 9725.2 9801.8 9852.3 9957.8 9752.4 9788.5 9810.0 9841.0 9911.8 7771.8 8093.7 8181.3 8340.3 8353.6 5806.3 5876.6 5894.5 5922.1 5976.5 8969.6 9151.9 9231.7 9346.9 9399.7 9274.8 9336.7 9382.5 9454.1 9471.3 7294.3 7402.9 7495.9 7552.6 7554.8 8317.2 8357.2 8363.0 8372.0 8372.8 7468.4 7492.3 7534.1 7568.5 7725.2 7408.1 7473.4 7487.6 7502.1 7539.1 6291.6 6404.8 6410.6 6416.5 6426.8 5102.3 5126.7 5145.5 5147.4 5300.7 5032.4 5041.9 5092.6 5116.7 5224.1 10:04:34 INFO - PROCESS | 17472 | 10:04:34 INFO - PROCESS | 17472 | [#4] prototype.html Cycles:180 Average:4773.51 Median:5481.06 stddev:1398.60 (25.5%) stddev-sans-first:1362.55 10:04:34 INFO - PROCESS | 17472 | Values: 350.6 355.2 365.2 373.0 378.4 5308.2 5391.4 5419.4 5435.5 5474.8 5279.4 5338.7 5387.9 5394.8 5422.6 4241.7 4243.3 4260.3 4265.7 4271.3 4068.9 4193.2 4252.9 4262.4 4266.8 4199.3 4227.4 4228.1 4232.9 4235.3 4221.2 4222.5 4225.7 4231.8 4239.1 3742.7 3748.5 3748.9 3757.8 3766.7 5179.8 5283.2 5283.9 5308.0 5376.2 4835.5 4851.8 4856.2 4858.2 4876.6 5479.7 5662.2 5686.9 5696.3 5727.2 4069.2 4099.6 4100.1 4110.6 4137.5 5850.0 5862.4 5869.1 5887.5 5923.0 4142.5 4168.4 4186.9 4206.1 4243.4 4073.3 4145.6 4188.8 4197.3 4238.8 4790.7 4792.0 4806.9 4840.7 4868.1 5625.7 5690.4 5731.5 5739.5 5746.5 1398.6 1426.2 1427.3 1430.3 1433.1 952.9 966.0 975.6 978.2 984.1 5438.4 5458.6 5467.9 5493.0 5524.9 5553.3 5647.5 5668.1 5669.5 5683.4 5204.9 5482.5 5502.6 5504.8 5511.7 2985.7 2999.0 3012.8 3045.0 3047.2 5767.7 5948.9 6010.7 6011.2 6029.4 5683.0 5757.9 5767.8 5781.9 5792.6 5895.4 5927.2 5956.8 5998.3 6021.5 5416.2 5527.9 5605.6 5734.6 5749.2 5599.9 5609.3 5612.5 5633.9 5687.0 5937.0 5943.2 5943.5 6000.4 6001.3 3856.2 4042.5 4103.7 4201.0 4212.7 5841.6 5849.2 5856.2 5865.9 5898.2 5765.2 5778.9 5783.9 5786.9 5795.8 5593.3 5714.7 5745.0 5788.6 5801.3 5638.8 5683.6 5700.4 5779.3 5789.3 5510.5 5735.7 5746.7 5762.8 5777.4 5634.8 5655.7 5656.8 5659.4 5671.6 10:04:34 INFO - PROCESS | 17472 | 10:04:34 INFO - PROCESS | 17472 | [#5] yui.html Cycles:180 Average:18214.13 Median:4123.56 stddev:22078.60 (535.4%) stddev-sans-first:22101.92 10:04:34 INFO - PROCESS | 17472 | Values: 823.2 831.5 836.8 899.8 903.5 15987.8 16771.2 17310.8 17957.3 18037.1 17677.1 17820.6 18030.0 18031.7 18141.4 803.4 830.5 840.0 842.5 842.8 844.8 847.6 851.2 851.9 852.1 873.0 880.1 881.3 883.5 886.3 868.0 870.9 873.6 877.5 877.6 641.0 642.0 643.7 644.4 644.7 17320.0 17436.8 17573.4 17600.6 17970.4 16284.8 16358.8 16532.5 16554.5 16703.4 12912.5 12922.4 12972.8 13040.3 13261.6 4017.1 4042.8 4094.1 4095.3 4151.8 84527.6 84793.6 85092.6 86004.6 86411.0 12375.1 12532.7 12545.6 12588.9 12595.3 24724.5 24750.0 24775.4 25086.1 25210.9 8054.7 8357.3 8364.9 8389.1 8421.3 5082.5 5152.0 5160.1 5220.6 5288.3 3800.7 3826.2 3837.5 3880.6 3897.4 596.6 600.9 602.6 605.4 617.1 764.6 783.0 792.9 794.9 799.9 10805.6 11221.3 11299.4 11345.8 11928.6 693.3 699.6 705.6 738.9 823.4 4978.2 5536.6 5610.5 5623.6 5671.7 60090.1 73515.6 73563.3 76685.0 77241.0 65584.0 66343.7 66996.0 67935.0 68083.3 59110.0 59211.4 59441.0 59644.4 62403.4 10363.0 10439.2 10505.0 10623.0 11196.7 39839.2 40911.2 42042.0 42516.0 44115.8 54003.5 55351.4 55567.7 55664.9 55942.7 13988.9 14481.9 14482.4 14544.2 14576.3 15835.8 15905.9 15989.7 15993.2 16188.4 15142.0 15308.5 15500.8 15521.6 15572.7 13569.5 13619.3 13648.9 13662.0 13825.0 14924.3 14957.7 14968.5 15113.4 15242.9 11500.8 12303.7 12808.0 12841.4 12859.6 11215.7 11338.7 11438.7 11487.3 11570.4 10:04:34 INFO - PROCESS | 17472 | -------- Summary: end -------- 10:04:34 INFO - PROCESS | 17472 | 10:04:35 INFO - TEST-INFO | 17472: exit 0 10:04:35 INFO - TEST-OK | dromaeo_css | took 1112358ms 10:04:35 INFO - TEST-START | kraken 10:04:35 INFO - operating with platform_type : linux_ 10:04:35 INFO - Initialising browser for kraken test... 10:04:35 INFO - TEST-INFO | started process 17839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEKEgwC/profile http://localhost:46881/getInfo.html) 10:04:39 INFO - PROCESS | 17839 | __metrics Screen width/height:1600/1200 10:04:39 INFO - PROCESS | 17839 | colorDepth:24 10:04:39 INFO - PROCESS | 17839 | Browser inner width/height: 1024/697 10:04:39 INFO - PROCESS | 17839 | __metrics 10:04:40 INFO - PROCESS | 17839 | 1486490680345 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 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpEKEgwC/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpEKEgwC/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpEKEgwC/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpEKEgwC/profile/extensions/talos-powers@TalosPowersService.js:55:9 10:04:40 ERROR - PROCESS | 17839 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 10:04:41 INFO - TEST-INFO | 17839: exit 0 10:04:41 INFO - Browser initialized. 10:04:41 INFO - Running cycle 1/1 for kraken test... 10:04:41 INFO - TEST-INFO | started process 17966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEKEgwC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:04:53 INFO - PROCESS | 17966 | RSS: Main: 144465920 10:04:53 INFO - PROCESS | 17966 | 10:04:55 INFO - PROCESS | 17966 | Cycle 1(1): loaded http://localhost:46881/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46881/tests/kraken/driver.html?testName=audio-beat-detection) 10:04:56 INFO - PROCESS | 17966 | RSS: Main: 151212032 10:04:56 INFO - PROCESS | 17966 | 10:04:59 INFO - PROCESS | 17966 | Cycle 1(1): loaded http://localhost:46881/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46881/tests/kraken/driver.html?testName=audio-dft) 10:04:59 INFO - PROCESS | 17966 | RSS: Main: 149630976 10:04:59 INFO - PROCESS | 17966 | 10:05:02 INFO - PROCESS | 17966 | Cycle 1(1): loaded http://localhost:46881/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46881/tests/kraken/driver.html?testName=audio-fft) 10:05:03 INFO - PROCESS | 17966 | RSS: Main: 150413312 10:05:03 INFO - PROCESS | 17966 | 10:05:05 INFO - PROCESS | 17966 | Cycle 1(1): loaded http://localhost:46881/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46881/tests/kraken/driver.html?testName=audio-oscillator) 10:05:05 INFO - PROCESS | 17966 | RSS: Main: 149934080 10:05:05 INFO - PROCESS | 17966 | 10:05:07 INFO - PROCESS | 17966 | Cycle 1(1): loaded http://localhost:46881/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46881/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:05:08 INFO - PROCESS | 17966 | RSS: Main: 149843968 10:05:08 INFO - PROCESS | 17966 | 10:05:11 INFO - PROCESS | 17966 | Cycle 1(1): loaded http://localhost:46881/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46881/tests/kraken/driver.html?testName=imaging-darkroom) 10:05:12 INFO - PROCESS | 17966 | RSS: Main: 154058752 10:05:12 INFO - PROCESS | 17966 | 10:05:15 INFO - PROCESS | 17966 | Cycle 1(1): loaded http://localhost:46881/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46881/tests/kraken/driver.html?testName=imaging-desaturate) 10:05:16 INFO - PROCESS | 17966 | RSS: Main: 153341952 10:05:16 INFO - PROCESS | 17966 | 10:05:18 INFO - PROCESS | 17966 | Cycle 1(1): loaded http://localhost:46881/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46881/tests/kraken/driver.html?testName=json-parse-financial) 10:05:19 INFO - PROCESS | 17966 | RSS: Main: 152842240 10:05:19 INFO - PROCESS | 17966 | 10:05:21 INFO - PROCESS | 17966 | Cycle 1(1): loaded http://localhost:46881/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46881/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:21 INFO - PROCESS | 17966 | RSS: Main: 152436736 10:05:21 INFO - PROCESS | 17966 | 10:05:23 INFO - PROCESS | 17966 | Cycle 1(1): loaded http://localhost:46881/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46881/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:05:24 INFO - PROCESS | 17966 | RSS: Main: 151867392 10:05:24 INFO - PROCESS | 17966 | 10:05:26 INFO - PROCESS | 17966 | Cycle 1(1): loaded http://localhost:46881/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46881/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:05:26 INFO - PROCESS | 17966 | RSS: Main: 152358912 10:05:26 INFO - PROCESS | 17966 | 10:05:29 INFO - PROCESS | 17966 | Cycle 1(1): loaded http://localhost:46881/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:05:30 INFO - PROCESS | 17966 | RSS: Main: 152629248 10:05:30 INFO - PROCESS | 17966 | 10:05:32 INFO - PROCESS | 17966 | Cycle 1(1): loaded http://localhost:46881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:05:33 INFO - PROCESS | 17966 | RSS: Main: 153067520 10:05:33 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | Cycle 1(1): loaded http://localhost:46881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46881/tests/kraken/driver.html?testName=ai-astar) 10:05:35 INFO - PROCESS | 17966 | RSS: Main: 154529792 10:05:35 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | __start_tp_report 10:05:35 INFO - PROCESS | 17966 | _x_x_mozilla_page_load 10:05:35 INFO - PROCESS | 17966 | _x_x_mozilla_page_load_details 10:05:35 INFO - PROCESS | 17966 | |i|pagename|runs| 10:05:35 INFO - PROCESS | 17966 | |0;ai-astar;102;112;113;110;112;115;110;113;111;112 10:05:35 INFO - PROCESS | 17966 | |1;audio-beat-detection;150;118;121;149;123;119;118;118;135;118 10:05:35 INFO - PROCESS | 17966 | |2;audio-dft;164;164;160;161;161;162;162;164;162;168 10:05:35 INFO - PROCESS | 17966 | |3;audio-fft;75;74;75;122;76;76;77;76;93;77 10:05:35 INFO - PROCESS | 17966 | |4;audio-oscillator;84;83;107;84;83;83;96;82;83;108 10:05:35 INFO - PROCESS | 17966 | |5;imaging-gaussian-blur;118;118;118;119;117;117;117;117;118;122 10:05:35 INFO - PROCESS | 17966 | |6;imaging-darkroom;148;148;148;148;149;149;148;147;148;147 10:05:35 INFO - PROCESS | 17966 | |7;imaging-desaturate;96;96;97;98;95;96;96;96;96;97 10:05:35 INFO - PROCESS | 17966 | |8;json-parse-financial;54;56;57;54;58;60;54;56;56;54 10:05:35 INFO - PROCESS | 17966 | |9;json-stringify-tinderbox;65;65;65;65;66;64;64;65;65;66 10:05:35 INFO - PROCESS | 17966 | |10;stanford-crypto-aes;76;76;76;83;75;84;76;75;82;76 10:05:35 INFO - PROCESS | 17966 | |11;stanford-crypto-ccm;123;123;130;124;126;125;121;128;158;121 10:05:35 INFO - PROCESS | 17966 | |12;stanford-crypto-pbkdf2;161;164;166;159;158;157;159;161;165;160 10:05:35 INFO - PROCESS | 17966 | |13;stanford-crypto-sha256-iterative;70;63;74;62;61;62;64;63;61;60 10:05:35 INFO - PROCESS | 17966 | __end_tp_report 10:05:35 INFO - PROCESS | 17966 | __start_cc_report 10:05:35 INFO - PROCESS | 17966 | _x_x_mozilla_cycle_collect,712 10:05:35 INFO - PROCESS | 17966 | __end_cc_report 10:05:35 INFO - PROCESS | 17966 | __startTimestamp1486490735335__endTimestamp 10:05:35 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | ------- Summary: start ------- 10:05:35 INFO - PROCESS | 17966 | Number of tests: 14 10:05:35 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.50 (3.1%) stddev-sans-first:1.58 10:05:35 INFO - PROCESS | 17966 | Values: 102.0 112.0 113.0 110.0 112.0 115.0 110.0 113.0 111.0 112.0 10:05:35 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:122.00 stddev:12.98 (10.6%) stddev-sans-first:10.75 10:05:35 INFO - PROCESS | 17966 | Values: 150.0 118.0 121.0 149.0 123.0 119.0 118.0 118.0 135.0 118.0 10:05:35 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:2.30 (1.4%) stddev-sans-first:2.40 10:05:35 INFO - PROCESS | 17966 | Values: 164.0 164.0 160.0 161.0 161.0 162.0 162.0 164.0 162.0 168.0 10:05:35 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:15.06 (19.8%) stddev-sans-first:15.75 10:05:35 INFO - PROCESS | 17966 | Values: 75.0 74.0 75.0 122.0 76.0 76.0 77.0 76.0 93.0 77.0 10:05:35 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:83.00 stddev:10.41 (12.5%) stddev-sans-first:10.87 10:05:35 INFO - PROCESS | 17966 | Values: 84.0 83.0 107.0 84.0 83.0 83.0 96.0 82.0 83.0 108.0 10:05:35 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.52 (1.3%) stddev-sans-first:1.62 10:05:35 INFO - PROCESS | 17966 | Values: 118.0 118.0 118.0 119.0 117.0 117.0 117.0 117.0 118.0 122.0 10:05:35 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 10:05:35 INFO - PROCESS | 17966 | Values: 148.0 148.0 148.0 148.0 149.0 149.0 148.0 147.0 148.0 147.0 10:05:35 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 10:05:35 INFO - PROCESS | 17966 | Values: 96.0 96.0 97.0 98.0 95.0 96.0 96.0 96.0 96.0 97.0 10:05:35 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:2.02 (3.6%) stddev-sans-first:2.03 10:05:35 INFO - PROCESS | 17966 | Values: 54.0 56.0 57.0 54.0 58.0 60.0 54.0 56.0 56.0 54.0 10:05:35 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 10:05:35 INFO - PROCESS | 17966 | Values: 65.0 65.0 65.0 65.0 66.0 64.0 64.0 65.0 65.0 66.0 10:05:35 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:76.00 stddev:3.57 (4.7%) stddev-sans-first:3.72 10:05:35 INFO - PROCESS | 17966 | Values: 76.0 76.0 76.0 83.0 75.0 84.0 76.0 75.0 82.0 76.0 10:05:35 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:125.50 stddev:10.96 (8.7%) stddev-sans-first:11.48 10:05:35 INFO - PROCESS | 17966 | Values: 123.0 123.0 130.0 124.0 126.0 125.0 121.0 128.0 158.0 121.0 10:05:35 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.00 stddev:3.06 (1.9%) stddev-sans-first:3.24 10:05:35 INFO - PROCESS | 17966 | Values: 161.0 164.0 166.0 159.0 158.0 157.0 159.0 161.0 165.0 160.0 10:05:35 INFO - PROCESS | 17966 | 10:05:35 INFO - PROCESS | 17966 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:63.00 stddev:4.47 (7.1%) stddev-sans-first:4.18 10:05:35 INFO - PROCESS | 17966 | Values: 70.0 63.0 74.0 62.0 61.0 62.0 64.0 63.0 61.0 60.0 10:05:35 INFO - PROCESS | 17966 | -------- Summary: end -------- 10:05:35 INFO - PROCESS | 17966 | 10:05:36 INFO - TEST-INFO | 17966: exit 0 10:05:36 INFO - TEST-OK | kraken | took 61330ms 10:05:36 INFO - SUITE-END | took 1173s 10:05:36 INFO - Completed test suite (00:19:33) 10:05:36 INFO - javascript benchmark 10:05:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7509.763841731464, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3192.3136525646987, 3291.9177020574466, 3321.153105957982, 3330.4338262495376, 3341.3317336532687, 5406.810761623344, 5423.593230507713, 5441.673499590018, 5474.589405794566, 5492.972535137324, 5519.503244707976, 5558.805441809537, 5561.888762224753, 5571.665700057999, 5586.385497595272, 5035.723035233052, 5073.289739436482, 5090.872728181788, 5096.286519887219, 5148.6910785353, 5089.491050894918, 5142.845714628548, 5148.176291793314, 5157.948420515784, 5192.143296356116, 4931.358923339979, 4933.605311575084, 5134.358205224347, 5141.331626888499, 5152.871178220537, 4971.45314015458, 4999.250112483121, 5058.367704036996, 5109.182530795092, 5125.103106956268, 4986.700797952099, 5078.97460512695, 5087.109755792759, 5089.541941225308, 5120.743962801845, 5228.686278823283, 5426.674399536001, 5478.534324582415, 5535.114381698909, 5549.944500554983, 5643.351014633287, 5654.858628534278, 5715.971420142914, 5779.913301300484, 5882.411758824083, 5845.298564172284, 5851.444112809277, 5852.531797456193, 5884.382139875294, 5887.322957859816, 5458.972705136449, 5465.152901300305, 5473.0969390050195, 5484.095124304525, 5492.862678433071, 5680.0627896397455, 5715.9997000524745, 5891.145783861316, 5907.379725128885, 5941.494972927263, 5774.566907481955, 5807.390224026501, 5813.953488372049, 5842.298924129132, 5861.472467477947, 5857.062869940874, 5900.763969441175, 5921.526277897758, 5921.911171332434, 5924.940750592526, 5676.006698827771, 5741.971290143606, 5747.5114615257335, 5783.103618939072, 5869.647821130746, 5847.532197424196, 5853.678047707417, 5862.736176872051, 5877.941220587825, 5899.380565040609, 4499.0, 4505.301678239878, 4510.594046535827, 4520.118576877478, 4535.841245556456, 3914.5106861642294, 3947.624975627311, 3993.341098718737, 4007.7595344279434, 4051.837926482967, 5773.797917072882, 5777.7977770777825, 5787.594868359174, 5834.620749651259, 5837.970810145922, 5895.086261629369, 5905.970470147622, 5948.405159484017, 5949.0, 5960.6721630309885, 5515.062439385314, 5546.972265138729, 5698.886022279614, 5791.7683292667825, 5838.095095260242, 5087.287779710843, 5090.567301779391, 5090.847274581694, 5118.283440318359, 5121.641485096007, 6261.7182226799905, 6268.1851359323, 6271.874562508724, 6281.59169653971, 6288.056791481315, 5684.289463817023, 5725.227094342211, 5862.149988251595, 5974.253218347707, 5983.551233657406, 6213.316535181217, 6268.623882567061, 6277.905831412441, 6281.59169653971, 6288.402601752826, 5770.711464426846, 5777.335606405317, 5820.76716931318, 5824.970875145597, 5837.854053648693, 5804.303483581997, 5839.766409343579, 5858.326292476249, 5891.1752354669525, 5908.675022873783, 5647.604667673223, 5670.829875103754, 5698.886022279614, 5738.626989245686, 5774.8845023098465, 5708.771649133988, 5728.627639203439, 5730.197772311796, 5733.9392212440835, 5742.19609254713, 5565.053940829987, 5709.3719690834805, 5730.541556675373, 5733.455321744427, 5754.856128596651, 5610.831675049755, 5687.971560142173, 5757.3954734753925, 5783.768649254151, 5867.501262392574, 5656.321241451053, 5692.943070569241, 5695.686737229492, 5710.2576665033275, 5710.3433105193435], "value": 5447.029580965851, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.6643929740397, 610.8839320529099, 618.7494064903714, 712.6009434716563, 718.7053308143662, 43932.34101488476, 44711.552884471144, 48753.51246487534, 48798.0, 49104.75447622766, 49959.0, 50921.49078509214, 50972.23541646869, 50998.49001509984, 51105.0, 9275.58259878307, 11100.222984391095, 11451.484683189277, 11505.597304094359, 11554.480048397842, 11049.33703977764, 11089.05743011841, 11131.443427828617, 11146.108311335074, 11151.38667373294, 11211.66365009051, 11233.775324493505, 11244.100471962265, 11255.0, 11267.21129520934, 11001.61494347698, 11068.169887258447, 11079.390633515113, 11101.944490277498, 11122.55509779608, 10975.0, 11081.72295692606, 11089.889101109047, 11166.553337866557, 11177.385243811586, 42456.78771606153, 42904.0, 42961.35557966633, 43058.56941430577, 43071.35392969108, 4410.867673969754, 4449.7330160190495, 4496.258117410656, 4559.74921379324, 4570.862874113782, 31445.17390419758, 31869.0, 32242.0, 32690.346193076242, 32819.015429537154, 4362.345648152771, 4393.384926110315, 4433.13553856998, 4499.0, 4555.385023021883, 374919.0, 376747.0, 376963.0, 378459.99999999726, 379076.0, 62490.375096248456, 62847.68576157181, 63089.36910630927, 63302.0, 63354.0, 64920.0, 65046.34953650403, 65061.0, 65141.34858651353, 65373.0, 15767.448139315298, 16155.838441615668, 16902.154892255337, 17177.0, 17229.65540689179, 13017.934910325577, 13308.600741977756, 13331.733365332639, 13949.372278247503, 13963.930180349033, 20058.896760678304, 20368.69446958297, 20485.795142048388, 20527.692084618742, 20531.38405847827, 7283.963580182065, 7340.797760671777, 7344.155422126417, 7440.925590744023, 7544.283293087257, 1005.4017859373661, 1005.8994100590029, 1016.7813920007234, 1017.2065788684838, 1037.6057098302597, 33249.501257481155, 33672.326553469284, 33769.32461350759, 34091.659083409344, 34741.652583474344, 1103.4593049405732, 1173.239766548211, 1183.6863231243726, 1216.3735676126803, 1216.6532538226563, 17778.46664600064, 17879.910600447176, 17923.283068677367, 18042.458726238234, 18102.728459073125, 545957.0, 548713.0, 552331.0, 552412.0, 552756.0, 72327.6383618089, 72490.63754681192, 72707.0, 72957.6352118236, 73105.0, 1561.8281988981203, 1566.639672875245, 1580.6759614279044, 1605.2856478867025, 1626.243796634547, 32961.83519082485, 33152.0, 33367.16582085467, 33599.16002099967, 33899.66100338965, 58949.41050589439, 59030.0, 59218.40781592129, 59724.70137649284, 60008.39991600028, 325926.0, 326318.0, 327789.0, 328544.0, 328630.0, 31809.840950795096, 32944.67055329416, 33048.50427243641, 33124.0, 33168.66831331656, 47546.28680569863, 47903.0, 49599.752001241206, 55227.44772552223, 55459.0, 41193.0, 41378.1724365517, 42196.367054493596, 42812.57187428086, 43242.35136472892, 41573.168536628495, 41610.0, 41783.7910810444, 42672.35991460068, 42743.358849616656, 41554.58445415507, 42140.78929605455, 42239.366409504495, 42305.365419518115, 42336.15327693367, 34374.0, 35594.46608300929, 36210.0, 36302.273954520235, 36363.45454818233, 27535.31161720973, 27799.58300625533, 27906.302342440787, 28060.0, 28250.71749282563], "value": 21761.683952388743, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.30623755309426, 399.6483094876509, 401.52619908507967, 405.6754596322942, 415.66396849704665, 20036.59926801463, 21500.56998860026, 22061.779382206172, 22079.779202207974, 22108.115675373007, 20399.592008159863, 21263.14947402106, 22780.0, 23195.420114497145, 23481.178158764447, 5947.791827286046, 6189.783357582485, 6194.070889366586, 6218.564700470969, 6232.594881332699, 5942.494887934531, 5998.4001599839885, 6013.939860601382, 6043.728032238538, 6075.665838378887, 6000.0, 6002.0, 6004.5796794224425, 6006.849828754294, 6015.909761353583, 5852.444017818321, 5886.587938844261, 5888.970555147197, 5907.7046147692445, 5918.319393269786, 5230.895382092375, 5244.449332820037, 5264.552513036397, 5267.657602255841, 5275.446078161776, 26031.479370412486, 26128.73871261282, 26345.20964371072, 26377.3405664858, 26390.944362225488, 2708.8645567721537, 2821.8306901585765, 2851.201663534214, 2857.6570811502543, 3342.548755917944, 11005.944970275097, 11070.667879963614, 11395.658130256106, 11641.6507504775, 16677.66644667112, 2014.244658253155, 2055.7019232211396, 2092.435042538506, 2096.423483542023, 2100.432883121564, 95403.0, 99720.50139749255, 101596.49201754018, 101655.49172254092, 102292.0, 12040.518379264906, 12309.815352769716, 12385.504579816707, 12481.375931203585, 12523.373831308398, 16899.57751056209, 16952.321907123824, 17079.231434585472, 17084.97490150595, 17093.059881706376, 9266.305027122859, 9362.25101991839, 9403.106704863027, 9420.19928306088, 9590.136887680002, 9281.118293762082, 9329.440233586007, 9350.111739384884, 9468.431894086378, 9512.571934262975, 4922.778474968635, 5073.188289873602, 5104.285400043997, 5154.974225128851, 5249.081410753103, 2093.5394213273057, 2097.9790202097784, 2117.650587653051, 2137.2901678657013, 2137.5511142659902, 952.6379975609362, 955.1022039283051, 963.5134257200069, 972.7276362618478, 986.1716158426956, 19874.50313742168, 20578.38264852057, 21661.67507487389, 21732.456688582595, 22120.557588848133, 972.1396564040875, 982.5578489679673, 984.7931934293736, 985.0987593943614, 992.6376872441507, 11649.76700465986, 11792.764144717057, 11920.0, 12003.099767517471, 12019.399030048462, 308243.0, 606741.0, 662241.0, 687167.0, 722611.0, 82858.0, 110002.0, 110529.1654455404, 110721.0, 112874.43562782134, 1042.671558459083, 1044.9477526123662, 1066.5094056733835, 1072.06730144773, 1073.4525392050111, 17613.03128327903, 18404.35584754527, 18535.53661158482, 18881.527961801065, 19388.4183474496, 37471.0, 43898.561014390725, 44344.33483497686, 48909.51090489049, 50761.74619126881, 60213.39786602078, 61657.0, 62503.0, 64726.0, 71926.28073719406, 8567.485950842969, 8936.46381217129, 9030.45817250967, 9058.773530661787, 9176.403533770284, 9841.655542055994, 13560.525381611596, 13599.184048957095, 14265.215413152377, 14364.640883977983, 11331.490082946122, 11356.659300221007, 11404.885951140383, 11567.363794991019, 11823.349715765371, 6195.969020155051, 8827.337949653931, 10500.684979450323, 11351.602693905674, 11390.772184556428, 12417.19288246261, 12423.0, 12560.937195313965, 12676.429560669976, 12854.100212985375, 7743.264389882952, 7979.162187970412, 8128.0, 8465.068842427205, 9206.401583897024, 11344.319340839576, 11713.531458741554, 11763.882431169026, 12106.0, 12142.332171730639], "value": 9912.142131974922, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.1049081042186, 1518.7721841723737, 1520.4146403634597, 1530.3725472556248, 1534.8081489813774, 8116.431849770518, 8288.336933045357, 8453.070162282143, 8793.076726943675, 8805.691800786974, 8643.049264580892, 8758.124187581254, 8767.868481972775, 8776.297896168291, 8777.34169937254, 2336.2056900653815, 2390.940226494343, 2393.413613664655, 2394.2936833634035, 2405.6632071510003, 2358.127492827656, 2380.0, 2390.3785015895905, 2390.8326417150806, 2391.8804059797026, 2234.731832180141, 2244.820414366855, 2245.461089338555, 2245.5396643688005, 2257.7855103765196, 2240.2047273217936, 2261.072960086365, 2273.874936878471, 2276.146445083094, 2277.3737222263926, 2193.923212687564, 2209.4697272654607, 2228.2869481765842, 2230.074519074582, 2232.8883555822144, 8658.567071646456, 8737.519436430994, 8769.912300876973, 8777.517236551987, 8788.472691638459, 5154.123798954187, 5249.86875328116, 5250.05499010178, 5289.841304760864, 5292.100342941709, 3126.624805023389, 3130.2330928922333, 3320.96679033209, 3334.283129127225, 3337.49812584338, 1295.086963690596, 1296.4814074370327, 1300.2966114390085, 1321.729045545661, 1335.205552696154, 11538.076953843673, 11596.710082247926, 11621.186516943817, 11639.243449175861, 11663.125265605113, 4142.565030671796, 4370.978145109254, 4395.802188901507, 4424.778761061998, 4466.6203372713035, 9096.681616143536, 9145.176934075833, 9150.725478235663, 9203.35576509638, 9214.308926830514, 5158.0199762045095, 5159.664621799571, 5162.380514338229, 5162.561182299547, 5178.533931946143, 4221.535631080578, 4362.7818609070055, 4678.789454474557, 4701.905961880743, 4890.682105663121, 4009.1179940413062, 4030.6170913763144, 4153.293940030202, 4168.979155104205, 4180.059486615487, 1285.2802430638872, 1297.928613926243, 1327.8406591209116, 1328.0902581731546, 1341.9396127174105, 974.9853752193723, 1000.6247657128577, 1006.6677996261217, 1012.9341592796445, 1019.8164330420595, 5565.0, 5712.028955077563, 5764.5676574257095, 5842.357340692521, 5983.521318294526, 1031.742064483879, 1037.5953378182514, 1037.984430233547, 1068.6954218047974, 1114.2979922648842, 3802.429635554689, 3889.902752431212, 3893.201893611803, 3903.785291808978, 3969.0871099647243, 9606.807863842823, 9725.173360264314, 9801.754956126011, 9852.310338276395, 9957.80084398308, 9752.366096203725, 9788.510574471391, 9810.0, 9840.950795245977, 9911.752206194902, 7771.805704857424, 8093.716719914774, 8181.304589109992, 8340.29107525867, 8353.624086916103, 5806.274215723035, 5876.647401155944, 5894.498967587631, 5922.099554330523, 5976.521878249817, 8969.641214351353, 9151.86272205904, 9231.723048308562, 9346.906530934875, 9399.671011514563, 9274.768130796783, 9336.673216437392, 9382.48396338208, 9454.14912657864, 9471.28965327617, 7294.343509084208, 7402.925970740439, 7495.88756168647, 7552.584607846401, 7554.811129721801, 8317.168283171635, 8357.164283571594, 8362.958185209034, 8372.037215720271, 8372.790680233044, 7468.402527797872, 7492.325690687864, 7534.095908491016, 7568.5458872467825, 7725.188855170126, 7408.073990751156, 7473.364763995121, 7487.5507469552, 7502.137254215835, 7539.0576177977755, 6291.622502649856, 6404.775832845828, 6410.61536307823, 6416.518761092843, 6426.807195784134, 5102.336696229467, 5126.6923984561045, 5145.536901678717, 5147.433782284021, 5300.681959082467, 5032.370953630796, 5041.949580504294, 5092.6435149539175, 5116.692998420107, 5224.085784987688], "value": 4546.816722821937, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.62658268943574, 355.1706764704415, 365.1546669460198, 372.96083911189334, 378.3643478955355, 5308.203769434577, 5391.433899440561, 5419.430959749228, 5435.510804027636, 5474.835754927349, 5279.445658205881, 5338.690012192446, 5387.868547605008, 5394.757235924383, 5422.6475279106835, 4241.660667146636, 4243.257429949762, 4260.254455470295, 4265.722728022669, 4271.295236286009, 4068.8982775430554, 4193.245215861144, 4252.893677658068, 4262.424572682679, 4266.829326826939, 4199.307114326132, 4227.429297044906, 4228.118487273165, 4232.915341693164, 4235.280002399584, 4221.24017676818, 4222.493300803892, 4225.72532785368, 4231.772785892088, 4239.0885959518855, 3742.6631603155847, 3748.456473811282, 3748.9437658435145, 3757.812109394519, 3766.679832214265, 5179.766910489037, 5283.1546952487415, 5283.89038301957, 5307.9734601326745, 5376.166694162411, 4835.468098509161, 4851.757412129415, 4856.150173719585, 4858.230808439191, 4876.561109500162, 5479.671219726829, 5662.235598194232, 5686.943130568724, 5696.316442026942, 5727.167306461893, 4069.2065047315787, 4099.569545197771, 4100.077482566428, 4110.568390319033, 4137.46212992309, 5850.0, 5862.38444963277, 5869.148973398876, 5887.528117970507, 5922.97038514809, 4142.544320124784, 4168.374743788396, 4186.853460128881, 4206.053637931441, 4243.42713733642, 4073.348264277701, 4145.606167414091, 4188.790560471964, 4197.286461301586, 4238.766867822238, 4790.712557246507, 4791.952080479151, 4806.903861922742, 4840.661153719277, 4868.123737727172, 5625.662460252398, 5690.4025077367105, 5731.541476681856, 5739.512141467939, 5746.454086861741, 1398.5594537720585, 1426.1514398932618, 1427.3300238720722, 1430.3348942741675, 1433.1114708880561, 952.9047095290554, 965.9517024148764, 975.6195083917278, 978.2174260591498, 984.1437948984429, 5438.362394238791, 5458.617896747269, 5467.890642187134, 5492.972535137299, 5524.861878452991, 5553.278073850454, 5647.458643610392, 5668.149777533321, 5669.469243304285, 5683.431656834367, 5204.947950520446, 5482.451754824486, 5502.58730595207, 5504.779808807683, 5511.696856672841, 2985.7312841843905, 2998.99067624692, 3012.8041677290908, 3044.9847750761105, 3047.222958145703, 5767.711614419262, 5948.940510594925, 6010.699465026732, 6011.248593925759, 6029.366916473795, 5683.0, 5757.9424205757405, 5767.798127065533, 5781.913271300934, 5792.623479473821, 5895.35151133375, 5927.170196172539, 5956.791512297049, 5998.340182579913, 6021.458068773743, 5416.152543473648, 5527.944720552743, 5605.607607467438, 5734.569907257056, 5749.1663708762835, 5599.860003499782, 5609.325891541047, 5612.522935550524, 5633.943660563342, 5687.0, 5936.970315148569, 5943.197668314895, 5943.484411475046, 6000.429959153874, 6001.309849367379, 3856.2480316338047, 4042.514898212233, 4103.651189648914, 4200.957990420179, 4212.7472351659, 5841.561882858888, 5849.181114643869, 5856.150858125463, 5865.882682346414, 5898.233229680286, 5765.221695071112, 5778.913316300175, 5783.884322313446, 5786.94213057864, 5795.768169273182, 5593.300837395325, 5714.657120572779, 5745.0, 5788.623739456922, 5801.3038435388025, 5638.830835074954, 5683.630564013326, 5700.401457846866, 5779.306483221872, 5789.334226563999, 5510.5316048134755, 5735.684537350486, 5746.683932383759, 5762.798302059407, 5777.422257774189, 5634.774609015757, 5655.688937108499, 5656.830295091154, 5659.405762394889, 5671.631343962629], "value": 4333.611620369, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.1973825520118, 831.4553967151518, 836.8200836820082, 899.847026005579, 903.4985583001434, 15987.76018359724, 16771.1614419279, 17310.826891731096, 17957.281708731636, 18037.098145092725, 17677.1161441928, 17820.64358712825, 18030.0, 18031.72952405715, 18141.365052223176, 803.4135081390589, 830.5099991005305, 839.9790005249856, 842.4945032980224, 842.759813453166, 844.8310337932438, 847.6185716427632, 851.2041241439243, 851.8935133108362, 852.0754980845759, 872.9563521823915, 880.067128843428, 881.2685471059037, 883.4919921045392, 886.2776836877956, 868.0234735922088, 870.8650159225331, 873.5937788928147, 877.473515890467, 877.6182360673064, 641.0256410256384, 642.0369445831253, 643.6910283064155, 644.391050457318, 644.7388807532957, 17320.0, 17436.825631743774, 17573.384931527464, 17600.64798704019, 17970.371037013643, 16284.75572866408, 16358.754618680729, 16532.504024879152, 16554.503364899072, 16703.415380461745, 12912.548060817826, 12922.41849116792, 12972.80540791889, 13040.282784446852, 13261.602151935362, 4017.116234428421, 4042.797860106983, 4094.0583665756744, 4095.2833254180696, 4151.83392664293, 84527.57736211341, 84793.57603211944, 85092.57453712691, 86004.56997714972, 86411.0, 12375.133740638068, 12532.749345013048, 12545.560905368267, 12588.937055314847, 12595.307258100893, 24724.505509889703, 24750.0, 24775.38061548476, 25086.121985730413, 25210.873945630156, 8054.718084867001, 8357.289630381363, 8364.874526882102, 8389.07720150783, 8421.284190843724, 5082.466341034212, 5152.0, 5160.122779127557, 5220.634555581073, 5288.286081378965, 3800.657940785343, 3826.215625796705, 3837.5394952605866, 3880.631340022693, 3897.395903634941, 596.6122020686502, 600.8643663476033, 602.5842168903442, 605.4127496328555, 617.102116420607, 764.5680190692241, 782.9664842407967, 792.9286364227132, 794.9046114466302, 799.8720204767326, 10805.567777288821, 11221.270617410006, 11299.435028248554, 11345.773084538263, 11928.642140735792, 693.3101563943908, 699.5592776550842, 705.5696025424487, 738.9224131466226, 823.4318320358933, 4978.2034874419915, 5536.557075433956, 5610.5231055360755, 5623.550115990711, 5671.6597004179885, 60090.09864852031, 73515.63242183861, 73563.2643673567, 76685.0, 77241.0, 65584.0, 66343.66828165925, 66996.0, 67935.0, 68083.3191668087, 59110.0, 59211.40788592145, 59441.0, 59644.40355596389, 62403.37596624067, 10363.0, 10439.164866810788, 10505.0, 10623.0, 11196.720081998015, 39839.2032159361, 40911.18177636371, 42042.0, 42516.0, 44115.77942110269, 54003.45996540142, 55351.44648553463, 55567.722161388934, 55664.93842838683, 55942.720286398304, 13988.930055350065, 14481.92759036198, 14482.420703171754, 14544.200068996306, 14576.344064517334, 15835.841641583898, 15905.920470397574, 15989.68020639604, 15993.200339983186, 16188.433404830774, 15142.0, 15308.464203752816, 15500.767488487456, 15521.611959701098, 15572.68854622924, 13569.457221711416, 13619.25094119833, 13648.86351136476, 13662.0, 13825.0, 14924.253787310374, 14957.700845983238, 14968.47610333633, 15113.395464181309, 15242.923785381447, 11500.769984600429, 12303.69240768988, 12808.0, 12841.357932103545, 12859.614211573667, 11215.66353009411, 11338.659840204808, 11438.656840294805, 11487.310761354345, 11570.363630000431], "value": 7746.975712531004, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1486.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 113.0, 110.0, 112.0, 115.0, 110.0, 113.0, 111.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 121.0, 149.0, 123.0, 119.0, 118.0, 118.0, 135.0, 118.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 160.0, 161.0, 161.0, 162.0, 162.0, 164.0, 162.0, 168.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 122.0, 76.0, 76.0, 77.0, 76.0, 93.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 107.0, 84.0, 83.0, 83.0, 96.0, 82.0, 83.0, 108.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 117.0, 117.0, 117.0, 117.0, 118.0, 122.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 148.0, 147.0, 148.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 98.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 57.0, 54.0, 58.0, 60.0, 54.0, 56.0, 56.0, 54.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 64.0, 64.0, 65.0, 65.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 83.0, 75.0, 84.0, 76.0, 75.0, 82.0, 76.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 123.0, 130.0, 124.0, 126.0, 125.0, 121.0, 128.0, 158.0, 121.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 166.0, 159.0, 158.0, 157.0, 159.0, 161.0, 165.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 63.0, 74.0, 62.0, 61.0, 62.0, 64.0, 63.0, 61.0, 60.0], "value": 64.0, "unit": "score"}]}]} 10:05:36 INFO - Return code: 0 10:05:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:05:36 ERROR - # TBPL SUCCESS # 10:05:36 INFO - Running post-action listener: _resource_record_post_action 10:05:36 INFO - [mozharness: 2017-02-07 18:05:36.645088Z] Finished run-tests step (success) 10:05:36 INFO - Running post-run listener: _resource_record_post_run 10:05:36 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 270336; Write bytes: 361193472; Read time: 112; Write time: 323992 10:05:36 INFO - TinderboxPrint: CPU usage
13.3% 10:05:36 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 112 10:05:36 INFO - TinderboxPrint: I/O write bytes / time
361,193,472 / 323,992 10:05:36 INFO - TinderboxPrint: CPU idle
8,228.3 (86.7%) 10:05:36 INFO - TinderboxPrint: CPU user
1,206.3 (12.7%) 10:05:36 INFO - TinderboxPrint: Swap in / out
0 / 0 10:05:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109977600; Read time: 0; Write time: 149512 10:05:36 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251215872; Read time: 100; Write time: 174480 10:05:37 INFO - Running post-run listener: _upload_blobber_files 10:05:37 INFO - Blob upload gear active. 10:05:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:05:37 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 10:05:37 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'] 10:05:37 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 10:05:37 INFO - (blobuploader) - INFO - Open directory for files ... 10:05:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:05:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:05:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:38 INFO - (blobuploader) - INFO - Done attempting. 10:05:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:05:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:05:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:39 INFO - (blobuploader) - INFO - Done attempting. 10:05:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:05:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:05:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:40 INFO - (blobuploader) - INFO - Done attempting. 10:05:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:05:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:05:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:43 INFO - (blobuploader) - INFO - Done attempting. 10:05:43 INFO - (blobuploader) - INFO - Iteration through files over. 10:05:43 INFO - Return code: 0 10:05:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:05:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:05:43 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb9c08c87ee912fd53a1196d3b93363f1c80117b07f20f69c5e3db9ccbf63178415452c26fdccf02332c8c789e0cd7410b2b8d1740999e84dfb6cee2830484be", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d690d57d666d48b0ea24ca9c8ebbcb136e734c11b43475e51dac33f155ad2af36ede9c69f2cd8f084bd2744b1e857d15901274b31fa038160d32b54aa4b9557a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f29768f0ff8ecb13e6060db01537151d11a23c2389dd461f666c01fab7b7ed81a3886cd883adadf536d306dfbc74cff1e548f1c271301f4212db5f2a0f38fe5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f5b4a4ad52265dfe3c7448f65ce13c92d3268fca6e130ded764d39d089765efc4a9b2e5c8d588fef7e14254cd29e6991bb287a50c427c7c139b59bb382dc57c"} 10:05:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:05:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:05:43 INFO - Contents: 10:05:43 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb9c08c87ee912fd53a1196d3b93363f1c80117b07f20f69c5e3db9ccbf63178415452c26fdccf02332c8c789e0cd7410b2b8d1740999e84dfb6cee2830484be", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d690d57d666d48b0ea24ca9c8ebbcb136e734c11b43475e51dac33f155ad2af36ede9c69f2cd8f084bd2744b1e857d15901274b31fa038160d32b54aa4b9557a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f29768f0ff8ecb13e6060db01537151d11a23c2389dd461f666c01fab7b7ed81a3886cd883adadf536d306dfbc74cff1e548f1c271301f4212db5f2a0f38fe5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f5b4a4ad52265dfe3c7448f65ce13c92d3268fca6e130ded764d39d089765efc4a9b2e5c8d588fef7e14254cd29e6991bb287a50c427c7c139b59bb382dc57c"} 10:05:43 INFO - Running post-run listener: copy_logs_to_upload_dir 10:05:43 INFO - Copying logs to upload dir... 10:05:43 INFO - mkdir: /builds/slave/test/build/upload/logs 10:05:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.122532 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-07 10:05:43.628172) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 10:05:43.632146) ========= 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=ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411 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/bb9c08c87ee912fd53a1196d3b93363f1c80117b07f20f69c5e3db9ccbf63178415452c26fdccf02332c8c789e0cd7410b2b8d1740999e84dfb6cee2830484be", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d690d57d666d48b0ea24ca9c8ebbcb136e734c11b43475e51dac33f155ad2af36ede9c69f2cd8f084bd2744b1e857d15901274b31fa038160d32b54aa4b9557a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f29768f0ff8ecb13e6060db01537151d11a23c2389dd461f666c01fab7b7ed81a3886cd883adadf536d306dfbc74cff1e548f1c271301f4212db5f2a0f38fe5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f5b4a4ad52265dfe3c7448f65ce13c92d3268fca6e130ded764d39d089765efc4a9b2e5c8d588fef7e14254cd29e6991bb287a50c427c7c139b59bb382dc57c"} build_url:https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/FCooJ0XkTKK_dRPbhIcWiA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb9c08c87ee912fd53a1196d3b93363f1c80117b07f20f69c5e3db9ccbf63178415452c26fdccf02332c8c789e0cd7410b2b8d1740999e84dfb6cee2830484be", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d690d57d666d48b0ea24ca9c8ebbcb136e734c11b43475e51dac33f155ad2af36ede9c69f2cd8f084bd2744b1e857d15901274b31fa038160d32b54aa4b9557a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f29768f0ff8ecb13e6060db01537151d11a23c2389dd461f666c01fab7b7ed81a3886cd883adadf536d306dfbc74cff1e548f1c271301f4212db5f2a0f38fe5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f5b4a4ad52265dfe3c7448f65ce13c92d3268fca6e130ded764d39d089765efc4a9b2e5c8d588fef7e14254cd29e6991bb287a50c427c7c139b59bb382dc57c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 10:05:43.657439) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 10:05:43.657814) ========= 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=ba164b0a7b0ec7655860e956000001c1-1486489505.53307-823123411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 10:05:43.743716) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 10:05:43.744455) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 10:05:43.745274) ========= ========= Total master_lag: 0.17 =========