builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1483980238.98 results: success (0) revision: eefd48f36d82304bd1a4bb8626b29ef5ee54bb80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 08:43:58.984121) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 08:43:58.984711) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 08:43:58.985083) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 08:43:59.001263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 08:43:59.001771) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-09 08:44:01-- 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% 221M=0s 2017-01-09 08:44:01 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.229282 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 08:43:59.246831) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 08:43:59.247327) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019022 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 08:43:59.301319) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 08:43:59.301678) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev eefd48f36d82304bd1a4bb8626b29ef5ee54bb80 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/graphics --rev eefd48f36d82304bd1a4bb8626b29ef5ee54bb80 --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=97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-09 08:44:01,698 truncating revision to first 12 chars 2017-01-09 08:44:01,699 Setting DEBUG logging. 2017-01-09 08:44:01,699 attempt 1/10 2017-01-09 08:44:01,699 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/eefd48f36d82?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 08:44:02,010 unpacking tar archive at: graphics-eefd48f36d82/testing/mozharness/ program finished with exit code 0 elapsedTime=0.591714 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 08:43:59.911397) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 08:43:59.911727) ========= script_repo_revision: eefd48f36d82304bd1a4bb8626b29ef5ee54bb80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 08:43:59.912086) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 08:43:59.912349) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 08:43:59.932804) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-01-09 08:43:59.933261) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:44:02 INFO - MultiFileLogger online at 20170109 08:44:02 in /builds/slave/test 08:44:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 08:44:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:44:02 INFO - {'append_to_log': False, 08:44:02 INFO - 'base_work_dir': '/builds/slave/test', 08:44:02 INFO - 'blob_upload_branch': 'Graphics', 08:44:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:44:02 INFO - 'branch': 'Graphics', 08:44:02 INFO - 'buildbot_json_path': 'buildprops.json', 08:44:02 INFO - 'config_files': ('talos/linux_config.py',), 08:44:02 INFO - 'default_actions': ('clobber', 08:44:02 INFO - 'read-buildbot-config', 08:44:02 INFO - 'download-and-extract', 08:44:02 INFO - 'populate-webroot', 08:44:02 INFO - 'create-virtualenv', 08:44:02 INFO - 'install', 08:44:02 INFO - 'run-tests'), 08:44:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:44:02 INFO - 'download_minidump_stackwalk': True, 08:44:02 INFO - 'download_symbols': 'ondemand', 08:44:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:44:02 INFO - 'tooltool.py': '/tools/tooltool.py', 08:44:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:44:02 INFO - '/tools/misc-python/virtualenv.py')}, 08:44:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:44:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:44:02 INFO - 'installer_path': 'installer.exe', 08:44:02 INFO - 'log_level': 'info', 08:44:02 INFO - 'log_name': 'talos', 08:44:02 INFO - 'log_to_console': True, 08:44:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:44:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:44:02 INFO - 'opt_config_files': (), 08:44:02 INFO - 'pip_index': False, 08:44:02 INFO - 'sps_profile': False, 08:44:02 INFO - 'sps_profile_interval': 0, 08:44:02 INFO - 'suite': 'dromaeojs', 08:44:02 INFO - 'system_bits': '32', 08:44:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:44:02 INFO - 'title': 'talos-linux64-ix-068', 08:44:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:44:02 INFO - 'use_talos_json': True, 08:44:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:44:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:44:02 INFO - 'work_dir': 'build'} 08:44:02 INFO - [mozharness: 2017-01-09 16:44:02.425027Z] Running clobber step. 08:44:02 INFO - Running pre-action listener: _resource_record_pre_action 08:44:02 INFO - Running main action method: clobber 08:44:02 INFO - rmtree: /builds/slave/test/build 08:44:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:44:02 INFO - Running post-action listener: _resource_record_post_action 08:44:02 INFO - [mozharness: 2017-01-09 16:44:02.888577Z] Finished clobber step (success) 08:44:02 INFO - [mozharness: 2017-01-09 16:44:02.888701Z] Running read-buildbot-config step. 08:44:02 INFO - Running pre-action listener: _resource_record_pre_action 08:44:02 INFO - Running main action method: read_buildbot_config 08:44:02 INFO - Using buildbot properties: 08:44:02 INFO - { 08:44:02 INFO - "project": "", 08:44:02 INFO - "product": "firefox", 08:44:02 INFO - "who": "kgupta@mozilla.com", 08:44:02 INFO - "installer_path": "public/build/target.tar.bz2", 08:44:02 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 08:44:02 INFO - "repository": "https://hg.mozilla.org/projects/graphics/", 08:44:02 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 08:44:02 INFO - "stage_platform": "linux64", 08:44:02 INFO - "basedir": "/builds/slave/test", 08:44:02 INFO - "buildnumber": 8, 08:44:02 INFO - "platform": "ubuntu64_hw", 08:44:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:44:02 INFO - "slavebuilddir": "test", 08:44:02 INFO - "taskId": "ETWE2wWTSVaRqwnI-gQODA", 08:44:02 INFO - "branch": "graphics", 08:44:02 INFO - "script_repo_revision": "default", 08:44:02 INFO - "revision": "eefd48f36d82304bd1a4bb8626b29ef5ee54bb80", 08:44:02 INFO - "slavename": "talos-linux64-ix-068", 08:44:02 INFO - "repo_path": "projects/graphics" 08:44:02 INFO - } 08:44:02 INFO - Finding installer, test and symbols from parent task. 08:44:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ETWE2wWTSVaRqwnI-gQODA'}, attempt #1 08:44:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ETWE2wWTSVaRqwnI-gQODA'}, attempt #1 08:44:04 INFO - Task dependencies: RCXJoFLQSUOBgxPZyVH53g 08:44:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g'}, attempt #1 08:44:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.tar.bz2 08:44:04 INFO - Set test_url: https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/test_packages.json 08:44:04 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.crashreporter-symbols.zip 08:44:04 INFO - Running post-action listener: _resource_record_post_action 08:44:04 INFO - [mozharness: 2017-01-09 16:44:04.513391Z] Finished read-buildbot-config step (success) 08:44:04 INFO - [mozharness: 2017-01-09 16:44:04.513608Z] Running download-and-extract step. 08:44:04 INFO - Running pre-action listener: _resource_record_pre_action 08:44:04 INFO - Running main action method: download_and_extract 08:44:04 INFO - mkdir: /builds/slave/test/build/tests 08:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:04 INFO - trying https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.test_packages.json 08:44:04 INFO - Downloading https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:44:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:44:05 INFO - Downloaded 896 bytes. 08:44:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:44:05 INFO - Using the following test package requirements: 08:44:05 INFO - {u'common': [u'target.common.tests.zip'], 08:44:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:44:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:44:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:44:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:44:05 INFO - u'mozbase': [u'target.common.tests.zip'], 08:44:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:44:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:44:05 INFO - u'web-platform': [u'target.common.tests.zip', 08:44:05 INFO - u'target.web-platform.tests.zip'], 08:44:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:44:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:44:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.common.tests.zip 08:44:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:44:05 INFO - Fetch https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.common.tests.zip into memory 08:44:05 INFO - Expected file size: 20251352 08:44:05 INFO - Obtained file size: 20251352 08:44:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:44:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.common.tests.zip 08:44:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:44:09 INFO - Fetch https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.common.tests.zip into memory 08:44:10 INFO - Expected file size: 20251352 08:44:10 INFO - Obtained file size: 20251352 08:44:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.talos.tests.zip 08:44:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:44:15 INFO - Fetch https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.talos.tests.zip into memory 08:44:15 INFO - Expected file size: 14403537 08:44:15 INFO - Obtained file size: 14403537 08:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:16 INFO - trying https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.tar.bz2 08:44:16 INFO - Downloading https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:44:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:44:18 INFO - Downloaded 55898347 bytes. 08:44:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.tar.bz2 08:44:18 INFO - mkdir: /builds/slave/test/properties 08:44:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:44:18 INFO - Writing to file /builds/slave/test/properties/build_url 08:44:18 INFO - Contents: 08:44:18 INFO - build_url:https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.tar.bz2 08:44:18 INFO - Running post-action listener: _resource_record_post_action 08:44:18 INFO - Running post-action listener: set_extra_try_arguments 08:44:18 INFO - [mozharness: 2017-01-09 16:44:18.092516Z] Finished download-and-extract step (success) 08:44:18 INFO - [mozharness: 2017-01-09 16:44:18.092613Z] Running populate-webroot step. 08:44:18 INFO - Running pre-action listener: _resource_record_pre_action 08:44:18 INFO - Running main action method: populate_webroot 08:44:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:44:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:44:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:44:18 INFO - '--tppagecycles', 08:44:18 INFO - '7'], 08:44:18 INFO - 'tests': ['tsvgm']}}, 08:44:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:44:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:44:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:44:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:44:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:44:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:44:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:44:18 INFO - 'talos_options': ['--disable-e10s'], 08:44:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:44:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:44:18 INFO - 'talos_options': ['--disable-e10s'], 08:44:18 INFO - 'tests': ['damp', 'tps']}, 08:44:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:44:18 INFO - 'tests': ['damp', 'tps']}, 08:44:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:44:18 INFO - 'tests': ['dromaeo_dom']}, 08:44:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:44:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:44:18 INFO - 'tests': ['basic_compositor_video']}, 08:44:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:44:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:44:18 INFO - 'tests': ['a11yr', 08:44:18 INFO - 'ts_paint', 08:44:18 INFO - 'tpaint', 08:44:18 INFO - 'sessionrestore', 08:44:18 INFO - 'sessionrestore_no_auto_restore', 08:44:18 INFO - 'tabpaint']}, 08:44:18 INFO - 'other-e10s': {'tests': ['a11yr', 08:44:18 INFO - 'ts_paint', 08:44:18 INFO - 'tpaint', 08:44:18 INFO - 'sessionrestore', 08:44:18 INFO - 'sessionrestore_no_auto_restore', 08:44:18 INFO - 'tabpaint']}, 08:44:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:44:18 INFO - 'ts_paint', 08:44:18 INFO - 'tpaint', 08:44:18 INFO - 'sessionrestore', 08:44:18 INFO - 'sessionrestore_no_auto_restore', 08:44:18 INFO - 'tabpaint']}, 08:44:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:44:18 INFO - 'ts_paint', 08:44:18 INFO - 'tpaint', 08:44:18 INFO - 'sessionrestore', 08:44:18 INFO - 'sessionrestore_no_auto_restore', 08:44:18 INFO - 'tabpaint']}, 08:44:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:44:18 INFO - 'tests': ['a11yr', 08:44:18 INFO - 'ts_paint', 08:44:18 INFO - 'tpaint', 08:44:18 INFO - 'sessionrestore', 08:44:18 INFO - 'sessionrestore_no_auto_restore', 08:44:18 INFO - 'tabpaint']}, 08:44:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:44:18 INFO - 'tests': ['a11yr', 08:44:18 INFO - 'ts_paint', 08:44:18 INFO - 'tpaint', 08:44:18 INFO - 'sessionrestore', 08:44:18 INFO - 'sessionrestore_no_auto_restore', 08:44:18 INFO - 'tabpaint']}, 08:44:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:44:18 INFO - 'tests': ['tsvgx', 08:44:18 INFO - 'tsvgr_opacity', 08:44:18 INFO - 'tart', 08:44:18 INFO - 'tscrollx', 08:44:18 INFO - 'cart', 08:44:18 INFO - 'tsvg_static']}, 08:44:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:44:18 INFO - 'tsvgr_opacity', 08:44:18 INFO - 'tart', 08:44:18 INFO - 'tscrollx', 08:44:18 INFO - 'cart', 08:44:18 INFO - 'tsvg_static']}, 08:44:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:44:18 INFO - 'talos_options': ['--disable-e10s'], 08:44:18 INFO - 'tests': ['tp5o']}, 08:44:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:44:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:44:18 INFO - 'talos_options': ['--disable-e10s', 08:44:18 INFO - '--xperf_path', 08:44:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:18 INFO - 'tests': ['tp5n']}, 08:44:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:44:18 INFO - 'talos_options': ['--xperf_path', 08:44:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:18 INFO - 'tests': ['tp5n']}}, 08:44:18 INFO - 'talos.zip': {'path': '', 08:44:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:44:18 INFO - Running post-action listener: _resource_record_post_action 08:44:18 INFO - [mozharness: 2017-01-09 16:44:18.105902Z] Finished populate-webroot step (success) 08:44:18 INFO - [mozharness: 2017-01-09 16:44:18.105996Z] Running create-virtualenv step. 08:44:18 INFO - Running pre-action listener: _resource_record_pre_action 08:44:18 INFO - Running main action method: create_virtualenv 08:44:18 INFO - Creating virtualenv /builds/slave/test/build/venv 08:44:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:44:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:44:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:44:18 INFO - Using real prefix '/usr' 08:44:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:44:18 INFO - Installing distribute.............................................................................................................................................................................................done. 08:44:20 INFO - Installing pip.................done. 08:44:20 INFO - Return code: 0 08:44:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:44:20 INFO - Reading from file tmpfile_stdout 08:44:20 INFO - Output received: 08:44:20 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:44:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:20 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 0xa6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3f0>, '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 0xddecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:44:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:44:20 INFO - Using env: {'DISPLAY': ':0', 08:44:20 INFO - 'HOME': '/home/cltbld', 08:44:20 INFO - 'LANG': 'en_US.UTF-8', 08:44:20 INFO - 'LANGUAGE': 'en_US:en', 08:44:20 INFO - 'LOGNAME': 'cltbld', 08:44:20 INFO - 'MAIL': '/var/mail/cltbld', 08:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:20 INFO - 'MOZ_NO_REMOTE': '1', 08:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:20 INFO - 'NO_EM_RESTART': '1', 08:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:20 INFO - 'PWD': '/builds/slave/test', 08:44:20 INFO - 'SHELL': '/bin/bash', 08:44:20 INFO - 'SHLVL': '1', 08:44:20 INFO - 'TERM': 'linux', 08:44:20 INFO - 'TMOUT': '86400', 08:44:20 INFO - 'USER': 'cltbld', 08:44:20 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 08:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:20 INFO - '_': '/tools/buildbot/bin/python'} 08:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:44:21 INFO - Cleaning up... 08:44:21 INFO - Return code: 0 08:44:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:21 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 0xa6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3f0>, '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 0xddecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:44:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:44:21 INFO - Using env: {'DISPLAY': ':0', 08:44:21 INFO - 'HOME': '/home/cltbld', 08:44:21 INFO - 'LANG': 'en_US.UTF-8', 08:44:21 INFO - 'LANGUAGE': 'en_US:en', 08:44:21 INFO - 'LOGNAME': 'cltbld', 08:44:21 INFO - 'MAIL': '/var/mail/cltbld', 08:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:21 INFO - 'MOZ_NO_REMOTE': '1', 08:44:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:21 INFO - 'NO_EM_RESTART': '1', 08:44:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:21 INFO - 'PWD': '/builds/slave/test', 08:44:21 INFO - 'SHELL': '/bin/bash', 08:44:21 INFO - 'SHLVL': '1', 08:44:21 INFO - 'TERM': 'linux', 08:44:21 INFO - 'TMOUT': '86400', 08:44:21 INFO - 'USER': 'cltbld', 08:44:21 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 08:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:21 INFO - '_': '/tools/buildbot/bin/python'} 08:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:21 INFO - Downloading/unpacking psutil>=3.1.1 08:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:44:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:23 INFO - Installing collected packages: psutil 08:44:23 INFO - Running setup.py install for psutil 08:44:23 INFO - building 'psutil._psutil_linux' extension 08:44:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:44:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:44:23 INFO - building 'psutil._psutil_posix' extension 08:44:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:44:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:44:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:23 INFO - Successfully installed psutil 08:44:23 INFO - Cleaning up... 08:44:24 INFO - Return code: 0 08:44:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3f0>, '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 0xddecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:44:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:44:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:44:24 INFO - Using env: {'DISPLAY': ':0', 08:44:24 INFO - 'HOME': '/home/cltbld', 08:44:24 INFO - 'LANG': 'en_US.UTF-8', 08:44:24 INFO - 'LANGUAGE': 'en_US:en', 08:44:24 INFO - 'LOGNAME': 'cltbld', 08:44:24 INFO - 'MAIL': '/var/mail/cltbld', 08:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:24 INFO - 'MOZ_NO_REMOTE': '1', 08:44:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:24 INFO - 'NO_EM_RESTART': '1', 08:44:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:24 INFO - 'PWD': '/builds/slave/test', 08:44:24 INFO - 'SHELL': '/bin/bash', 08:44:24 INFO - 'SHLVL': '1', 08:44:24 INFO - 'TERM': 'linux', 08:44:24 INFO - 'TMOUT': '86400', 08:44:24 INFO - 'USER': 'cltbld', 08:44:24 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 08:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:24 INFO - '_': '/tools/buildbot/bin/python'} 08:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:44:26 INFO - Installing collected packages: mozsystemmonitor 08:44:26 INFO - Running setup.py install for mozsystemmonitor 08:44:26 INFO - Successfully installed mozsystemmonitor 08:44:26 INFO - Cleaning up... 08:44:26 INFO - Return code: 0 08:44:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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', '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 0xa6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3f0>, '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 0xddecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:44: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:44: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 jsonschema==2.5.1 08:44:26 INFO - Using env: {'DISPLAY': ':0', 08:44:26 INFO - 'HOME': '/home/cltbld', 08:44:26 INFO - 'LANG': 'en_US.UTF-8', 08:44:26 INFO - 'LANGUAGE': 'en_US:en', 08:44:26 INFO - 'LOGNAME': 'cltbld', 08:44:26 INFO - 'MAIL': '/var/mail/cltbld', 08:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:26 INFO - 'MOZ_NO_REMOTE': '1', 08:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:26 INFO - 'NO_EM_RESTART': '1', 08:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:26 INFO - 'PWD': '/builds/slave/test', 08:44:26 INFO - 'SHELL': '/bin/bash', 08:44:26 INFO - 'SHLVL': '1', 08:44:26 INFO - 'TERM': 'linux', 08:44:26 INFO - 'TMOUT': '86400', 08:44:26 INFO - 'USER': 'cltbld', 08:44:26 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 08:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:26 INFO - '_': '/tools/buildbot/bin/python'} 08:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:26 INFO - Downloading/unpacking jsonschema==2.5.1 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:44:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:28 INFO - Downloading functools32-3.2.3-2.tar.gz 08:44:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:44:28 INFO - warning: no files found matching '*.txt' 08:44:28 INFO - no previously-included directories found matching 'build' 08:44:28 INFO - no previously-included directories found matching 'dist' 08:44:28 INFO - no previously-included directories found matching '.git*' 08:44:28 INFO - Installing collected packages: jsonschema, functools32 08:44:29 INFO - Running setup.py install for functools32 08:44:29 INFO - warning: no files found matching '*.txt' 08:44:29 INFO - no previously-included directories found matching 'build' 08:44:29 INFO - no previously-included directories found matching 'dist' 08:44:29 INFO - no previously-included directories found matching '.git*' 08:44:29 INFO - Successfully installed jsonschema functools32 08:44:29 INFO - Cleaning up... 08:44:29 INFO - Return code: 0 08:44:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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', '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 0xa6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3f0>, '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 0xddecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:44: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:44: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 functools32==3.2.3-2 08:44:29 INFO - Using env: {'DISPLAY': ':0', 08:44:29 INFO - 'HOME': '/home/cltbld', 08:44:29 INFO - 'LANG': 'en_US.UTF-8', 08:44:29 INFO - 'LANGUAGE': 'en_US:en', 08:44:29 INFO - 'LOGNAME': 'cltbld', 08:44:29 INFO - 'MAIL': '/var/mail/cltbld', 08:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:29 INFO - 'MOZ_NO_REMOTE': '1', 08:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:29 INFO - 'NO_EM_RESTART': '1', 08:44:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:29 INFO - 'PWD': '/builds/slave/test', 08:44:29 INFO - 'SHELL': '/bin/bash', 08:44:29 INFO - 'SHLVL': '1', 08:44:29 INFO - 'TERM': 'linux', 08:44:29 INFO - 'TMOUT': '86400', 08:44:29 INFO - 'USER': 'cltbld', 08:44:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 08:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:29 INFO - '_': '/tools/buildbot/bin/python'} 08:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:44:29 INFO - Cleaning up... 08:44:29 INFO - Return code: 0 08:44:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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', '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 0xa6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3f0>, '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 0xddecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:44: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:44: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 blobuploader==1.2.4 08:44:29 INFO - Using env: {'DISPLAY': ':0', 08:44:29 INFO - 'HOME': '/home/cltbld', 08:44:29 INFO - 'LANG': 'en_US.UTF-8', 08:44:29 INFO - 'LANGUAGE': 'en_US:en', 08:44:29 INFO - 'LOGNAME': 'cltbld', 08:44:29 INFO - 'MAIL': '/var/mail/cltbld', 08:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:29 INFO - 'MOZ_NO_REMOTE': '1', 08:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:29 INFO - 'NO_EM_RESTART': '1', 08:44:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:29 INFO - 'PWD': '/builds/slave/test', 08:44:29 INFO - 'SHELL': '/bin/bash', 08:44:29 INFO - 'SHLVL': '1', 08:44:29 INFO - 'TERM': 'linux', 08:44:29 INFO - 'TMOUT': '86400', 08:44:29 INFO - 'USER': 'cltbld', 08:44:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 08:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:29 INFO - '_': '/tools/buildbot/bin/python'} 08:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:29 INFO - Downloading/unpacking blobuploader==1.2.4 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44:31 INFO - Downloading blobuploader-1.2.4.tar.gz 08:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:44:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:44:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:32 INFO - Downloading docopt-0.6.1.tar.gz 08:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:44:32 INFO - Installing collected packages: blobuploader, requests, docopt 08:44:32 INFO - Running setup.py install for blobuploader 08:44:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:44:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:44:32 INFO - Running setup.py install for requests 08:44:32 INFO - Running setup.py install for docopt 08:44:33 INFO - Successfully installed blobuploader requests docopt 08:44:33 INFO - Cleaning up... 08:44:33 INFO - Return code: 0 08:44:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:33 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 0xa6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3f0>, '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 0xddecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:44:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:44:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:44:33 INFO - Using env: {'DISPLAY': ':0', 08:44:33 INFO - 'HOME': '/home/cltbld', 08:44:33 INFO - 'LANG': 'en_US.UTF-8', 08:44:33 INFO - 'LANGUAGE': 'en_US:en', 08:44:33 INFO - 'LOGNAME': 'cltbld', 08:44:33 INFO - 'MAIL': '/var/mail/cltbld', 08:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:33 INFO - 'MOZ_NO_REMOTE': '1', 08:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:33 INFO - 'NO_EM_RESTART': '1', 08:44:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:33 INFO - 'PWD': '/builds/slave/test', 08:44:33 INFO - 'SHELL': '/bin/bash', 08:44:33 INFO - 'SHLVL': '1', 08:44:33 INFO - 'TERM': 'linux', 08:44:33 INFO - 'TMOUT': '86400', 08:44:33 INFO - 'USER': 'cltbld', 08:44:33 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 08:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:33 INFO - '_': '/tools/buildbot/bin/python'} 08:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:33 INFO - Running setup.py (path:/tmp/pip-c4QmMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:33 INFO - Running setup.py (path:/tmp/pip-wyJEM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:33 INFO - Running setup.py (path:/tmp/pip-42CPBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:33 INFO - Running setup.py (path:/tmp/pip-1brIvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:33 INFO - Running setup.py (path:/tmp/pip-WWFpUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:33 INFO - Running setup.py (path:/tmp/pip-FjHL2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:33 INFO - Running setup.py (path:/tmp/pip-2r3xKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:33 INFO - Running setup.py (path:/tmp/pip-MQxEi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:33 INFO - Running setup.py (path:/tmp/pip-SVMcds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:33 INFO - Running setup.py (path:/tmp/pip-pOu31q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:34 INFO - Running setup.py (path:/tmp/pip-VSUOXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:34 INFO - Running setup.py (path:/tmp/pip-5ZIj5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:34 INFO - Running setup.py (path:/tmp/pip-sRbKPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:34 INFO - Running setup.py (path:/tmp/pip-jnPQXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:34 INFO - Running setup.py (path:/tmp/pip-tyczd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:34 INFO - Running setup.py (path:/tmp/pip-ZDFUlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:34 INFO - Running setup.py (path:/tmp/pip-8PoCFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:44:34 INFO - Running setup.py install for manifestparser 08:44:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:44:34 INFO - Running setup.py install for mozcrash 08:44:34 INFO - Running setup.py install for mozdebug 08:44:34 INFO - Running setup.py install for mozdevice 08:44:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:44:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:44:34 INFO - Running setup.py install for mozfile 08:44:35 INFO - Running setup.py install for mozhttpd 08:44:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:44:35 INFO - Running setup.py install for mozinfo 08:44:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:44:35 INFO - Running setup.py install for mozInstall 08:44:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:44:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:44:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:44:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:44:35 INFO - Running setup.py install for mozleak 08:44:35 INFO - Running setup.py install for mozlog 08:44:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:44:35 INFO - Running setup.py install for moznetwork 08:44:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:44:35 INFO - Running setup.py install for mozprocess 08:44:35 INFO - Running setup.py install for mozprofile 08:44:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:44:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:44:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:44:35 INFO - Running setup.py install for mozrunner 08:44:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:44:36 INFO - Running setup.py install for mozscreenshot 08:44:36 INFO - Running setup.py install for moztest 08:44:36 INFO - Running setup.py install for mozversion 08:44:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:44:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:44:36 INFO - Cleaning up... 08:44:36 INFO - Return code: 0 08:44:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:36 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 0xa6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3f0>, '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 0xddecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:44:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:44:36 INFO - Using env: {'DISPLAY': ':0', 08:44:36 INFO - 'HOME': '/home/cltbld', 08:44:36 INFO - 'LANG': 'en_US.UTF-8', 08:44:36 INFO - 'LANGUAGE': 'en_US:en', 08:44:36 INFO - 'LOGNAME': 'cltbld', 08:44:36 INFO - 'MAIL': '/var/mail/cltbld', 08:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:36 INFO - 'MOZ_NO_REMOTE': '1', 08:44:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:36 INFO - 'NO_EM_RESTART': '1', 08:44:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:36 INFO - 'PWD': '/builds/slave/test', 08:44:36 INFO - 'SHELL': '/bin/bash', 08:44:36 INFO - 'SHLVL': '1', 08:44:36 INFO - 'TERM': 'linux', 08:44:36 INFO - 'TMOUT': '86400', 08:44:36 INFO - 'USER': 'cltbld', 08:44:36 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 08:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:36 INFO - '_': '/tools/buildbot/bin/python'} 08:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:36 INFO - Running setup.py (path:/tmp/pip-9MXRSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:36 INFO - Running setup.py (path:/tmp/pip-OyHOfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:36 INFO - Running setup.py (path:/tmp/pip-q7Ycf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:36 INFO - Running setup.py (path:/tmp/pip-UUkkAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:36 INFO - Running setup.py (path:/tmp/pip-qQ5AGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:37 INFO - Running setup.py (path:/tmp/pip-881u1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:37 INFO - Running setup.py (path:/tmp/pip-6NeiWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:37 INFO - Running setup.py (path:/tmp/pip-Q0jBoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:37 INFO - Running setup.py (path:/tmp/pip-hGNT8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:37 INFO - Running setup.py (path:/tmp/pip-glLbwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:37 INFO - Running setup.py (path:/tmp/pip-rWDmhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:37 INFO - Running setup.py (path:/tmp/pip-7TwVco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:37 INFO - Running setup.py (path:/tmp/pip-KC3Cno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:37 INFO - Running setup.py (path:/tmp/pip-9SWUUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:37 INFO - Running setup.py (path:/tmp/pip-jSDac1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:37 INFO - Running setup.py (path:/tmp/pip-jPG4Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:37 INFO - Running setup.py (path:/tmp/pip-_KDE2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:44:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:39 INFO - Downloading blessings-1.6.tar.gz 08:44:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:44:40 INFO - Installing collected packages: blessings 08:44:40 INFO - Running setup.py install for blessings 08:44:40 INFO - Successfully installed blessings 08:44:40 INFO - Cleaning up... 08:44:40 INFO - Return code: 0 08:44:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:44:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:40 INFO - Reading from file tmpfile_stdout 08:44:40 INFO - Current package versions: 08:44:40 INFO - argparse == 1.2.1 08:44:40 INFO - blessings == 1.6 08:44:40 INFO - blobuploader == 1.2.4 08:44:40 INFO - docopt == 0.6.1 08:44:40 INFO - functools32 == 3.2.3-2 08:44:40 INFO - jsonschema == 2.5.1 08:44:40 INFO - manifestparser == 1.1 08:44:40 INFO - mozInstall == 1.12 08:44:40 INFO - mozcrash == 1.0 08:44:40 INFO - mozdebug == 0.1 08:44:40 INFO - mozdevice == 0.49 08:44:40 INFO - mozfile == 1.2 08:44:40 INFO - mozhttpd == 0.7 08:44:40 INFO - mozinfo == 0.9 08:44:40 INFO - mozleak == 0.1 08:44:40 INFO - mozlog == 3.4 08:44:40 INFO - moznetwork == 0.27 08:44:40 INFO - mozprocess == 0.24 08:44:40 INFO - mozprofile == 0.28 08:44:40 INFO - mozrunner == 6.13 08:44:40 INFO - mozscreenshot == 0.1 08:44:40 INFO - mozsystemmonitor == 0.3 08:44:40 INFO - moztest == 0.8 08:44:40 INFO - mozversion == 1.4 08:44:40 INFO - psutil == 3.1.1 08:44:40 INFO - requests == 1.2.3 08:44:40 INFO - wsgiref == 0.1.2 08:44:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:40 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 0xa6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3f0>, '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 0xddecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:44:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:44:40 INFO - Using env: {'DISPLAY': ':0', 08:44:40 INFO - 'HOME': '/home/cltbld', 08:44:40 INFO - 'LANG': 'en_US.UTF-8', 08:44:40 INFO - 'LANGUAGE': 'en_US:en', 08:44:40 INFO - 'LOGNAME': 'cltbld', 08:44:40 INFO - 'MAIL': '/var/mail/cltbld', 08:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:40 INFO - 'MOZ_NO_REMOTE': '1', 08:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:40 INFO - 'NO_EM_RESTART': '1', 08:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:40 INFO - 'PWD': '/builds/slave/test', 08:44:40 INFO - 'SHELL': '/bin/bash', 08:44:40 INFO - 'SHLVL': '1', 08:44:40 INFO - 'TERM': 'linux', 08:44:40 INFO - 'TMOUT': '86400', 08:44:40 INFO - 'USER': 'cltbld', 08:44:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 08:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:40 INFO - '_': '/tools/buildbot/bin/python'} 08:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:44:40 INFO - Cleaning up... 08:44:40 INFO - Return code: 0 08:44:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdde3f0>, '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 0xddecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:44:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:44:40 INFO - Using env: {'DISPLAY': ':0', 08:44:40 INFO - 'HOME': '/home/cltbld', 08:44:40 INFO - 'LANG': 'en_US.UTF-8', 08:44:40 INFO - 'LANGUAGE': 'en_US:en', 08:44:40 INFO - 'LOGNAME': 'cltbld', 08:44:40 INFO - 'MAIL': '/var/mail/cltbld', 08:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:40 INFO - 'MOZ_NO_REMOTE': '1', 08:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:40 INFO - 'NO_EM_RESTART': '1', 08:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:40 INFO - 'PWD': '/builds/slave/test', 08:44:40 INFO - 'SHELL': '/bin/bash', 08:44:40 INFO - 'SHLVL': '1', 08:44:40 INFO - 'TERM': 'linux', 08:44:40 INFO - 'TMOUT': '86400', 08:44:40 INFO - 'USER': 'cltbld', 08:44:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 08:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:40 INFO - '_': '/tools/buildbot/bin/python'} 08:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:44:40 INFO - Cleaning up... 08:44:40 INFO - Return code: 0 08:44:40 INFO - Running post-action listener: _resource_record_post_action 08:44:40 INFO - Running post-action listener: _start_resource_monitoring 08:44:40 INFO - Starting resource monitoring. 08:44:40 INFO - [mozharness: 2017-01-09 16:44:40.924565Z] Finished create-virtualenv step (success) 08:44:40 INFO - [mozharness: 2017-01-09 16:44:40.925152Z] Running install step. 08:44:40 INFO - Running pre-action listener: _resource_record_pre_action 08:44:40 INFO - Running main action method: install 08:44:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:41 INFO - Reading from file tmpfile_stdout 08:44:41 INFO - Detecting whether we're running mozinstall >=1.0... 08:44:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:44:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:44:41 INFO - Reading from file tmpfile_stdout 08:44:41 INFO - Output received: 08:44:41 INFO - Usage: mozinstall [options] installer 08:44:41 INFO - Options: 08:44:41 INFO - -h, --help show this help message and exit 08:44:41 INFO - -d DEST, --destination=DEST 08:44:41 INFO - Directory to install application into. [default: 08:44:41 INFO - "/builds/slave/test"] 08:44:41 INFO - --app=APP Application being installed. [default: firefox] 08:44:41 INFO - mkdir: /builds/slave/test/build/application 08:44:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:44:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:44:57 INFO - Reading from file tmpfile_stdout 08:44:57 INFO - Output received: 08:44:57 INFO - /builds/slave/test/build/application/firefox/firefox 08:44:57 INFO - Running post-action listener: _resource_record_post_action 08:44:57 INFO - [mozharness: 2017-01-09 16:44:57.986416Z] Finished install step (success) 08:44:57 INFO - [mozharness: 2017-01-09 16:44:57.986693Z] Running run-tests step. 08:44:57 INFO - Running pre-action listener: _resource_record_pre_action 08:44:57 INFO - Running main action method: run_tests 08:44:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:44:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:44:57 INFO - Python 2.7.3 08:44:57 INFO - Return code: 0 08:44:57 INFO - grabbing minidump binary from tooltool 08:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:57 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 0xdde3f0>, '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 0xddecf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddf1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:44:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:44:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:44:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:44:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:44:58 INFO - Return code: 0 08:44:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:44:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:44:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:44:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:44:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:44:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:44:58 INFO - Using env: {'DISPLAY': ':0', 08:44:58 INFO - 'HOME': '/home/cltbld', 08:44:58 INFO - 'LANG': 'en_US.UTF-8', 08:44:58 INFO - 'LANGUAGE': 'en_US:en', 08:44:58 INFO - 'LOGNAME': 'cltbld', 08:44:58 INFO - 'MAIL': '/var/mail/cltbld', 08:44:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:44:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:58 INFO - 'MOZ_NO_REMOTE': '1', 08:44:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:58 INFO - 'NO_EM_RESTART': '1', 08:44:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:58 INFO - 'PWD': '/builds/slave/test', 08:44:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:44:58 INFO - 'SHELL': '/bin/bash', 08:44:58 INFO - 'SHLVL': '1', 08:44:58 INFO - 'TERM': 'linux', 08:44:58 INFO - 'TMOUT': '86400', 08:44:58 INFO - 'USER': 'cltbld', 08:44:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011', 08:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:58 INFO - '_': '/tools/buildbot/bin/python'} 08:44:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:44:58 INFO - mozversion application_buildid: 20170109152247 08:44:58 INFO - mozversion application_changeset: eefd48f36d82304bd1a4bb8626b29ef5ee54bb80 08:44:58 INFO - mozversion application_display_name: Nightly 08:44:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:44:58 INFO - mozversion application_name: Firefox 08:44:58 INFO - mozversion application_remotingname: firefox 08:44:58 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 08:44:58 INFO - mozversion application_vendor: Mozilla 08:44:58 INFO - mozversion application_version: 53.0a1 08:44:58 INFO - mozversion platform_buildid: 20170109152247 08:44:58 INFO - mozversion platform_changeset: eefd48f36d82304bd1a4bb8626b29ef5ee54bb80 08:44:58 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 08:44:58 INFO - mozversion platform_version: 53.0a1 08:44:58 INFO - using testdate: 1483980298 08:44:58 INFO - actual date: 1483980298 08:44:58 INFO - starting webserver on 'localhost:35481' 08:44:58 INFO - SUITE-START | Running 2 tests 08:44:58 INFO - TEST-START | dromaeo_css 08:44:58 INFO - operating with platform_type : linux_ 08:44:58 INFO - Initialising browser for dromaeo_css test... 08:44:58 INFO - TEST-INFO | started process 1554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0WT_lv/profile http://localhost:35481/getInfo.html) 08:44:58 INFO - PROCESS | 1554 | 1483980298804 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 08:45:02 INFO - PROCESS | 1554 | __metrics Screen width/height:1600/1200 08:45:02 INFO - PROCESS | 1554 | colorDepth:24 08:45:02 INFO - PROCESS | 1554 | Browser inner width/height: 1024/697 08:45:02 INFO - PROCESS | 1554 | __metrics 08:45:03 INFO - PROCESS | 1554 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:45:03 INFO - PROCESS | 1554 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:45:04 INFO - PROCESS | 1554 | console.error: PushService: 08:45:04 INFO - PROCESS | 1554 | stateChangeProcessEnqueue: Error transitioning state 08:45:04 INFO - PROCESS | 1554 | UnknownError 08:45:04 INFO - TEST-INFO | 1554: exit 0 08:45:04 INFO - Browser initialized. 08:45:04 INFO - Running cycle 1/1 for dromaeo_css test... 08:45:04 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0WT_lv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:45:16 INFO - PROCESS | 1642 | RSS: Main: 152817664 08:45:16 INFO - PROCESS | 1642 | 08:48:22 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:35481/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35481/tests/dromaeo/cssquery-ext.html) 08:48:23 INFO - PROCESS | 1642 | RSS: Main: 254525440 08:48:23 INFO - PROCESS | 1642 | 08:50:05 INFO - PROCESS | 1642 | ************************* 08:50:05 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 08:50:05 INFO - PROCESS | 1642 | 08:50:05 INFO - PROCESS | 1642 | Full message: ReferenceError: fetch is not defined 08:50:05 INFO - PROCESS | 1642 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 08:50:05 INFO - PROCESS | 1642 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 08:50:05 INFO - PROCESS | 1642 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 08:50:05 INFO - PROCESS | 1642 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:50:05 INFO - PROCESS | 1642 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:50:05 INFO - PROCESS | 1642 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:50:05 INFO - PROCESS | 1642 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 08:50:05 INFO - PROCESS | 1642 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:50:05 INFO - PROCESS | 1642 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:50:05 INFO - PROCESS | 1642 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:50:05 INFO - PROCESS | 1642 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 08:50:05 INFO - PROCESS | 1642 | 08:50:05 INFO - PROCESS | 1642 | ************************* 08:51:26 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:35481/tests/dromaeo/cssquery-ext.html (next: http://localhost:35481/tests/dromaeo/cssquery-jquery.html) 08:51:26 INFO - PROCESS | 1642 | RSS: Main: 242892800 08:51:26 INFO - PROCESS | 1642 | 08:54:29 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:35481/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35481/tests/dromaeo/cssquery-mootools.html) 08:54:29 INFO - PROCESS | 1642 | RSS: Main: 184573952 08:54:29 INFO - PROCESS | 1642 | 08:57:32 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:35481/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35481/tests/dromaeo/cssquery-prototype.html) 08:57:32 INFO - PROCESS | 1642 | RSS: Main: 184365056 08:57:32 INFO - PROCESS | 1642 | 09:00:36 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:35481/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35481/tests/dromaeo/cssquery-yui.html) 09:00:36 INFO - PROCESS | 1642 | RSS: Main: 184926208 09:00:36 INFO - PROCESS | 1642 | 09:03:39 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:35481/tests/dromaeo/cssquery-yui.html (next: http://localhost:35481/tests/dromaeo/cssquery-dojo.html) 09:03:39 INFO - PROCESS | 1642 | RSS: Main: 283541504 09:03:39 INFO - PROCESS | 1642 | 09:03:39 INFO - PROCESS | 1642 | __start_tp_report 09:03:39 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 09:03:39 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 09:03:39 INFO - PROCESS | 1642 | |i|pagename|runs| 09:03:39 INFO - PROCESS | 1642 | |0;dojo.html;2589.119699302237;2603.5704108822047;2624.8687565621713;2646.37810114623;2648.801339899508;4704.317873908281;4776.211925032366;4829.78265978031;4848.442429120648;4852.563269305761;4760.214564596846;4813.278008298748;4816.795801049738;4845.6365772567115;4889.413270407547;4367.934480982788;4400.427944367244;4438.600525952664;4494.640428765691;4556.384888040106;4073.775942323171;4417.977910110461;4501.482329532113;4572.839950601713;4588.816447342102;4357.9128417431475;4444.955550444486;4462.576055274743;4468.82124715011;4564.064366804813;4306.483222013347;4309.245881970643;4377.321515165155;4392.670549708785;4411.073674528353;4396.758178300192;4406.493253275882;4444.400005999181;4448.310511870665;4457.531959144308;4766.690165139289;4792.688475249098;4815.542523460265;4817.7591120444185;4860.854174374775;5058.0895438821;5103.413107492612;5170.405403378584;5170.922436163461;5174.43081261061;5025.396952365703;5084.008618319429;5105;5165.9225111623355;5194.454582268883;4780.617550595944;4782.402199725035;4784.210605250164;4785.114753770564;4825.4933232010835;5218.191180367049;5220.608454365938;5222.294990176353;5224.817131400383;5273.841784746463;4979.178435558165;5020.046191223656;5027.723475208825;5036.11867923112;5082.923756143661;5021.573166280907;5113.667611605234;5183.870403239949;5229.111051121318;5239.135542635422;5076.314697515862;5084.084864724385;5091.847244582668;5157.303763991813;5221.164613661796;5184.351956005499;5186.377634683862;5186.429492755794;5192.506711862367;5219.817306394334;4256.404103425523;4307.052448461333;4377.190219809282;4388.210122177975;4428.512863585003;3675.6691897728797;3710.962890371116;3724.571674257441;3745.831437585315;3771.321162190777;4329.870103896888;4338.240807858675;4341.110072435144;4361.062371590124;4371.235033869124;5034.119029169954;5146.974265128725;5148.845534633967;5155.639105262596;5157.6647517911215;4294.957050429518;4327;4379.5401482843845;4385.320275357325;4442.600165985077;4560.566746159176;4583.885402864888;4585.541445855454;4586.908261834745;4622.884427889262;4902.362692849978;4905.435874874435;4908.337374454403;4914.877128071684;4952.851414457428;5081.212412076134;5121.513456221653;5145.897082058413;5157.6647517911215;5159.948400516097;4854.466008738966;4878.048780487771;4882.2920676501;4920.40955085392;4922.1140194765285;5113.3097031900215;5119.974400127976;5120.180771076759;5121.641485096007;5125.923111153261;5076.060928728197;5101.9489805101475;5118.872028199325;5132.640715150053;5139.357580302462;5003.474635163256;5030.57240134578;5045.293658887832;5053.469385714594;5084.8220312288895;4866.05112003156;5022.171341728574;5029.0947629427055;5033.622478314068;5064.873378165576;4832.661713680009;4853.587445067067;4865.854024379274;4878.243872199815;4920.5571498565305;5022.121128802518;5029.798808047637;5035.496450354935;5037.92443113361;5079.949200507947;4917.704937703749;4922.261660750916;4925.064237794808;4926.655134140576;4953.826616068421 09:03:39 INFO - PROCESS | 1642 | |1;ext.html;500.5120007992207;503.1873524258324;522.5010115339851;523.2569750953645;531.779311585692;29274.560881586767;42811.571884281184;45277.99999999992;45323.866903327435;45430;41557.37663935036;41937.161256774925;41938.580614193925;41962.58037419625;42041.15917681644;7577.24227577242;7615;7747.380209583248;7758.379329653614;7759.379249660042;7592.620368981557;9864.802703945918;10117.089461948422;10124.240681948846;10493.895061049368;10112.443815590139;10165.085142337188;10172.59309627614;10181.847272290921;10190.388576685422;10044.397336159855;10123.848142277871;10133.847992280122;10136.290459667825;10137;9388;9456.290778191595;9458.810823783486;9470.384425012353;9471.621135154586;38933.22133557313;39252.21495570073;39268.21463570741;39268.60731392678;39322.21355572901;3648.7445878788494;3747.662710356081;3762.755420897633;3789.109559253573;3794.1842503861526;29067.85466072677;29089;29373.412531749458;29622.70377296221;29785.25536861574;3408.301298233881;3417.179876829568;3457.861685532576;3535.805530695811;3613.439916812898;176126;176150;176842;177026;177366.99999999872;46964.76517617459;47062.52937470582;47097.76451117791;47126;47158.1052368454;57280.42719572751;57332.426675732706;57391.42608573861;57512.712436438385;57532.13701794476;13531;13693.931530342285;13695.726085478234;13723.313834308245;13728.588142355746;9287.535623218811;9642.758931026781;10303.433311167808;10418.635347762793;10503.737406564744;16418.014919104655;16498.092604906604;16513.587160320847;16521.17394130313;16772.832271677373;6122.071547462535;6153.815385538441;6217.96891015542;6230.688465576703;6243.968780156161;815.355868863603;820.9958950205211;821.0475848016273;832.8917240758663;846.9830603387898;26619.46761064768;27755.420355641498;27885.425862473257;27913;28340.71659283422;978.3974627490841;980.6518685866557;981.5435822342645;987.7876256604865;1012.8936461671418;12212.32832194238;13267.270300133392;13365.532206372925;13384.263865487492;13663.453461861414;351488;351960;353440;353598;353600;44505.33242001373;44583.777081114386;44687.743715879806;44715;44770;1227.0674287541533;1249.5938819883575;1283.2044132637825;1289.6840274132896;1291;24069.60124700563;24397.507582684768;25458.363540911625;25827.741722583287;25923.889133304125;37302.8134859324;37322.626773731914;37644.62355376411;37696.2460750778;37711.434328484545;283202;284329;284692;285087;286090;19794.307199247956;20307.59384812325;21633.567328653655;23384.6492302619;23860.284191474282;33734;35959;36547.63452365442;36893.63106368902;37010.8149459251;30785;31052.844735776176;31069.22326941754;31140.844295779283;32268;30725;31045.534316985715;31187.688123118478;31476.527852082694;32215.838920805247;29876.850615746782;30806.845965770026;30827.69172308338;30962;30979;26347.20958371252;28270.575941360486;28296.575551366335;28387.290317742223;28403.43193136167;21593;21841.890790545945;22173.889130554246;22299.88850055804;22400.77599223987 09:03:39 INFO - PROCESS | 1642 | |2;jquery.html;342.90398688367236;362.6246834526264;372.1737742212289;373.49391574416666;399.65629558579616;13444;16995.57511062224;18154.72767908481;19198.808011919875;19385.806141938578;18435.944092299673;18591.628167436676;18672.253109875623;18786.342478013274;18806;4882.536159064892;5151.922721159186;5153.56194723449;5157.510036546522;5162.22566615007;3926.9410958835642;4033.7378070425475;5060.721660308682;5117.232415137722;5121.564667003309;5670.631408958425;5929.495992840592;5950.226470558821;6051.818445446622;6054.697265136748;5838.2118414013985;5930.911036334458;5999.520038396918;6042.909356359658;6067.1202675611785;5266.578673706094;5266.789328426858;5272.420033796279;5279.788808447696;5321.813736519203;21891.452713682127;21896.89051554732;21927.890360548095;22009.779902200935;22148;2051.415346626219;2182.879941603211;2200.19692812124;2219.9001044953015;2378.3578433822945;9327.860082098774;9371.062893710643;9516.33385662997;9568.378055426445;15018.399264029425;1824.6168304655905;1890.3761758619623;1891.9716204256947;1913.8277555019977;1916.3675986924281;74615;95267.04732952651;96647.51676241645;96951;97646.51176744071;16957.745633815503;17947.282108715506;18361.3573524926;18428.8535079606;18717.532061698566;33755.662443375746;33927.4910876337;34061.659383406346;34141;34296.48555271673;8581.656733730706;8826.55867206637;8873.378863479624;8981.14679105484;9096.772580685536;7068.71725130989;7177;7319.743808966767;7323.157836848724;7346.045014148127;9471.242300616072;9518.286128540387;9658.951705241569;9660.913624416573;9801.754956126153;3580.8906496204727;3698.815059247027;3938.625830546151;4021.1756589899;4075.7146999709735;963.3882484622176;996.4967691315984;999.1157825324494;1001.9098281154731;1011.4437059617181;18049.278028878696;18165.27338906429;18196.45410637683;18262.634747305245;18814.247430102918;977.1059480575336;982.3025651787311;984.1634610580949;989.1789814453986;992.4690290694443;9814.460204688668;9935.950320248352;10052.246081543768;10255.435951022617;10274.178065754722;484175;489040;508201;530368;530557;91514.08485915055;91518;91611.54194228986;92588.53705731429;95011.52494237623;952.8523078922778;955.9569819358146;983.1397527163732;988.545269176187;991.7471044883653;15466.370716977915;15503.069815811088;16105.436309729103;16240.72383824768;16361.918190408971;39223.41164882472;39272.21455570815;39292.41061384024;39443.80278098591;40115.398269025405;49506.504934950186;53516.46483535115;53857.46142538524;54127;55710.442895572145;7367.852642947219;7663.846723065396;7764.689412423666;7802.375809935078;8241.217084376975;11233.213675042669;12099.818502722643;12825.615231543068;12831.165974211646;12848.100632955604;9071.863922041042;9358.719238422858;9392.624295028396;9742.07450292221;10144.391336519833;9893.109620134222;10249.282550221711;10568.89431105679;10705.090067344363;11618.70953226176;9563;9794.804103918024;9883.209343252667;10453.738656533647;11006.559737610727;7388.4828062037295;7497.475176737576;7515.962420187864;7649.6557654904545;7890.408219383684;7742.922570774445;9421.199198068241;9742.61029558838;9893.91166971647;10761.730956726144 09:03:39 INFO - PROCESS | 1642 | |3;mootools.html;1336.8796808287254;1339.2567125245484;1353.5397964692006;1362.9795553066713;1363.154843996722;6828.351306625869;7208.387287080592;7222.386097181746;7237.240089790568;7253.057102576658;6432.77485288015;6595;6671.633060181688;6873.278305777896;7123.145222573298;2062.030845502615;2095.0048726854775;2099.0973881231066;2109.4093653776968;2117.4071260047212;2080.9796095573106;2115.21736957326;2116.2698868890207;2119.6714509251015;2126.25581046634;1865.2632210276931;1924.874883132592;2050.2721533855492;2086.5618220173706;2133.1254185783832;2083.0418007716466;2090.843186760984;2106.4207342980726;2109.778473260301;2114.175471566075;2054.445299769069;2070.5444802143506;2081.5212501124674;2084.6247675418417;2089.0912453082956;7164.498485106044;7191.928080719178;7247;7262.419006479469;7313.744018959311;4470.083632855257;4548.545145485458;4578.381918441001;4590.334401511762;4595.954040459586;2672.8529930853797;2804.467151241258;2812.8734206960735;2818.5631227159824;2844.1894060192744;974.8147851908114;999.8950110238466;1017.4759998600726;1059.8622179116664;1064.8136576099153;9404.858927116098;9442.575084121163;9505.952470237673;9524.761880952963;9561.521923903778;3808.333541630259;4053.61490658387;4058.289799285172;4102.733322334038;4114.280000999813;8205.71280005197;8271.669133234604;8274.338052955749;8275.8344833103;8299.626516806758;4557.043020965568;4582.060677561092;4585.72485650862;4606.746628935441;4607.447106347193;3713.1088538750505;3854.7879866607605;4013.337799263147;4198.118395137056;4213.304804707251;3294.8682052717622;3311.4867195584725;3430.3653824042135;3479.8608055677996;3541.805200713934;1152.2683096233952;1179.1097721220594;1198.964031079069;1203.1577895473204;1203.5667159822458;667.9532432729662;682.2870100744634;691.9273476285018;693.3932808792307;784.2353705137559;4631.536846315409;4750.857474275777;4782.258749893772;4798.2802579612635;4858.7570621469495;913.2009491694768;914.3188324698142;914.7392992996964;939.3659279985982;950.3110245072268;3384.9506652937666;3469.115375579211;3476.443768996948;3496.9650303497147;3571.767835090711;8344.290735287568;8647.740567782977;8707.564621768886;8766.254868336135;8826.779330516789;8132.268095871282;8281.8343633127;8329.708460203863;8745.956270218609;8756.299496040301;6674.899876501856;6770.289119642465;6780.830479238059;6812.62530560814;6839.863202736017;4760.16697078003;4940.580050695731;4979.427365852974;5088.516590923857;5325.307709997675;7861.095973963067;7876.84246315082;7883.487573307717;7926.643301051582;7971.163027882221;7784.88322675149;7971.3224375926375;8005.479643823133;8049.436539442183;8199.590020498832;5799.2750906136735;6012.9098063529955;6321.589096708699;6447.129637498878;6461.06314584392;6623.701933412912;6775.898361524482;6813.080234168324;6982.860342793014;7012.789616311519;6210.534209934182;6272.18461599989;6328.746850126127;6413.134226879311;6471.320511346241;6220.160278362363;6239.594426362272;6258;6267.2165979252595;6274.435300822948;5542.0855558832345;5660.32076150848;5665.773369065191;5667.121596152603;5667.8866422672145;4279.828806847816;4288;4327.783610819383;4394.252976993983;4443.977780111208;4377.956220437755;4479.1265703188865;4525.049739554599;4536.88657783558;4538.069695712305 09:03:39 INFO - PROCESS | 1642 | |4;prototype.html;351.0889242415931;352.6598924088463;353.3480728056735;354.11647938393713;361.340553489881;4788.688735232212;4835.395575553056;4841.668541151181;4856.684315519488;4879.39007624047;4803.423589169296;4822.831200907969;4840.071756587258;4845.563899249067;4846.515348465152;3670.376036073867;3776.924461510768;3794.392897136459;3809.4857194278693;3823.6941044716355;3848.345781217186;3854.807259637007;3858.884233472986;3867.245887052026;3880.6507414332705;3819.427085937104;3833.195029043904;3833.3291673957087;3841.5390153181656;3854;3674.963250367489;3733.4773131761576;3742.232842267356;3829.5213098362706;3847.153626202231;3430;3448.1897253738125;3452.7583069185166;3460.809655468948;3473.166440054394;4768.785404656799;4774.785134668949;4778.586813659114;4782.306565547976;4798.424189097295;4275.20908631901;4393.6704747144095;4415.271480205763;4453.532379100213;4472.84345047925;4948.579370753454;5043.773030213649;5057.418396884369;5070.974645126787;5072.54347108762;3777;3780.7353485256044;3784.299904517673;3798.9810050949845;3803.5245594300713;5127.282180494733;5344.7862085516535;5354.651947623431;5357.624696441217;5362.731863406814;3814.8664796731982;3863.32391831434;3870.4000879863665;3880.1851611161974;3894.123822139996;3950.2692001979726;3950.6246906543834;3968.1666849961252;3970.332460366653;3976.6421022108148;4387.736735795798;4401.515833258339;4403.295472724349;4448.599626033672;4468.687191896601;4874.707517548958;5060.773259765691;5096.668716533413;5102.4897510248675;5108.489151084936;1227.3617718786181;1233.3226811536304;1241.931693756834;1246.1277106025818;1253.9184952978028;822.6668199379261;855.8459477294023;860.4966094834467;863.8272345530919;872.2629378175432;4248.893777655521;4274.679399045084;4360.542143074995;4386;4390.934135987963;5181.35233095863;5195.168772996378;5196.272521846944;5199.584033277329;5211.635185536976;4367.912641747211;4394.868153955386;4399.868003959887;4412.426384569985;4418.513963464016;2600.8049396295355;2642.286582622681;2673.7326267373105;2680.5577079782006;2684.6442546513886;4743.454502732161;4749.2876068589985;4754.195024935305;4760.215274064711;4787.941185290359;5169.844904652867;5177.8187763428095;5183.585313174937;5185.818496352609;5188.5330320270605;4635.814567417266;4896.755162241873;4929.8661307898665;4936.456989731127;4971.4282857471135;5163.850051468526;5231.215317702375;5259;5276.366835979707;5277.8416647500635;4902.436219834764;5183.248428977702;5185.325907632135;5187;5193;4882.218844984785;4900.607951363953;4919.188333925005;4923.852284431473;4927.482614325444;3902.1610353774076;3905.3556163232747;3934.842606295716;3935.2523020627136;3950.58518855516;5053.8736531587;5271.156614941591;5271.736413179249;5280.867978300574;5294.2852714883;5049.823256186016;5058;5062.848114556569;5073.59411247092;5082.771275292695;5040.420351659606;5045.974770126126;5047.116754568009;5088.193691239557;5102.846914592568;4710.526973339024;4945.307656928105;4952;4954.479779623088;4987.600991920565;4877.707337559757;4988.176950803077;5082.491750824888;5114.4629813869005;5135.6405051646025;4855.470526784193;4983.632774432116;4983.775730092227;4992.450830408725;5005.62457815658 09:03:39 INFO - PROCESS | 1642 | |5;yui.html;659.4592434203948;665.0987911380083;730.3901242462543;761.0980987529775;779.8752199648055;12447.564335248268;12918.870811291885;13021.15362501438;13084.542041028566;13091.60725178245;12612.81080783789;12632;12645.747085058294;12648.05139614528;12694.682632934158;635.4090695653041;667.3993405934649;773.8220209351853;792.385900926782;810.623060276971;817.9263866252036;818.5743413425015;820.9671613135467;821.0270829067545;821.1747194069981;866.6273502393968;868.3791089371099;868.5570359116833;868.6481974800216;868.6612221233723;675.9594424334531;704.1901812915137;704.2499737779249;704.63359053292;866.0646501778097;593.2613895699882;624.9031400132986;628.0108828594936;631.43171145969;633.8193614819754;13252.801207981887;13278.867211327859;13311.73376532464;13322.333883305795;13322.60032199026;11093.667189984313;11121.05471034963;11452.885471145266;11629.24409913353;11877;12118;12257.509699612005;12327.321997290146;12364.505419783198;12507.74984500314;4035.2534781065597;4051.858184963512;4128.236276288866;4147.8963025924295;4235.0682849773;59944;60163;60415.39584604186;60876;62031.68984155096;9694.709158725249;9758.512074396253;9789.923108458064;9920;9964.451955142391;18154.546136346697;18462.44612661622;18502.44492665222;18519.166637501345;18543.72184417235;6735.4274886635185;6741.292164322774;6743.561668491532;6989.720411183495;7018.438524917994;3664.7984360859878;3704.4628528863163;3785.3186426443503;3789.810509474515;3804.771713697187;2925.312551550384;2988.686187950234;3005.9248518786767;3022.788404811686;3031.257341951236;502.550217555286;507.55588859747724;513.876669599301;514.007964628271;516.917293233081;598.1715324275822;622.7678349366772;630.9085182648582;635.2313700422541;636.3763511758502;8664.696735614223;8883.64465421389;9090.181883630505;9152.31357648179;9267.304952128483;614.4623454477332;628.6259675493075;644.8549076457759;645.7578408096964;654.1365397675023;4201.663866890642;4260.936085958713;4298.613124818781;4307.203167414038;4361.978190109029;59393;62300.688496557224;62930;63026.36973630205;63856;57965.710171448874;58093;58186.418135818945;58354.416455835744;58669;52124;52409.47590524122;52647.999999999236;53377;53679;7914.960425198067;8151.388645851704;8206.548639824628;8216.958915205625;8342.29090527312;34458;34660.48009279813;34890.47664284987;35437.291254174255;35561.288774224886;42791.3581296287;42940.570594293655;43780.12439751251;44392.334114988946;45731.77134114308;10072.236337368662;10153.543090560795;10195.541200645841;10320.638777642747;10484.475776211311;11373.090152787923;11488.138389620644;11688.649340519798;11728;11786.931988116392;10027.29808913369;10056.446895420822;10150.187984961038;10791.946040269748;13272.070955033056;12197.817032744693;12557;12809.551665691655;12949.223046617233;12954.805677915027;11857.16999810005;11902.642920712393;12018;12222.327771972627;12347.506099755909;10484.737881553023;10673.35959842412;10848.67453976382;11040.282381645167;11201.103911687209;10698.83951740709;10796.244262901522;11067.169962252703;11088.223824332543;11118.944405277922 09:03:39 INFO - PROCESS | 1642 | __end_tp_report 09:03:39 INFO - PROCESS | 1642 | __start_cc_report 09:03:39 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1105 09:03:39 INFO - PROCESS | 1642 | __end_cc_report 09:03:39 INFO - PROCESS | 1642 | __startTimestamp1483981419819__endTimestamp 09:03:39 INFO - PROCESS | 1642 | 09:03:39 INFO - PROCESS | 1642 | ------- Summary: start ------- 09:03:39 INFO - PROCESS | 1642 | Number of tests: 6 09:03:39 INFO - PROCESS | 1642 | 09:03:39 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:4743.76 Median:4889.41 stddev:514.65 (10.5%) stddev-sans-first:487.68 09:03:39 INFO - PROCESS | 1642 | Values: 2589.1 2603.6 2624.9 2646.4 2648.8 4704.3 4776.2 4829.8 4848.4 4852.6 4760.2 4813.3 4816.8 4845.6 4889.4 4367.9 4400.4 4438.6 4494.6 4556.4 4073.8 4418.0 4501.5 4572.8 4588.8 4357.9 4445.0 4462.6 4468.8 4564.1 4306.5 4309.2 4377.3 4392.7 4411.1 4396.8 4406.5 4444.4 4448.3 4457.5 4766.7 4792.7 4815.5 4817.8 4860.9 5058.1 5103.4 5170.4 5170.9 5174.4 5025.4 5084.0 5105.0 5165.9 5194.5 4780.6 4782.4 4784.2 4785.1 4825.5 5218.2 5220.6 5222.3 5224.8 5273.8 4979.2 5020.0 5027.7 5036.1 5082.9 5021.6 5113.7 5183.9 5229.1 5239.1 5076.3 5084.1 5091.8 5157.3 5221.2 5184.4 5186.4 5186.4 5192.5 5219.8 4256.4 4307.1 4377.2 4388.2 4428.5 3675.7 3711.0 3724.6 3745.8 3771.3 4329.9 4338.2 4341.1 4361.1 4371.2 5034.1 5147.0 5148.8 5155.6 5157.7 4295.0 4327.0 4379.5 4385.3 4442.6 4560.6 4583.9 4585.5 4586.9 4622.9 4902.4 4905.4 4908.3 4914.9 4952.9 5081.2 5121.5 5145.9 5157.7 5159.9 4854.5 4878.0 4882.3 4920.4 4922.1 5113.3 5120.0 5120.2 5121.6 5125.9 5076.1 5101.9 5118.9 5132.6 5139.4 5003.5 5030.6 5045.3 5053.5 5084.8 4866.1 5022.2 5029.1 5033.6 5064.9 4832.7 4853.6 4865.9 4878.2 4920.6 5022.1 5029.8 5035.5 5037.9 5079.9 4917.7 4922.3 4925.1 4926.7 4953.8 09:03:39 INFO - PROCESS | 1642 | 09:03:39 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:42345.91 Median:31846.18 stddev:73923.45 (232.1%) stddev-sans-first:74064.05 09:03:39 INFO - PROCESS | 1642 | Values: 500.5 503.2 522.5 523.3 531.8 29274.6 42811.6 45278.0 45323.9 45430.0 41557.4 41937.2 41938.6 41962.6 42041.2 7577.2 7615.0 7747.4 7758.4 7759.4 7592.6 9864.8 10117.1 10124.2 10493.9 10112.4 10165.1 10172.6 10181.8 10190.4 10044.4 10123.8 10133.8 10136.3 10137.0 9388.0 9456.3 9458.8 9470.4 9471.6 38933.2 39252.2 39268.2 39268.6 39322.2 3648.7 3747.7 3762.8 3789.1 3794.2 29067.9 29089.0 29373.4 29622.7 29785.3 3408.3 3417.2 3457.9 3535.8 3613.4 176126.0 176150.0 176842.0 177026.0 177367.0 46964.8 47062.5 47097.8 47126.0 47158.1 57280.4 57332.4 57391.4 57512.7 57532.1 13531.0 13693.9 13695.7 13723.3 13728.6 9287.5 9642.8 10303.4 10418.6 10503.7 16418.0 16498.1 16513.6 16521.2 16772.8 6122.1 6153.8 6218.0 6230.7 6244.0 815.4 821.0 821.0 832.9 847.0 26619.5 27755.4 27885.4 27913.0 28340.7 978.4 980.7 981.5 987.8 1012.9 12212.3 13267.3 13365.5 13384.3 13663.5 351488.0 351960.0 353440.0 353598.0 353600.0 44505.3 44583.8 44687.7 44715.0 44770.0 1227.1 1249.6 1283.2 1289.7 1291.0 24069.6 24397.5 25458.4 25827.7 25923.9 37302.8 37322.6 37644.6 37696.2 37711.4 283202.0 284329.0 284692.0 285087.0 286090.0 19794.3 20307.6 21633.6 23384.6 23860.3 33734.0 35959.0 36547.6 36893.6 37010.8 30785.0 31052.8 31069.2 31140.8 32268.0 30725.0 31045.5 31187.7 31476.5 32215.8 29876.9 30806.8 30827.7 30962.0 30979.0 26347.2 28270.6 28296.6 28387.3 28403.4 21593.0 21841.9 22173.9 22299.9 22400.8 09:03:39 INFO - PROCESS | 1642 | 09:03:39 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:30069.26 Median:5155.54 stddev:83968.72 (1628.7%) stddev-sans-first:84174.61 09:03:39 INFO - PROCESS | 1642 | Values: 342.9 362.6 372.2 373.5 399.7 13444.0 16995.6 18154.7 19198.8 19385.8 18435.9 18591.6 18672.3 18786.3 18806.0 4882.5 5151.9 5153.6 5157.5 5162.2 3926.9 4033.7 5060.7 5117.2 5121.6 5670.6 5929.5 5950.2 6051.8 6054.7 5838.2 5930.9 5999.5 6042.9 6067.1 5266.6 5266.8 5272.4 5279.8 5321.8 21891.5 21896.9 21927.9 22009.8 22148.0 2051.4 2182.9 2200.2 2219.9 2378.4 9327.9 9371.1 9516.3 9568.4 15018.4 1824.6 1890.4 1892.0 1913.8 1916.4 74615.0 95267.0 96647.5 96951.0 97646.5 16957.7 17947.3 18361.4 18428.9 18717.5 33755.7 33927.5 34061.7 34141.0 34296.5 8581.7 8826.6 8873.4 8981.1 9096.8 7068.7 7177.0 7319.7 7323.2 7346.0 9471.2 9518.3 9659.0 9660.9 9801.8 3580.9 3698.8 3938.6 4021.2 4075.7 963.4 996.5 999.1 1001.9 1011.4 18049.3 18165.3 18196.5 18262.6 18814.2 977.1 982.3 984.2 989.2 992.5 9814.5 9936.0 10052.2 10255.4 10274.2 484175.0 489040.0 508201.0 530368.0 530557.0 91514.1 91518.0 91611.5 92588.5 95011.5 952.9 956.0 983.1 988.5 991.7 15466.4 15503.1 16105.4 16240.7 16361.9 39223.4 39272.2 39292.4 39443.8 40115.4 49506.5 53516.5 53857.5 54127.0 55710.4 7367.9 7663.8 7764.7 7802.4 8241.2 11233.2 12099.8 12825.6 12831.2 12848.1 9071.9 9358.7 9392.6 9742.1 10144.4 9893.1 10249.3 10568.9 10705.1 11618.7 9563.0 9794.8 9883.2 10453.7 11006.6 7388.5 7497.5 7516.0 7649.7 7890.4 7742.9 9421.2 9742.6 9893.9 10761.7 09:03:39 INFO - PROCESS | 1642 | 09:03:39 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:4750.36 Median:5033.97 stddev:2536.26 (50.4%) stddev-sans-first:2530.40 09:03:39 INFO - PROCESS | 1642 | Values: 1336.9 1339.3 1353.5 1363.0 1363.2 6828.4 7208.4 7222.4 7237.2 7253.1 6432.8 6595.0 6671.6 6873.3 7123.1 2062.0 2095.0 2099.1 2109.4 2117.4 2081.0 2115.2 2116.3 2119.7 2126.3 1865.3 1924.9 2050.3 2086.6 2133.1 2083.0 2090.8 2106.4 2109.8 2114.2 2054.4 2070.5 2081.5 2084.6 2089.1 7164.5 7191.9 7247.0 7262.4 7313.7 4470.1 4548.5 4578.4 4590.3 4596.0 2672.9 2804.5 2812.9 2818.6 2844.2 974.8 999.9 1017.5 1059.9 1064.8 9404.9 9442.6 9506.0 9524.8 9561.5 3808.3 4053.6 4058.3 4102.7 4114.3 8205.7 8271.7 8274.3 8275.8 8299.6 4557.0 4582.1 4585.7 4606.7 4607.4 3713.1 3854.8 4013.3 4198.1 4213.3 3294.9 3311.5 3430.4 3479.9 3541.8 1152.3 1179.1 1199.0 1203.2 1203.6 668.0 682.3 691.9 693.4 784.2 4631.5 4750.9 4782.3 4798.3 4858.8 913.2 914.3 914.7 939.4 950.3 3385.0 3469.1 3476.4 3497.0 3571.8 8344.3 8647.7 8707.6 8766.3 8826.8 8132.3 8281.8 8329.7 8746.0 8756.3 6674.9 6770.3 6780.8 6812.6 6839.9 4760.2 4940.6 4979.4 5088.5 5325.3 7861.1 7876.8 7883.5 7926.6 7971.2 7784.9 7971.3 8005.5 8049.4 8199.6 5799.3 6012.9 6321.6 6447.1 6461.1 6623.7 6775.9 6813.1 6982.9 7012.8 6210.5 6272.2 6328.7 6413.1 6471.3 6220.2 6239.6 6258.0 6267.2 6274.4 5542.1 5660.3 5665.8 5667.1 5667.9 4279.8 4288.0 4327.8 4394.3 4444.0 4378.0 4479.1 4525.0 4536.9 4538.1 09:03:39 INFO - PROCESS | 1642 | 09:03:39 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4231.03 Median:4788.31 stddev:1208.18 (25.2%) stddev-sans-first:1175.95 09:03:39 INFO - PROCESS | 1642 | Values: 351.1 352.7 353.3 354.1 361.3 4788.7 4835.4 4841.7 4856.7 4879.4 4803.4 4822.8 4840.1 4845.6 4846.5 3670.4 3776.9 3794.4 3809.5 3823.7 3848.3 3854.8 3858.9 3867.2 3880.7 3819.4 3833.2 3833.3 3841.5 3854.0 3675.0 3733.5 3742.2 3829.5 3847.2 3430.0 3448.2 3452.8 3460.8 3473.2 4768.8 4774.8 4778.6 4782.3 4798.4 4275.2 4393.7 4415.3 4453.5 4472.8 4948.6 5043.8 5057.4 5071.0 5072.5 3777.0 3780.7 3784.3 3799.0 3803.5 5127.3 5344.8 5354.7 5357.6 5362.7 3814.9 3863.3 3870.4 3880.2 3894.1 3950.3 3950.6 3968.2 3970.3 3976.6 4387.7 4401.5 4403.3 4448.6 4468.7 4874.7 5060.8 5096.7 5102.5 5108.5 1227.4 1233.3 1241.9 1246.1 1253.9 822.7 855.8 860.5 863.8 872.3 4248.9 4274.7 4360.5 4386.0 4390.9 5181.4 5195.2 5196.3 5199.6 5211.6 4367.9 4394.9 4399.9 4412.4 4418.5 2600.8 2642.3 2673.7 2680.6 2684.6 4743.5 4749.3 4754.2 4760.2 4787.9 5169.8 5177.8 5183.6 5185.8 5188.5 4635.8 4896.8 4929.9 4936.5 4971.4 5163.9 5231.2 5259.0 5276.4 5277.8 4902.4 5183.2 5185.3 5187.0 5193.0 4882.2 4900.6 4919.2 4923.9 4927.5 3902.2 3905.4 3934.8 3935.3 3950.6 5053.9 5271.2 5271.7 5280.9 5294.3 5049.8 5058.0 5062.8 5073.6 5082.8 5040.4 5046.0 5047.1 5088.2 5102.8 4710.5 4945.3 4952.0 4954.5 4987.6 4877.7 4988.2 5082.5 5114.5 5135.6 4855.5 4983.6 4983.8 4992.5 5005.6 09:03:39 INFO - PROCESS | 1642 | 09:03:39 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:14683.74 Median:4334.59 stddev:17947.96 (414.1%) stddev-sans-first:17967.41 09:03:39 INFO - PROCESS | 1642 | Values: 659.5 665.1 730.4 761.1 779.9 12447.6 12918.9 13021.2 13084.5 13091.6 12612.8 12632.0 12645.7 12648.1 12694.7 635.4 667.4 773.8 792.4 810.6 817.9 818.6 821.0 821.0 821.2 866.6 868.4 868.6 868.6 868.7 676.0 704.2 704.2 704.6 866.1 593.3 624.9 628.0 631.4 633.8 13252.8 13278.9 13311.7 13322.3 13322.6 11093.7 11121.1 11452.9 11629.2 11877.0 12118.0 12257.5 12327.3 12364.5 12507.7 4035.3 4051.9 4128.2 4147.9 4235.1 59944.0 60163.0 60415.4 60876.0 62031.7 9694.7 9758.5 9789.9 9920.0 9964.5 18154.5 18462.4 18502.4 18519.2 18543.7 6735.4 6741.3 6743.6 6989.7 7018.4 3664.8 3704.5 3785.3 3789.8 3804.8 2925.3 2988.7 3005.9 3022.8 3031.3 502.6 507.6 513.9 514.0 516.9 598.2 622.8 630.9 635.2 636.4 8664.7 8883.6 9090.2 9152.3 9267.3 614.5 628.6 644.9 645.8 654.1 4201.7 4260.9 4298.6 4307.2 4362.0 59393.0 62300.7 62930.0 63026.4 63856.0 57965.7 58093.0 58186.4 58354.4 58669.0 52124.0 52409.5 52648.0 53377.0 53679.0 7915.0 8151.4 8206.5 8217.0 8342.3 34458.0 34660.5 34890.5 35437.3 35561.3 42791.4 42940.6 43780.1 44392.3 45731.8 10072.2 10153.5 10195.5 10320.6 10484.5 11373.1 11488.1 11688.6 11728.0 11786.9 10027.3 10056.4 10150.2 10791.9 13272.1 12197.8 12557.0 12809.6 12949.2 12954.8 11857.2 11902.6 12018.0 12222.3 12347.5 10484.7 10673.4 10848.7 11040.3 11201.1 10698.8 10796.2 11067.2 11088.2 11118.9 09:03:39 INFO - PROCESS | 1642 | -------- Summary: end -------- 09:03:39 INFO - PROCESS | 1642 | 09:03:40 INFO - TEST-INFO | 1642: exit 0 09:03:40 INFO - TEST-OK | dromaeo_css | took 1122372ms 09:03:40 INFO - TEST-START | kraken 09:03:40 INFO - operating with platform_type : linux_ 09:03:40 INFO - Initialising browser for kraken test... 09:03:40 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfQEeLd/profile http://localhost:35481/getInfo.html) 09:03:41 INFO - PROCESS | 1939 | 1483981421159 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 09:03:44 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 09:03:44 INFO - PROCESS | 1939 | colorDepth:24 09:03:44 INFO - PROCESS | 1939 | Browser inner width/height: 1024/697 09:03:44 INFO - PROCESS | 1939 | __metrics 09:03:45 INFO - PROCESS | 1939 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:03:45 INFO - PROCESS | 1939 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:03:46 INFO - PROCESS | 1939 | console.error: PushService: 09:03:46 INFO - PROCESS | 1939 | stateChangeProcessEnqueue: Error transitioning state 09:03:46 INFO - PROCESS | 1939 | UnknownError 09:03:46 INFO - TEST-INFO | 1939: exit 0 09:03:46 INFO - Browser initialized. 09:03:46 INFO - Running cycle 1/1 for kraken test... 09:03:46 INFO - TEST-INFO | started process 2021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfQEeLd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:03:59 INFO - PROCESS | 2021 | RSS: Main: 152469504 09:03:59 INFO - PROCESS | 2021 | 09:04:01 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:35481/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35481/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:02 INFO - PROCESS | 2021 | RSS: Main: 206618624 09:04:02 INFO - PROCESS | 2021 | 09:04:05 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:35481/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35481/tests/kraken/driver.html?testName=audio-dft) 09:04:06 INFO - PROCESS | 2021 | RSS: Main: 186392576 09:04:06 INFO - PROCESS | 2021 | 09:04:09 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:35481/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35481/tests/kraken/driver.html?testName=audio-fft) 09:04:09 INFO - PROCESS | 2021 | RSS: Main: 268705792 09:04:09 INFO - PROCESS | 2021 | 09:04:12 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:35481/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35481/tests/kraken/driver.html?testName=audio-oscillator) 09:04:12 INFO - PROCESS | 2021 | RSS: Main: 179818496 09:04:12 INFO - PROCESS | 2021 | 09:04:14 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:35481/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35481/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:04:15 INFO - PROCESS | 2021 | RSS: Main: 183238656 09:04:15 INFO - PROCESS | 2021 | 09:04:18 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:35481/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35481/tests/kraken/driver.html?testName=imaging-darkroom) 09:04:19 INFO - PROCESS | 2021 | RSS: Main: 222162944 09:04:19 INFO - PROCESS | 2021 | 09:04:22 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:35481/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35481/tests/kraken/driver.html?testName=imaging-desaturate) 09:04:23 INFO - PROCESS | 2021 | RSS: Main: 222257152 09:04:23 INFO - PROCESS | 2021 | 09:04:26 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:35481/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35481/tests/kraken/driver.html?testName=json-parse-financial) 09:04:26 INFO - PROCESS | 2021 | RSS: Main: 220393472 09:04:26 INFO - PROCESS | 2021 | 09:04:28 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:35481/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35481/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:04:29 INFO - PROCESS | 2021 | RSS: Main: 182906880 09:04:29 INFO - PROCESS | 2021 | 09:04:31 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:35481/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35481/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:04:31 INFO - PROCESS | 2021 | RSS: Main: 190681088 09:04:31 INFO - PROCESS | 2021 | 09:04:33 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:35481/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35481/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:04:34 INFO - PROCESS | 2021 | RSS: Main: 199000064 09:04:34 INFO - PROCESS | 2021 | 09:04:37 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:35481/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:04:37 INFO - PROCESS | 2021 | RSS: Main: 208060416 09:04:37 INFO - PROCESS | 2021 | 09:04:40 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:35481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:04:41 INFO - PROCESS | 2021 | RSS: Main: 204443648 09:04:41 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:35481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35481/tests/kraken/driver.html?testName=ai-astar) 09:04:43 INFO - PROCESS | 2021 | RSS: Main: 256053248 09:04:43 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | __start_tp_report 09:04:43 INFO - PROCESS | 2021 | _x_x_mozilla_page_load 09:04:43 INFO - PROCESS | 2021 | _x_x_mozilla_page_load_details 09:04:43 INFO - PROCESS | 2021 | |i|pagename|runs| 09:04:43 INFO - PROCESS | 2021 | |0;ai-astar;114;114;116;117;116;116;115;115;114;115 09:04:43 INFO - PROCESS | 2021 | |1;audio-beat-detection;152;125;123;165;126;125;127;122;145;128 09:04:43 INFO - PROCESS | 2021 | |2;audio-dft;162;164;162;161;162;163;163;162;161;161 09:04:43 INFO - PROCESS | 2021 | |3;audio-fft;76;76;76;115;77;77;77;77;94;78 09:04:43 INFO - PROCESS | 2021 | |4;audio-oscillator;85;85;105;86;85;84;105;85;85;116 09:04:43 INFO - PROCESS | 2021 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;118;118 09:04:43 INFO - PROCESS | 2021 | |6;imaging-darkroom;148;150;150;149;148;150;150;150;149;149 09:04:43 INFO - PROCESS | 2021 | |7;imaging-desaturate;96;96;95;95;95;96;95;96;96;95 09:04:43 INFO - PROCESS | 2021 | |8;json-parse-financial;60;59;58;59;61;61;69;59;60;59 09:04:43 INFO - PROCESS | 2021 | |9;json-stringify-tinderbox;67;67;67;67;67;67;68;67;67;70 09:04:43 INFO - PROCESS | 2021 | |10;stanford-crypto-aes;96;86;94;85;85;94;89;85;87;85 09:04:43 INFO - PROCESS | 2021 | |11;stanford-crypto-ccm;144;139;138;136;139;132;131;131;174;132 09:04:43 INFO - PROCESS | 2021 | |12;stanford-crypto-pbkdf2;183;180;178;179;181;178;177;176;180;179 09:04:43 INFO - PROCESS | 2021 | |13;stanford-crypto-sha256-iterative;70;78;69;71;70;73;69;70;68;69 09:04:43 INFO - PROCESS | 2021 | __end_tp_report 09:04:43 INFO - PROCESS | 2021 | __start_cc_report 09:04:43 INFO - PROCESS | 2021 | _x_x_mozilla_cycle_collect,1853 09:04:43 INFO - PROCESS | 2021 | __end_cc_report 09:04:43 INFO - PROCESS | 2021 | __startTimestamp1483981483665__endTimestamp 09:04:43 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | ------- Summary: start ------- 09:04:43 INFO - PROCESS | 2021 | Number of tests: 14 09:04:43 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.50 stddev:1.03 (0.9%) stddev-sans-first:1.00 09:04:43 INFO - PROCESS | 2021 | Values: 114.0 114.0 116.0 117.0 116.0 116.0 115.0 115.0 114.0 115.0 09:04:43 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:127.50 stddev:14.84 (11.6%) stddev-sans-first:14.20 09:04:43 INFO - PROCESS | 2021 | Values: 152.0 125.0 123.0 165.0 126.0 125.0 127.0 122.0 145.0 128.0 09:04:43 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 09:04:43 INFO - PROCESS | 2021 | Values: 162.0 164.0 162.0 161.0 162.0 163.0 163.0 162.0 161.0 161.0 09:04:43 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | [#3] audio-fft Cycles:10 Average:82.30 Median:77.00 stddev:12.72 (16.5%) stddev-sans-first:13.29 09:04:43 INFO - PROCESS | 2021 | Values: 76.0 76.0 76.0 115.0 77.0 77.0 77.0 77.0 94.0 78.0 09:04:43 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:85.00 stddev:11.83 (13.9%) stddev-sans-first:12.26 09:04:43 INFO - PROCESS | 2021 | Values: 85.0 85.0 105.0 86.0 85.0 84.0 105.0 85.0 85.0 116.0 09:04:43 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:04:43 INFO - PROCESS | 2021 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 09:04:43 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:150.00 stddev:0.82 (0.5%) stddev-sans-first:0.73 09:04:43 INFO - PROCESS | 2021 | Values: 148.0 150.0 150.0 149.0 148.0 150.0 150.0 150.0 149.0 149.0 09:04:43 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:04:43 INFO - PROCESS | 2021 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 09:04:43 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:60.00 stddev:3.14 (5.2%) stddev-sans-first:3.32 09:04:43 INFO - PROCESS | 2021 | Values: 60.0 59.0 58.0 59.0 61.0 61.0 69.0 59.0 60.0 59.0 09:04:43 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 09:04:43 INFO - PROCESS | 2021 | Values: 67.0 67.0 67.0 67.0 67.0 67.0 68.0 67.0 67.0 70.0 09:04:43 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:88.00 stddev:4.40 (5.0%) stddev-sans-first:3.77 09:04:43 INFO - PROCESS | 2021 | Values: 96.0 86.0 94.0 85.0 85.0 94.0 89.0 85.0 87.0 85.0 09:04:43 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:138.50 stddev:12.83 (9.3%) stddev-sans-first:13.51 09:04:43 INFO - PROCESS | 2021 | Values: 144.0 139.0 138.0 136.0 139.0 132.0 131.0 131.0 174.0 132.0 09:04:43 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.10 Median:179.50 stddev:2.02 (1.1%) stddev-sans-first:1.58 09:04:43 INFO - PROCESS | 2021 | Values: 183.0 180.0 178.0 179.0 181.0 178.0 177.0 176.0 180.0 179.0 09:04:43 INFO - PROCESS | 2021 | 09:04:43 INFO - PROCESS | 2021 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.00 stddev:2.91 (4.2%) stddev-sans-first:3.07 09:04:43 INFO - PROCESS | 2021 | Values: 70.0 78.0 69.0 71.0 70.0 73.0 69.0 70.0 68.0 69.0 09:04:43 INFO - PROCESS | 2021 | -------- Summary: end -------- 09:04:43 INFO - PROCESS | 2021 | 09:04:44 INFO - TEST-INFO | 2021: exit 0 09:04:44 INFO - TEST-OK | kraken | took 64227ms 09:04:44 INFO - SUITE-END | took 1186s 09:04:45 INFO - Completed test suite (00:19:47) 09:04:45 INFO - javascript benchmark 09:04:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2589.119699302237, 2603.5704108822047, 2624.8687565621713, 2646.37810114623, 2648.801339899508, 4704.317873908281, 4776.211925032366, 4829.78265978031, 4848.442429120648, 4852.563269305761, 4760.214564596846, 4813.278008298748, 4816.795801049738, 4845.6365772567115, 4889.413270407547, 4367.934480982788, 4400.427944367244, 4438.600525952664, 4494.640428765691, 4556.384888040106, 4073.775942323171, 4417.977910110461, 4501.482329532113, 4572.839950601713, 4588.816447342102, 4357.9128417431475, 4444.955550444486, 4462.576055274743, 4468.82124715011, 4564.064366804813, 4306.483222013347, 4309.245881970643, 4377.321515165155, 4392.670549708785, 4411.073674528353, 4396.758178300192, 4406.493253275882, 4444.400005999181, 4448.310511870665, 4457.531959144308, 4766.690165139289, 4792.688475249098, 4815.542523460265, 4817.7591120444185, 4860.854174374775, 5058.0895438821, 5103.413107492612, 5170.405403378584, 5170.922436163461, 5174.43081261061, 5025.396952365703, 5084.008618319429, 5105.0, 5165.9225111623355, 5194.454582268883, 4780.617550595944, 4782.402199725035, 4784.210605250164, 4785.114753770564, 4825.4933232010835, 5218.191180367049, 5220.608454365938, 5222.294990176353, 5224.817131400383, 5273.841784746463, 4979.178435558165, 5020.046191223656, 5027.723475208825, 5036.11867923112, 5082.923756143661, 5021.573166280907, 5113.667611605234, 5183.870403239949, 5229.111051121318, 5239.135542635422, 5076.314697515862, 5084.084864724385, 5091.847244582668, 5157.303763991813, 5221.164613661796, 5184.351956005499, 5186.377634683862, 5186.429492755794, 5192.506711862367, 5219.817306394334, 4256.404103425523, 4307.052448461333, 4377.190219809282, 4388.210122177975, 4428.512863585003, 3675.6691897728797, 3710.962890371116, 3724.571674257441, 3745.831437585315, 3771.321162190777, 4329.870103896888, 4338.240807858675, 4341.110072435144, 4361.062371590124, 4371.235033869124, 5034.119029169954, 5146.974265128725, 5148.845534633967, 5155.639105262596, 5157.6647517911215, 4294.957050429518, 4327.0, 4379.5401482843845, 4385.320275357325, 4442.600165985077, 4560.566746159176, 4583.885402864888, 4585.541445855454, 4586.908261834745, 4622.884427889262, 4902.362692849978, 4905.435874874435, 4908.337374454403, 4914.877128071684, 4952.851414457428, 5081.212412076134, 5121.513456221653, 5145.897082058413, 5157.6647517911215, 5159.948400516097, 4854.466008738966, 4878.048780487771, 4882.2920676501, 4920.40955085392, 4922.1140194765285, 5113.3097031900215, 5119.974400127976, 5120.180771076759, 5121.641485096007, 5125.923111153261, 5076.060928728197, 5101.9489805101475, 5118.872028199325, 5132.640715150053, 5139.357580302462, 5003.474635163256, 5030.57240134578, 5045.293658887832, 5053.469385714594, 5084.8220312288895, 4866.05112003156, 5022.171341728574, 5029.0947629427055, 5033.622478314068, 5064.873378165576, 4832.661713680009, 4853.587445067067, 4865.854024379274, 4878.243872199815, 4920.5571498565305, 5022.121128802518, 5029.798808047637, 5035.496450354935, 5037.92443113361, 5079.949200507947, 4917.704937703749, 4922.261660750916, 4925.064237794808, 4926.655134140576, 4953.826616068421], "value": 4709.482072635507, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.5120007992207, 503.1873524258324, 522.5010115339851, 523.2569750953645, 531.779311585692, 29274.560881586767, 42811.571884281184, 45277.99999999992, 45323.866903327435, 45430.0, 41557.37663935036, 41937.161256774925, 41938.580614193925, 41962.58037419625, 42041.15917681644, 7577.24227577242, 7615.0, 7747.380209583248, 7758.379329653614, 7759.379249660042, 7592.620368981557, 9864.802703945918, 10117.089461948422, 10124.240681948846, 10493.895061049368, 10112.443815590139, 10165.085142337188, 10172.59309627614, 10181.847272290921, 10190.388576685422, 10044.397336159855, 10123.848142277871, 10133.847992280122, 10136.290459667825, 10137.0, 9388.0, 9456.290778191595, 9458.810823783486, 9470.384425012353, 9471.621135154586, 38933.22133557313, 39252.21495570073, 39268.21463570741, 39268.60731392678, 39322.21355572901, 3648.7445878788494, 3747.662710356081, 3762.755420897633, 3789.109559253573, 3794.1842503861526, 29067.85466072677, 29089.0, 29373.412531749458, 29622.70377296221, 29785.25536861574, 3408.301298233881, 3417.179876829568, 3457.861685532576, 3535.805530695811, 3613.439916812898, 176126.0, 176150.0, 176842.0, 177026.0, 177366.99999999872, 46964.76517617459, 47062.52937470582, 47097.76451117791, 47126.0, 47158.1052368454, 57280.42719572751, 57332.426675732706, 57391.42608573861, 57512.712436438385, 57532.13701794476, 13531.0, 13693.931530342285, 13695.726085478234, 13723.313834308245, 13728.588142355746, 9287.535623218811, 9642.758931026781, 10303.433311167808, 10418.635347762793, 10503.737406564744, 16418.014919104655, 16498.092604906604, 16513.587160320847, 16521.17394130313, 16772.832271677373, 6122.071547462535, 6153.815385538441, 6217.96891015542, 6230.688465576703, 6243.968780156161, 815.355868863603, 820.9958950205211, 821.0475848016273, 832.8917240758663, 846.9830603387898, 26619.46761064768, 27755.420355641498, 27885.425862473257, 27913.0, 28340.71659283422, 978.3974627490841, 980.6518685866557, 981.5435822342645, 987.7876256604865, 1012.8936461671418, 12212.32832194238, 13267.270300133392, 13365.532206372925, 13384.263865487492, 13663.453461861414, 351488.0, 351960.0, 353440.0, 353598.0, 353600.0, 44505.33242001373, 44583.777081114386, 44687.743715879806, 44715.0, 44770.0, 1227.0674287541533, 1249.5938819883575, 1283.2044132637825, 1289.6840274132896, 1291.0, 24069.60124700563, 24397.507582684768, 25458.363540911625, 25827.741722583287, 25923.889133304125, 37302.8134859324, 37322.626773731914, 37644.62355376411, 37696.2460750778, 37711.434328484545, 283202.0, 284329.0, 284692.0, 285087.0, 286090.0, 19794.307199247956, 20307.59384812325, 21633.567328653655, 23384.6492302619, 23860.284191474282, 33734.0, 35959.0, 36547.63452365442, 36893.63106368902, 37010.8149459251, 30785.0, 31052.844735776176, 31069.22326941754, 31140.844295779283, 32268.0, 30725.0, 31045.534316985715, 31187.688123118478, 31476.527852082694, 32215.838920805247, 29876.850615746782, 30806.845965770026, 30827.69172308338, 30962.0, 30979.0, 26347.20958371252, 28270.575941360486, 28296.575551366335, 28387.290317742223, 28403.43193136167, 21593.0, 21841.890790545945, 22173.889130554246, 22299.88850055804, 22400.77599223987], "value": 16880.838246945812, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.90398688367236, 362.6246834526264, 372.1737742212289, 373.49391574416666, 399.65629558579616, 13444.0, 16995.57511062224, 18154.72767908481, 19198.808011919875, 19385.806141938578, 18435.944092299673, 18591.628167436676, 18672.253109875623, 18786.342478013274, 18806.0, 4882.536159064892, 5151.922721159186, 5153.56194723449, 5157.510036546522, 5162.22566615007, 3926.9410958835642, 4033.7378070425475, 5060.721660308682, 5117.232415137722, 5121.564667003309, 5670.631408958425, 5929.495992840592, 5950.226470558821, 6051.818445446622, 6054.697265136748, 5838.2118414013985, 5930.911036334458, 5999.520038396918, 6042.909356359658, 6067.1202675611785, 5266.578673706094, 5266.789328426858, 5272.420033796279, 5279.788808447696, 5321.813736519203, 21891.452713682127, 21896.89051554732, 21927.890360548095, 22009.779902200935, 22148.0, 2051.415346626219, 2182.879941603211, 2200.19692812124, 2219.9001044953015, 2378.3578433822945, 9327.860082098774, 9371.062893710643, 9516.33385662997, 9568.378055426445, 15018.399264029425, 1824.6168304655905, 1890.3761758619623, 1891.9716204256947, 1913.8277555019977, 1916.3675986924281, 74615.0, 95267.04732952651, 96647.51676241645, 96951.0, 97646.51176744071, 16957.745633815503, 17947.282108715506, 18361.3573524926, 18428.8535079606, 18717.532061698566, 33755.662443375746, 33927.4910876337, 34061.659383406346, 34141.0, 34296.48555271673, 8581.656733730706, 8826.55867206637, 8873.378863479624, 8981.14679105484, 9096.772580685536, 7068.71725130989, 7177.0, 7319.743808966767, 7323.157836848724, 7346.045014148127, 9471.242300616072, 9518.286128540387, 9658.951705241569, 9660.913624416573, 9801.754956126153, 3580.8906496204727, 3698.815059247027, 3938.625830546151, 4021.1756589899, 4075.7146999709735, 963.3882484622176, 996.4967691315984, 999.1157825324494, 1001.9098281154731, 1011.4437059617181, 18049.278028878696, 18165.27338906429, 18196.45410637683, 18262.634747305245, 18814.247430102918, 977.1059480575336, 982.3025651787311, 984.1634610580949, 989.1789814453986, 992.4690290694443, 9814.460204688668, 9935.950320248352, 10052.246081543768, 10255.435951022617, 10274.178065754722, 484175.0, 489040.0, 508201.0, 530368.0, 530557.0, 91514.08485915055, 91518.0, 91611.54194228986, 92588.53705731429, 95011.52494237623, 952.8523078922778, 955.9569819358146, 983.1397527163732, 988.545269176187, 991.7471044883653, 15466.370716977915, 15503.069815811088, 16105.436309729103, 16240.72383824768, 16361.918190408971, 39223.41164882472, 39272.21455570815, 39292.41061384024, 39443.80278098591, 40115.398269025405, 49506.504934950186, 53516.46483535115, 53857.46142538524, 54127.0, 55710.442895572145, 7367.852642947219, 7663.846723065396, 7764.689412423666, 7802.375809935078, 8241.217084376975, 11233.213675042669, 12099.818502722643, 12825.615231543068, 12831.165974211646, 12848.100632955604, 9071.863922041042, 9358.719238422858, 9392.624295028396, 9742.07450292221, 10144.391336519833, 9893.109620134222, 10249.282550221711, 10568.89431105679, 10705.090067344363, 11618.70953226176, 9563.0, 9794.804103918024, 9883.209343252667, 10453.738656533647, 11006.559737610727, 7388.4828062037295, 7497.475176737576, 7515.962420187864, 7649.6557654904545, 7890.408219383684, 7742.922570774445, 9421.199198068241, 9742.61029558838, 9893.91166971647, 10761.730956726144], "value": 9467.087470446319, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.8796808287254, 1339.2567125245484, 1353.5397964692006, 1362.9795553066713, 1363.154843996722, 6828.351306625869, 7208.387287080592, 7222.386097181746, 7237.240089790568, 7253.057102576658, 6432.77485288015, 6595.0, 6671.633060181688, 6873.278305777896, 7123.145222573298, 2062.030845502615, 2095.0048726854775, 2099.0973881231066, 2109.4093653776968, 2117.4071260047212, 2080.9796095573106, 2115.21736957326, 2116.2698868890207, 2119.6714509251015, 2126.25581046634, 1865.2632210276931, 1924.874883132592, 2050.2721533855492, 2086.5618220173706, 2133.1254185783832, 2083.0418007716466, 2090.843186760984, 2106.4207342980726, 2109.778473260301, 2114.175471566075, 2054.445299769069, 2070.5444802143506, 2081.5212501124674, 2084.6247675418417, 2089.0912453082956, 7164.498485106044, 7191.928080719178, 7247.0, 7262.419006479469, 7313.744018959311, 4470.083632855257, 4548.545145485458, 4578.381918441001, 4590.334401511762, 4595.954040459586, 2672.8529930853797, 2804.467151241258, 2812.8734206960735, 2818.5631227159824, 2844.1894060192744, 974.8147851908114, 999.8950110238466, 1017.4759998600726, 1059.8622179116664, 1064.8136576099153, 9404.858927116098, 9442.575084121163, 9505.952470237673, 9524.761880952963, 9561.521923903778, 3808.333541630259, 4053.61490658387, 4058.289799285172, 4102.733322334038, 4114.280000999813, 8205.71280005197, 8271.669133234604, 8274.338052955749, 8275.8344833103, 8299.626516806758, 4557.043020965568, 4582.060677561092, 4585.72485650862, 4606.746628935441, 4607.447106347193, 3713.1088538750505, 3854.7879866607605, 4013.337799263147, 4198.118395137056, 4213.304804707251, 3294.8682052717622, 3311.4867195584725, 3430.3653824042135, 3479.8608055677996, 3541.805200713934, 1152.2683096233952, 1179.1097721220594, 1198.964031079069, 1203.1577895473204, 1203.5667159822458, 667.9532432729662, 682.2870100744634, 691.9273476285018, 693.3932808792307, 784.2353705137559, 4631.536846315409, 4750.857474275777, 4782.258749893772, 4798.2802579612635, 4858.7570621469495, 913.2009491694768, 914.3188324698142, 914.7392992996964, 939.3659279985982, 950.3110245072268, 3384.9506652937666, 3469.115375579211, 3476.443768996948, 3496.9650303497147, 3571.767835090711, 8344.290735287568, 8647.740567782977, 8707.564621768886, 8766.254868336135, 8826.779330516789, 8132.268095871282, 8281.8343633127, 8329.708460203863, 8745.956270218609, 8756.299496040301, 6674.899876501856, 6770.289119642465, 6780.830479238059, 6812.62530560814, 6839.863202736017, 4760.16697078003, 4940.580050695731, 4979.427365852974, 5088.516590923857, 5325.307709997675, 7861.095973963067, 7876.84246315082, 7883.487573307717, 7926.643301051582, 7971.163027882221, 7784.88322675149, 7971.3224375926375, 8005.479643823133, 8049.436539442183, 8199.590020498832, 5799.2750906136735, 6012.9098063529955, 6321.589096708699, 6447.129637498878, 6461.06314584392, 6623.701933412912, 6775.898361524482, 6813.080234168324, 6982.860342793014, 7012.789616311519, 6210.534209934182, 6272.18461599989, 6328.746850126127, 6413.134226879311, 6471.320511346241, 6220.160278362363, 6239.594426362272, 6258.0, 6267.2165979252595, 6274.435300822948, 5542.0855558832345, 5660.32076150848, 5665.773369065191, 5667.121596152603, 5667.8866422672145, 4279.828806847816, 4288.0, 4327.783610819383, 4394.252976993983, 4443.977780111208, 4377.956220437755, 4479.1265703188865, 4525.049739554599, 4536.88657783558, 4538.069695712305], "value": 3892.3370698758295, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.0889242415931, 352.6598924088463, 353.3480728056735, 354.11647938393713, 361.340553489881, 4788.688735232212, 4835.395575553056, 4841.668541151181, 4856.684315519488, 4879.39007624047, 4803.423589169296, 4822.831200907969, 4840.071756587258, 4845.563899249067, 4846.515348465152, 3670.376036073867, 3776.924461510768, 3794.392897136459, 3809.4857194278693, 3823.6941044716355, 3848.345781217186, 3854.807259637007, 3858.884233472986, 3867.245887052026, 3880.6507414332705, 3819.427085937104, 3833.195029043904, 3833.3291673957087, 3841.5390153181656, 3854.0, 3674.963250367489, 3733.4773131761576, 3742.232842267356, 3829.5213098362706, 3847.153626202231, 3430.0, 3448.1897253738125, 3452.7583069185166, 3460.809655468948, 3473.166440054394, 4768.785404656799, 4774.785134668949, 4778.586813659114, 4782.306565547976, 4798.424189097295, 4275.20908631901, 4393.6704747144095, 4415.271480205763, 4453.532379100213, 4472.84345047925, 4948.579370753454, 5043.773030213649, 5057.418396884369, 5070.974645126787, 5072.54347108762, 3777.0, 3780.7353485256044, 3784.299904517673, 3798.9810050949845, 3803.5245594300713, 5127.282180494733, 5344.7862085516535, 5354.651947623431, 5357.624696441217, 5362.731863406814, 3814.8664796731982, 3863.32391831434, 3870.4000879863665, 3880.1851611161974, 3894.123822139996, 3950.2692001979726, 3950.6246906543834, 3968.1666849961252, 3970.332460366653, 3976.6421022108148, 4387.736735795798, 4401.515833258339, 4403.295472724349, 4448.599626033672, 4468.687191896601, 4874.707517548958, 5060.773259765691, 5096.668716533413, 5102.4897510248675, 5108.489151084936, 1227.3617718786181, 1233.3226811536304, 1241.931693756834, 1246.1277106025818, 1253.9184952978028, 822.6668199379261, 855.8459477294023, 860.4966094834467, 863.8272345530919, 872.2629378175432, 4248.893777655521, 4274.679399045084, 4360.542143074995, 4386.0, 4390.934135987963, 5181.35233095863, 5195.168772996378, 5196.272521846944, 5199.584033277329, 5211.635185536976, 4367.912641747211, 4394.868153955386, 4399.868003959887, 4412.426384569985, 4418.513963464016, 2600.8049396295355, 2642.286582622681, 2673.7326267373105, 2680.5577079782006, 2684.6442546513886, 4743.454502732161, 4749.2876068589985, 4754.195024935305, 4760.215274064711, 4787.941185290359, 5169.844904652867, 5177.8187763428095, 5183.585313174937, 5185.818496352609, 5188.5330320270605, 4635.814567417266, 4896.755162241873, 4929.8661307898665, 4936.456989731127, 4971.4282857471135, 5163.850051468526, 5231.215317702375, 5259.0, 5276.366835979707, 5277.8416647500635, 4902.436219834764, 5183.248428977702, 5185.325907632135, 5187.0, 5193.0, 4882.218844984785, 4900.607951363953, 4919.188333925005, 4923.852284431473, 4927.482614325444, 3902.1610353774076, 3905.3556163232747, 3934.842606295716, 3935.2523020627136, 3950.58518855516, 5053.8736531587, 5271.156614941591, 5271.736413179249, 5280.867978300574, 5294.2852714883, 5049.823256186016, 5058.0, 5062.848114556569, 5073.59411247092, 5082.771275292695, 5040.420351659606, 5045.974770126126, 5047.116754568009, 5088.193691239557, 5102.846914592568, 4710.526973339024, 4945.307656928105, 4952.0, 4954.479779623088, 4987.600991920565, 4877.707337559757, 4988.176950803077, 5082.491750824888, 5114.4629813869005, 5135.6405051646025, 4855.470526784193, 4983.632774432116, 4983.775730092227, 4992.450830408725, 5005.62457815658], "value": 3856.2612732705925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.4592434203948, 665.0987911380083, 730.3901242462543, 761.0980987529775, 779.8752199648055, 12447.564335248268, 12918.870811291885, 13021.15362501438, 13084.542041028566, 13091.60725178245, 12612.81080783789, 12632.0, 12645.747085058294, 12648.05139614528, 12694.682632934158, 635.4090695653041, 667.3993405934649, 773.8220209351853, 792.385900926782, 810.623060276971, 817.9263866252036, 818.5743413425015, 820.9671613135467, 821.0270829067545, 821.1747194069981, 866.6273502393968, 868.3791089371099, 868.5570359116833, 868.6481974800216, 868.6612221233723, 675.9594424334531, 704.1901812915137, 704.2499737779249, 704.63359053292, 866.0646501778097, 593.2613895699882, 624.9031400132986, 628.0108828594936, 631.43171145969, 633.8193614819754, 13252.801207981887, 13278.867211327859, 13311.73376532464, 13322.333883305795, 13322.60032199026, 11093.667189984313, 11121.05471034963, 11452.885471145266, 11629.24409913353, 11877.0, 12118.0, 12257.509699612005, 12327.321997290146, 12364.505419783198, 12507.74984500314, 4035.2534781065597, 4051.858184963512, 4128.236276288866, 4147.8963025924295, 4235.0682849773, 59944.0, 60163.0, 60415.39584604186, 60876.0, 62031.68984155096, 9694.709158725249, 9758.512074396253, 9789.923108458064, 9920.0, 9964.451955142391, 18154.546136346697, 18462.44612661622, 18502.44492665222, 18519.166637501345, 18543.72184417235, 6735.4274886635185, 6741.292164322774, 6743.561668491532, 6989.720411183495, 7018.438524917994, 3664.7984360859878, 3704.4628528863163, 3785.3186426443503, 3789.810509474515, 3804.771713697187, 2925.312551550384, 2988.686187950234, 3005.9248518786767, 3022.788404811686, 3031.257341951236, 502.550217555286, 507.55588859747724, 513.876669599301, 514.007964628271, 516.917293233081, 598.1715324275822, 622.7678349366772, 630.9085182648582, 635.2313700422541, 636.3763511758502, 8664.696735614223, 8883.64465421389, 9090.181883630505, 9152.31357648179, 9267.304952128483, 614.4623454477332, 628.6259675493075, 644.8549076457759, 645.7578408096964, 654.1365397675023, 4201.663866890642, 4260.936085958713, 4298.613124818781, 4307.203167414038, 4361.978190109029, 59393.0, 62300.688496557224, 62930.0, 63026.36973630205, 63856.0, 57965.710171448874, 58093.0, 58186.418135818945, 58354.416455835744, 58669.0, 52124.0, 52409.47590524122, 52647.999999999236, 53377.0, 53679.0, 7914.960425198067, 8151.388645851704, 8206.548639824628, 8216.958915205625, 8342.29090527312, 34458.0, 34660.48009279813, 34890.47664284987, 35437.291254174255, 35561.288774224886, 42791.3581296287, 42940.570594293655, 43780.12439751251, 44392.334114988946, 45731.77134114308, 10072.236337368662, 10153.543090560795, 10195.541200645841, 10320.638777642747, 10484.475776211311, 11373.090152787923, 11488.138389620644, 11688.649340519798, 11728.0, 11786.931988116392, 10027.29808913369, 10056.446895420822, 10150.187984961038, 10791.946040269748, 13272.070955033056, 12197.817032744693, 12557.0, 12809.551665691655, 12949.223046617233, 12954.805677915027, 11857.16999810005, 11902.642920712393, 12018.0, 12222.327771972627, 12347.506099755909, 10484.737881553023, 10673.35959842412, 10848.67453976382, 11040.282381645167, 11201.103911687209, 10698.83951740709, 10796.244262901522, 11067.169962252703, 11088.223824332543, 11118.944405277922], "value": 6355.896195057565, "unit": "score"}], "name": "dromaeo_css", "value": 6447.107296378366, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 116.0, 117.0, 116.0, 116.0, 115.0, 115.0, 114.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 123.0, 165.0, 126.0, 125.0, 127.0, 122.0, 145.0, 128.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 161.0, 162.0, 163.0, 163.0, 162.0, 161.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 115.0, 77.0, 77.0, 77.0, 77.0, 94.0, 78.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 105.0, 86.0, 85.0, 84.0, 105.0, 85.0, 85.0, 116.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 150.0, 149.0, 148.0, 150.0, 150.0, 150.0, 149.0, 149.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 58.0, 59.0, 61.0, 61.0, 69.0, 59.0, 60.0, 59.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 70.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 86.0, 94.0, 85.0, 85.0, 94.0, 89.0, 85.0, 87.0, 85.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 139.0, 138.0, 136.0, 139.0, 132.0, 131.0, 131.0, 174.0, 132.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 178.0, 179.0, 181.0, 178.0, 177.0, 176.0, 180.0, 179.0], "value": 179.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 78.0, 69.0, 71.0, 70.0, 73.0, 69.0, 70.0, 68.0, 69.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1553.4999999999998, "alertThreshold": 2.0}]} 09:04:45 INFO - Return code: 0 09:04:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:04:45 INFO - # TBPL SUCCESS # 09:04:45 INFO - Running post-action listener: _resource_record_post_action 09:04:45 INFO - [mozharness: 2017-01-09 17:04:45.494262Z] Finished run-tests step (success) 09:04:45 INFO - Running post-run listener: _resource_record_post_run 09:04:45 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394358784; Read time: 16; Write time: 205416 09:04:45 INFO - TinderboxPrint: CPU usage
13.1% 09:04:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:04:45 INFO - TinderboxPrint: I/O write bytes / time
394,358,784 / 205,416 09:04:45 INFO - TinderboxPrint: CPU idle
8,351.9 (86.9%) 09:04:45 INFO - TinderboxPrint: CPU user
1,211.4 (12.6%) 09:04:45 INFO - TinderboxPrint: Swap in / out
0 / 0 09:04:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 100126720; Read time: 0; Write time: 68348 09:04:45 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 293842944; Read time: 0; Write time: 137032 09:04:46 INFO - Running post-run listener: _upload_blobber_files 09:04:46 INFO - Blob upload gear active. 09:04:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:04:46 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 09:04:46 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:04:46 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:04:46 INFO - (blobuploader) - INFO - Open directory for files ... 09:04:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:04:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:04:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:47 INFO - (blobuploader) - INFO - Done attempting. 09:04:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:04:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:04:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:50 INFO - (blobuploader) - INFO - Done attempting. 09:04:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:04:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:04:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:51 INFO - (blobuploader) - INFO - Done attempting. 09:04:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:04:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:04:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:52 INFO - (blobuploader) - INFO - Done attempting. 09:04:52 INFO - (blobuploader) - INFO - Iteration through files over. 09:04:52 INFO - Return code: 0 09:04:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:04:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:04:52 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/170696eb86a8d171ac75f72320739c9113419d690b1923f60f34e3b66a517bae972b096e777cc66a2b38a68b29032aed49f940f88ce3487c8bbab9f0347d083a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7a2908eeef49d8237ad71a9253ea9ccd6157610b32f4ad726ce698d37c4bdf5c86b819a31c8558c7832414b3e784d365bf5502a34394be20b280ec210f660dc8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/54bd6e5c6bb9ff1491d4778510df70f17d6a7bb756ebe002a74b45f399dea8f07ccf1703c540730098f8de22424be181b0f9f9f0dd5f9a4e6ac528904b20e2a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/850a815a2efcdfce23903a88b1c0ac720b45028eef80a50b0221d12538eb8d46fbf69d86019936ef6e4dbb8d64c6ad22a52c0ebe0daf0ab5a9de5e7a8696e97a"} 09:04:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:04:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:04:52 INFO - Contents: 09:04:52 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/170696eb86a8d171ac75f72320739c9113419d690b1923f60f34e3b66a517bae972b096e777cc66a2b38a68b29032aed49f940f88ce3487c8bbab9f0347d083a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7a2908eeef49d8237ad71a9253ea9ccd6157610b32f4ad726ce698d37c4bdf5c86b819a31c8558c7832414b3e784d365bf5502a34394be20b280ec210f660dc8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/54bd6e5c6bb9ff1491d4778510df70f17d6a7bb756ebe002a74b45f399dea8f07ccf1703c540730098f8de22424be181b0f9f9f0dd5f9a4e6ac528904b20e2a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/850a815a2efcdfce23903a88b1c0ac720b45028eef80a50b0221d12538eb8d46fbf69d86019936ef6e4dbb8d64c6ad22a52c0ebe0daf0ab5a9de5e7a8696e97a"} 09:04:52 INFO - Running post-run listener: copy_logs_to_upload_dir 09:04:52 INFO - Copying logs to upload dir... 09:04:52 INFO - mkdir: /builds/slave/test/build/upload/logs 09:04:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.454356 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-01-09 09:04:50.388142) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 09:04:50.392138) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/170696eb86a8d171ac75f72320739c9113419d690b1923f60f34e3b66a517bae972b096e777cc66a2b38a68b29032aed49f940f88ce3487c8bbab9f0347d083a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7a2908eeef49d8237ad71a9253ea9ccd6157610b32f4ad726ce698d37c4bdf5c86b819a31c8558c7832414b3e784d365bf5502a34394be20b280ec210f660dc8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/54bd6e5c6bb9ff1491d4778510df70f17d6a7bb756ebe002a74b45f399dea8f07ccf1703c540730098f8de22424be181b0f9f9f0dd5f9a4e6ac528904b20e2a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/850a815a2efcdfce23903a88b1c0ac720b45028eef80a50b0221d12538eb8d46fbf69d86019936ef6e4dbb8d64c6ad22a52c0ebe0daf0ab5a9de5e7a8696e97a"} build_url:https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011818 build_url: 'https://queue.taskcluster.net/v1/task/RCXJoFLQSUOBgxPZyVH53g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/170696eb86a8d171ac75f72320739c9113419d690b1923f60f34e3b66a517bae972b096e777cc66a2b38a68b29032aed49f940f88ce3487c8bbab9f0347d083a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7a2908eeef49d8237ad71a9253ea9ccd6157610b32f4ad726ce698d37c4bdf5c86b819a31c8558c7832414b3e784d365bf5502a34394be20b280ec210f660dc8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/54bd6e5c6bb9ff1491d4778510df70f17d6a7bb756ebe002a74b45f399dea8f07ccf1703c540730098f8de22424be181b0f9f9f0dd5f9a4e6ac528904b20e2a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/850a815a2efcdfce23903a88b1c0ac720b45028eef80a50b0221d12538eb8d46fbf69d86019936ef6e4dbb8d64c6ad22a52c0ebe0daf0ab5a9de5e7a8696e97a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 09:04:50.418193) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 09:04:50.418553) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1483980240.707253-445741011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 09:04:50.503333) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 09:04:50.504137) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 09:04:50.504893) ========= ========= Total master_lag: 0.16 =========