builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1484244575.94 results: success (0) revision: 571286200177ae7ddfa1893c6b42853b60f2e81e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 10:09:35.935470) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 10:09:35.936108) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 10:09:35.936408) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 10:09:35.951841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 10:09:35.952211) ========= 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=bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-12 10:09:36-- 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% 215M=0s 2017-01-12 10:09:36 (215 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115382 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 10:09:36.092431) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 10:09:36.092948) ========= 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=bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016686 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 10:09:36.147844) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 10:09:36.148214) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 571286200177ae7ddfa1893c6b42853b60f2e81e --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 571286200177ae7ddfa1893c6b42853b60f2e81e --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=bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-12 10:09:36,976 truncating revision to first 12 chars 2017-01-12 10:09:36,976 Setting DEBUG logging. 2017-01-12 10:09:36,976 attempt 1/10 2017-01-12 10:09:36,976 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/571286200177?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 10:09:38,267 unpacking tar archive at: graphics-571286200177/testing/mozharness/ program finished with exit code 0 elapsedTime=1.670492 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 10:09:37.832519) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 10:09:37.832847) ========= script_repo_revision: 571286200177ae7ddfa1893c6b42853b60f2e81e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 10:09:37.833247) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 10:09:37.833522) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 10:09:37.842477) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-12 10:09:37.842923) ========= /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=bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:09:38 INFO - MultiFileLogger online at 20170112 10:09:38 in /builds/slave/test 10:09:38 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 10:09:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:09:38 INFO - {'append_to_log': False, 10:09:38 INFO - 'base_work_dir': '/builds/slave/test', 10:09:38 INFO - 'blob_upload_branch': 'Graphics', 10:09:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:09:38 INFO - 'branch': 'Graphics', 10:09:38 INFO - 'buildbot_json_path': 'buildprops.json', 10:09:38 INFO - 'config_files': ('talos/linux_config.py',), 10:09:38 INFO - 'default_actions': ('clobber', 10:09:38 INFO - 'read-buildbot-config', 10:09:38 INFO - 'download-and-extract', 10:09:38 INFO - 'populate-webroot', 10:09:38 INFO - 'create-virtualenv', 10:09:38 INFO - 'install', 10:09:38 INFO - 'run-tests'), 10:09:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:09:38 INFO - 'download_minidump_stackwalk': True, 10:09:38 INFO - 'download_symbols': 'ondemand', 10:09:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:09:38 INFO - 'tooltool.py': '/tools/tooltool.py', 10:09:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:09:38 INFO - '/tools/misc-python/virtualenv.py')}, 10:09:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:09:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:09:38 INFO - 'installer_path': 'installer.exe', 10:09:38 INFO - 'log_level': 'info', 10:09:38 INFO - 'log_name': 'talos', 10:09:38 INFO - 'log_to_console': True, 10:09:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:09:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:09:38 INFO - 'opt_config_files': (), 10:09:38 INFO - 'pip_index': False, 10:09:38 INFO - 'sps_profile': False, 10:09:38 INFO - 'sps_profile_interval': 0, 10:09:38 INFO - 'suite': 'dromaeojs', 10:09:38 INFO - 'system_bits': '32', 10:09:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:09:38 INFO - 'title': 'talos-linux64-ix-055', 10:09:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:09:38 INFO - 'use_talos_json': True, 10:09:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:09:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:09:38 INFO - 'work_dir': 'build'} 10:09:38 INFO - [mozharness: 2017-01-12 18:09:38.774349Z] Running clobber step. 10:09:38 INFO - Running pre-action listener: _resource_record_pre_action 10:09:38 INFO - Running main action method: clobber 10:09:38 INFO - rmtree: /builds/slave/test/build 10:09:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:09:39 INFO - Running post-action listener: _resource_record_post_action 10:09:39 INFO - [mozharness: 2017-01-12 18:09:39.235908Z] Finished clobber step (success) 10:09:39 INFO - [mozharness: 2017-01-12 18:09:39.236011Z] Running read-buildbot-config step. 10:09:39 INFO - Running pre-action listener: _resource_record_pre_action 10:09:39 INFO - Running main action method: read_buildbot_config 10:09:39 INFO - Using buildbot properties: 10:09:39 INFO - { 10:09:39 INFO - "project": "", 10:09:39 INFO - "product": "firefox", 10:09:39 INFO - "who": "kgupta@mozilla.com", 10:09:39 INFO - "installer_path": "public/build/target.tar.bz2", 10:09:39 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 10:09:39 INFO - "repository": "https://hg.mozilla.org/projects/graphics/", 10:09:39 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 10:09:39 INFO - "stage_platform": "linux64", 10:09:39 INFO - "basedir": "/builds/slave/test", 10:09:39 INFO - "buildnumber": 52, 10:09:39 INFO - "platform": "ubuntu64_hw", 10:09:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:09:39 INFO - "slavebuilddir": "test", 10:09:39 INFO - "taskId": "MMURfrviScuZi6rNivDt3A", 10:09:39 INFO - "branch": "graphics", 10:09:39 INFO - "script_repo_revision": "default", 10:09:39 INFO - "revision": "571286200177ae7ddfa1893c6b42853b60f2e81e", 10:09:39 INFO - "slavename": "talos-linux64-ix-055", 10:09:39 INFO - "repo_path": "projects/graphics" 10:09:39 INFO - } 10:09:39 INFO - Finding installer, test and symbols from parent task. 10:09:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MMURfrviScuZi6rNivDt3A'}, attempt #1 10:09:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MMURfrviScuZi6rNivDt3A'}, attempt #1 10:09:40 INFO - Task dependencies: J4jnKgKAQieAhwvSQBKa3Q 10:09:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q'}, attempt #1 10:09:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.tar.bz2 10:09:40 INFO - Set test_url: https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/test_packages.json 10:09:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.crashreporter-symbols.zip 10:09:40 INFO - Running post-action listener: _resource_record_post_action 10:09:40 INFO - [mozharness: 2017-01-12 18:09:40.647433Z] Finished read-buildbot-config step (success) 10:09:40 INFO - [mozharness: 2017-01-12 18:09:40.647650Z] Running download-and-extract step. 10:09:40 INFO - Running pre-action listener: _resource_record_pre_action 10:09:40 INFO - Running main action method: download_and_extract 10:09:40 INFO - mkdir: /builds/slave/test/build/tests 10:09: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')]} 10:09:40 INFO - trying https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.test_packages.json 10:09:40 INFO - Downloading https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:09:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:09:41 INFO - Downloaded 896 bytes. 10:09:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:09:41 INFO - Using the following test package requirements: 10:09:41 INFO - {u'common': [u'target.common.tests.zip'], 10:09:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:09:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:09:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:09:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:09:41 INFO - u'mozbase': [u'target.common.tests.zip'], 10:09:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:09:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:09:41 INFO - u'web-platform': [u'target.common.tests.zip', 10:09:41 INFO - u'target.web-platform.tests.zip'], 10:09:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:09:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:09:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.common.tests.zip 10:09:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:09:41 INFO - Fetch https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.common.tests.zip into memory 10:09:42 INFO - Expected file size: 20257948 10:09:42 INFO - Obtained file size: 20257948 10:09:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:09:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.common.tests.zip 10:09:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:09:46 INFO - Fetch https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.common.tests.zip into memory 10:09:46 INFO - Expected file size: 20257948 10:09:46 INFO - Obtained file size: 20257948 10:09:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.talos.tests.zip 10:09:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:09:51 INFO - Fetch https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.talos.tests.zip into memory 10:09:52 INFO - Expected file size: 14403529 10:09:52 INFO - Obtained file size: 14403529 10:09:53 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')]} 10:09:53 INFO - trying https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.tar.bz2 10:09:53 INFO - Downloading https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:09:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:09:55 INFO - Downloaded 56034681 bytes. 10:09:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.tar.bz2 10:09:55 INFO - mkdir: /builds/slave/test/properties 10:09:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:09:55 INFO - Writing to file /builds/slave/test/properties/build_url 10:09:55 INFO - Contents: 10:09:55 INFO - build_url:https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.tar.bz2 10:09:55 INFO - Running post-action listener: _resource_record_post_action 10:09:55 INFO - Running post-action listener: set_extra_try_arguments 10:09:55 INFO - [mozharness: 2017-01-12 18:09:55.544416Z] Finished download-and-extract step (success) 10:09:55 INFO - [mozharness: 2017-01-12 18:09:55.544551Z] Running populate-webroot step. 10:09:55 INFO - Running pre-action listener: _resource_record_pre_action 10:09:55 INFO - Running main action method: populate_webroot 10:09:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:09:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:09:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:09:55 INFO - '--tppagecycles', 10:09:55 INFO - '7'], 10:09:55 INFO - 'tests': ['tsvgm']}}, 10:09:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:09:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:09:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:09:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:09:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:09:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:09:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:09:55 INFO - 'talos_options': ['--disable-e10s'], 10:09:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:09:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:09:55 INFO - 'talos_options': ['--disable-e10s'], 10:09:55 INFO - 'tests': ['damp', 'tps']}, 10:09:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:09:55 INFO - 'tests': ['damp', 'tps']}, 10:09:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:09:55 INFO - 'tests': ['dromaeo_dom']}, 10:09:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:09:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:09:55 INFO - 'tests': ['basic_compositor_video']}, 10:09:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:09:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:09:55 INFO - 'tests': ['a11yr', 10:09:55 INFO - 'ts_paint', 10:09:55 INFO - 'tpaint', 10:09:55 INFO - 'sessionrestore', 10:09:55 INFO - 'sessionrestore_no_auto_restore', 10:09:55 INFO - 'tabpaint']}, 10:09:55 INFO - 'other-e10s': {'tests': ['a11yr', 10:09:55 INFO - 'ts_paint', 10:09:55 INFO - 'tpaint', 10:09:55 INFO - 'sessionrestore', 10:09:55 INFO - 'sessionrestore_no_auto_restore', 10:09:55 INFO - 'tabpaint']}, 10:09:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:09:55 INFO - 'ts_paint', 10:09:55 INFO - 'tpaint', 10:09:55 INFO - 'sessionrestore', 10:09:55 INFO - 'sessionrestore_no_auto_restore', 10:09:55 INFO - 'tabpaint']}, 10:09:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:09:55 INFO - 'ts_paint', 10:09:55 INFO - 'tpaint', 10:09:55 INFO - 'sessionrestore', 10:09:55 INFO - 'sessionrestore_no_auto_restore', 10:09:55 INFO - 'tabpaint']}, 10:09:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:09:55 INFO - 'tests': ['a11yr', 10:09:55 INFO - 'ts_paint', 10:09:55 INFO - 'tpaint', 10:09:55 INFO - 'sessionrestore', 10:09:55 INFO - 'sessionrestore_no_auto_restore', 10:09:55 INFO - 'tabpaint']}, 10:09:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:09:55 INFO - 'tests': ['a11yr', 10:09:55 INFO - 'ts_paint', 10:09:55 INFO - 'tpaint', 10:09:55 INFO - 'sessionrestore', 10:09:55 INFO - 'sessionrestore_no_auto_restore', 10:09:55 INFO - 'tabpaint']}, 10:09:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:09:55 INFO - 'tests': ['tsvgx', 10:09:55 INFO - 'tsvgr_opacity', 10:09:55 INFO - 'tart', 10:09:55 INFO - 'tscrollx', 10:09:55 INFO - 'cart', 10:09:55 INFO - 'tsvg_static']}, 10:09:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:09:55 INFO - 'tsvgr_opacity', 10:09:55 INFO - 'tart', 10:09:55 INFO - 'tscrollx', 10:09:55 INFO - 'cart', 10:09:55 INFO - 'tsvg_static']}, 10:09:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:09:55 INFO - 'talos_options': ['--disable-e10s'], 10:09:55 INFO - 'tests': ['tp5o']}, 10:09:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:09:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:09:55 INFO - 'talos_options': ['--disable-e10s', 10:09:55 INFO - '--xperf_path', 10:09:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:55 INFO - 'tests': ['tp5n']}, 10:09:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:09:55 INFO - 'talos_options': ['--xperf_path', 10:09:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:55 INFO - 'tests': ['tp5n']}}, 10:09:55 INFO - 'talos.zip': {'path': '', 10:09:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:09:55 INFO - Running post-action listener: _resource_record_post_action 10:09:55 INFO - [mozharness: 2017-01-12 18:09:55.559838Z] Finished populate-webroot step (success) 10:09:55 INFO - [mozharness: 2017-01-12 18:09:55.559932Z] Running create-virtualenv step. 10:09:55 INFO - Running pre-action listener: _resource_record_pre_action 10:09:55 INFO - Running main action method: create_virtualenv 10:09:55 INFO - Creating virtualenv /builds/slave/test/build/venv 10:09:55 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 10:09:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:09:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:09:55 INFO - Using real prefix '/usr' 10:09:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:09:56 INFO - Installing distribute.............................................................................................................................................................................................done. 10:09:58 INFO - Installing pip.................done. 10:09:58 INFO - Return code: 0 10:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:09:58 INFO - Reading from file tmpfile_stdout 10:09:58 INFO - Output received: 10:09:58 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) 10:09:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:09:58 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')]} 10:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:58 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')]} 10:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:58 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb3f0>, '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 0x26bbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bc1a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', '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 10:09:58 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 10:09:58 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 10:09:58 INFO - Using env: {'DISPLAY': ':0', 10:09:58 INFO - 'HOME': '/home/cltbld', 10:09:58 INFO - 'LANG': 'en_US.UTF-8', 10:09:58 INFO - 'LANGUAGE': 'en_US:en', 10:09:58 INFO - 'LOGNAME': 'cltbld', 10:09:58 INFO - 'MAIL': '/var/mail/cltbld', 10:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:58 INFO - 'MOZ_NO_REMOTE': '1', 10:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:58 INFO - 'NO_EM_RESTART': '1', 10:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:58 INFO - 'PWD': '/builds/slave/test', 10:09:58 INFO - 'SHELL': '/bin/bash', 10:09:58 INFO - 'SHLVL': '1', 10:09:58 INFO - 'TERM': 'linux', 10:09:58 INFO - 'TMOUT': '86400', 10:09:58 INFO - 'USER': 'cltbld', 10:09:58 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', 10:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:58 INFO - '_': '/tools/buildbot/bin/python'} 10:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:58 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 10:09:58 INFO - Cleaning up... 10:09:58 INFO - Return code: 0 10:09:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:09:58 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')]} 10:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:58 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')]} 10:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:58 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb3f0>, '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 0x26bbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bc1a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', '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 10:09:58 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 10:09:58 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 10:09:58 INFO - Using env: {'DISPLAY': ':0', 10:09:58 INFO - 'HOME': '/home/cltbld', 10:09:58 INFO - 'LANG': 'en_US.UTF-8', 10:09:58 INFO - 'LANGUAGE': 'en_US:en', 10:09:58 INFO - 'LOGNAME': 'cltbld', 10:09:58 INFO - 'MAIL': '/var/mail/cltbld', 10:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:58 INFO - 'MOZ_NO_REMOTE': '1', 10:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:58 INFO - 'NO_EM_RESTART': '1', 10:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:58 INFO - 'PWD': '/builds/slave/test', 10:09:58 INFO - 'SHELL': '/bin/bash', 10:09:58 INFO - 'SHLVL': '1', 10:09:58 INFO - 'TERM': 'linux', 10:09:58 INFO - 'TMOUT': '86400', 10:09:58 INFO - 'USER': 'cltbld', 10:09:58 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', 10:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:58 INFO - '_': '/tools/buildbot/bin/python'} 10:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:58 INFO - Downloading/unpacking psutil>=3.1.1 10:09:58 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 10:09:58 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 10:09:58 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 10:09:58 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 10:09:58 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 10:09:58 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 10:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:10:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:00 INFO - Installing collected packages: psutil 10:10:00 INFO - Running setup.py install for psutil 10:10:00 INFO - building 'psutil._psutil_linux' extension 10:10:00 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 10:10:01 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 10:10:01 INFO - building 'psutil._psutil_posix' extension 10:10:01 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 10:10:01 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 10:10:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:01 INFO - Successfully installed psutil 10:10:01 INFO - Cleaning up... 10:10:01 INFO - Return code: 0 10:10:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:10:01 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')]} 10:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:01 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')]} 10:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:01 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb3f0>, '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 0x26bbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bc1a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', '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 10:10:01 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 10:10:01 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 10:10:01 INFO - Using env: {'DISPLAY': ':0', 10:10:01 INFO - 'HOME': '/home/cltbld', 10:10:01 INFO - 'LANG': 'en_US.UTF-8', 10:10:01 INFO - 'LANGUAGE': 'en_US:en', 10:10:01 INFO - 'LOGNAME': 'cltbld', 10:10:01 INFO - 'MAIL': '/var/mail/cltbld', 10:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:01 INFO - 'MOZ_NO_REMOTE': '1', 10:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:01 INFO - 'NO_EM_RESTART': '1', 10:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:01 INFO - 'PWD': '/builds/slave/test', 10:10:01 INFO - 'SHELL': '/bin/bash', 10:10:01 INFO - 'SHLVL': '1', 10:10:01 INFO - 'TERM': 'linux', 10:10:01 INFO - 'TMOUT': '86400', 10:10:01 INFO - 'USER': 'cltbld', 10:10:01 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', 10:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:01 INFO - '_': '/tools/buildbot/bin/python'} 10:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:10:01 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 10:10:01 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 10:10:01 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 10:10:01 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 10:10:01 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 10:10:01 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 10:10:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:10:03 INFO - Installing collected packages: mozsystemmonitor 10:10:03 INFO - Running setup.py install for mozsystemmonitor 10:10:03 INFO - Successfully installed mozsystemmonitor 10:10:03 INFO - Cleaning up... 10:10:03 INFO - Return code: 0 10:10:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:10:03 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')]} 10:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:03 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')]} 10:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:03 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb3f0>, '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 0x26bbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bc1a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', '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 10:10:03 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 10:10:03 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 10:10:03 INFO - Using env: {'DISPLAY': ':0', 10:10:03 INFO - 'HOME': '/home/cltbld', 10:10:03 INFO - 'LANG': 'en_US.UTF-8', 10:10:03 INFO - 'LANGUAGE': 'en_US:en', 10:10:03 INFO - 'LOGNAME': 'cltbld', 10:10:03 INFO - 'MAIL': '/var/mail/cltbld', 10:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:03 INFO - 'MOZ_NO_REMOTE': '1', 10:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:03 INFO - 'NO_EM_RESTART': '1', 10:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:03 INFO - 'PWD': '/builds/slave/test', 10:10:03 INFO - 'SHELL': '/bin/bash', 10:10:03 INFO - 'SHLVL': '1', 10:10:03 INFO - 'TERM': 'linux', 10:10:03 INFO - 'TMOUT': '86400', 10:10:03 INFO - 'USER': 'cltbld', 10:10:03 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', 10:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:03 INFO - '_': '/tools/buildbot/bin/python'} 10:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:04 INFO - Downloading/unpacking jsonschema==2.5.1 10:10:04 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 10:10:04 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 10:10:04 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 10:10:04 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 10:10:04 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 10:10:04 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 10:10:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:10:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:10:06 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 10:10:06 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 10:10:06 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 10:10:06 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 10:10:06 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 10:10:06 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 10:10:06 INFO - Downloading functools32-3.2.3-2.tar.gz 10:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:10:06 INFO - warning: no files found matching '*.txt' 10:10:06 INFO - no previously-included directories found matching 'build' 10:10:06 INFO - no previously-included directories found matching 'dist' 10:10:06 INFO - no previously-included directories found matching '.git*' 10:10:06 INFO - Installing collected packages: jsonschema, functools32 10:10:06 INFO - Running setup.py install for functools32 10:10:06 INFO - warning: no files found matching '*.txt' 10:10:06 INFO - no previously-included directories found matching 'build' 10:10:06 INFO - no previously-included directories found matching 'dist' 10:10:06 INFO - no previously-included directories found matching '.git*' 10:10:06 INFO - Successfully installed jsonschema functools32 10:10:06 INFO - Cleaning up... 10:10:06 INFO - Return code: 0 10:10:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:06 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb3f0>, '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 0x26bbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bc1a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', '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 10:10:06 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 10:10:06 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 10:10:06 INFO - Using env: {'DISPLAY': ':0', 10:10:06 INFO - 'HOME': '/home/cltbld', 10:10:06 INFO - 'LANG': 'en_US.UTF-8', 10:10:06 INFO - 'LANGUAGE': 'en_US:en', 10:10:06 INFO - 'LOGNAME': 'cltbld', 10:10:06 INFO - 'MAIL': '/var/mail/cltbld', 10:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:06 INFO - 'MOZ_NO_REMOTE': '1', 10:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:06 INFO - 'NO_EM_RESTART': '1', 10:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:06 INFO - 'PWD': '/builds/slave/test', 10:10:06 INFO - 'SHELL': '/bin/bash', 10:10:06 INFO - 'SHLVL': '1', 10:10:06 INFO - 'TERM': 'linux', 10:10:06 INFO - 'TMOUT': '86400', 10:10:06 INFO - 'USER': 'cltbld', 10:10:06 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', 10:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:06 INFO - '_': '/tools/buildbot/bin/python'} 10:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:10:06 INFO - Cleaning up... 10:10:06 INFO - Return code: 0 10:10:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:06 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb3f0>, '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 0x26bbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bc1a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', '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 10:10:06 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 10:10:06 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 10:10:06 INFO - Using env: {'DISPLAY': ':0', 10:10:06 INFO - 'HOME': '/home/cltbld', 10:10:06 INFO - 'LANG': 'en_US.UTF-8', 10:10:06 INFO - 'LANGUAGE': 'en_US:en', 10:10:06 INFO - 'LOGNAME': 'cltbld', 10:10:06 INFO - 'MAIL': '/var/mail/cltbld', 10:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:06 INFO - 'MOZ_NO_REMOTE': '1', 10:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:06 INFO - 'NO_EM_RESTART': '1', 10:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:06 INFO - 'PWD': '/builds/slave/test', 10:10:06 INFO - 'SHELL': '/bin/bash', 10:10:06 INFO - 'SHLVL': '1', 10:10:06 INFO - 'TERM': 'linux', 10:10:06 INFO - 'TMOUT': '86400', 10:10:06 INFO - 'USER': 'cltbld', 10:10:06 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', 10:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:06 INFO - '_': '/tools/buildbot/bin/python'} 10:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:06 INFO - Downloading/unpacking blobuploader==1.2.4 10:10:06 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 10:10:06 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 10:10:06 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 10:10:06 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 10:10:06 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 10:10:06 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 10:10:08 INFO - Downloading blobuploader-1.2.4.tar.gz 10:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:10:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:10:09 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 10:10:09 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 10:10:09 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 10:10:09 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 10:10:09 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 10:10:09 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 10:10:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:10:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:10:09 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 10:10:09 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 10:10:09 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 10:10:09 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 10:10:09 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 10:10:09 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 10:10:09 INFO - Downloading docopt-0.6.1.tar.gz 10:10:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:10:09 INFO - Installing collected packages: blobuploader, requests, docopt 10:10:09 INFO - Running setup.py install for blobuploader 10:10:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:10:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:10:09 INFO - Running setup.py install for requests 10:10:10 INFO - Running setup.py install for docopt 10:10:10 INFO - Successfully installed blobuploader requests docopt 10:10:10 INFO - Cleaning up... 10:10:10 INFO - Return code: 0 10:10:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:10 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb3f0>, '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 0x26bbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bc1a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', '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 10:10:10 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 10:10:10 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 10:10:10 INFO - Using env: {'DISPLAY': ':0', 10:10:10 INFO - 'HOME': '/home/cltbld', 10:10:10 INFO - 'LANG': 'en_US.UTF-8', 10:10:10 INFO - 'LANGUAGE': 'en_US:en', 10:10:10 INFO - 'LOGNAME': 'cltbld', 10:10:10 INFO - 'MAIL': '/var/mail/cltbld', 10:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:10 INFO - 'MOZ_NO_REMOTE': '1', 10:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:10 INFO - 'NO_EM_RESTART': '1', 10:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:10 INFO - 'PWD': '/builds/slave/test', 10:10:10 INFO - 'SHELL': '/bin/bash', 10:10:10 INFO - 'SHLVL': '1', 10:10:10 INFO - 'TERM': 'linux', 10:10:10 INFO - 'TMOUT': '86400', 10:10:10 INFO - 'USER': 'cltbld', 10:10:10 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', 10:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:10 INFO - '_': '/tools/buildbot/bin/python'} 10:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:10 INFO - Running setup.py (path:/tmp/pip-6h7li7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:10 INFO - Running setup.py (path:/tmp/pip-UpqCQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:10 INFO - Running setup.py (path:/tmp/pip-noPc0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:10 INFO - Running setup.py (path:/tmp/pip-pnOiKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:10 INFO - Running setup.py (path:/tmp/pip-TbjBcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:11 INFO - Running setup.py (path:/tmp/pip-jMDcmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:11 INFO - Running setup.py (path:/tmp/pip-Ut6ez4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:11 INFO - Running setup.py (path:/tmp/pip-mTd76k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:11 INFO - Running setup.py (path:/tmp/pip-trqJs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:11 INFO - Running setup.py (path:/tmp/pip-S9Qhdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:11 INFO - Running setup.py (path:/tmp/pip-PzjBbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:11 INFO - Running setup.py (path:/tmp/pip-ujFRkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:11 INFO - Running setup.py (path:/tmp/pip-RdxhYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:11 INFO - Running setup.py (path:/tmp/pip-92gFD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:11 INFO - Running setup.py (path:/tmp/pip-KXqxQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:11 INFO - Running setup.py (path:/tmp/pip-GmcuKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:11 INFO - Running setup.py (path:/tmp/pip-o2nV3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:10:11 INFO - Running setup.py install for manifestparser 10:10:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:10:11 INFO - Running setup.py install for mozcrash 10:10:12 INFO - Running setup.py install for mozdebug 10:10:12 INFO - Running setup.py install for mozdevice 10:10:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:10:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:10:12 INFO - Running setup.py install for mozfile 10:10:12 INFO - Running setup.py install for mozhttpd 10:10:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:10:12 INFO - Running setup.py install for mozinfo 10:10:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:10:12 INFO - Running setup.py install for mozInstall 10:10:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:10:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:10:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:10:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:10:12 INFO - Running setup.py install for mozleak 10:10:12 INFO - Running setup.py install for mozlog 10:10:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:10:12 INFO - Running setup.py install for moznetwork 10:10:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:10:13 INFO - Running setup.py install for mozprocess 10:10:13 INFO - Running setup.py install for mozprofile 10:10:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:10:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:10:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:10:13 INFO - Running setup.py install for mozrunner 10:10:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:10:13 INFO - Running setup.py install for mozscreenshot 10:10:13 INFO - Running setup.py install for moztest 10:10:13 INFO - Running setup.py install for mozversion 10:10:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:10:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:10:13 INFO - Cleaning up... 10:10:13 INFO - Return code: 0 10:10:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:13 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')]} 10:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:13 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')]} 10:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:13 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb3f0>, '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 0x26bbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bc1a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', '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 10:10:13 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 10:10:13 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 10:10:13 INFO - Using env: {'DISPLAY': ':0', 10:10:13 INFO - 'HOME': '/home/cltbld', 10:10:13 INFO - 'LANG': 'en_US.UTF-8', 10:10:13 INFO - 'LANGUAGE': 'en_US:en', 10:10:13 INFO - 'LOGNAME': 'cltbld', 10:10:13 INFO - 'MAIL': '/var/mail/cltbld', 10:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:13 INFO - 'MOZ_NO_REMOTE': '1', 10:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:13 INFO - 'NO_EM_RESTART': '1', 10:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:13 INFO - 'PWD': '/builds/slave/test', 10:10:13 INFO - 'SHELL': '/bin/bash', 10:10:13 INFO - 'SHLVL': '1', 10:10:13 INFO - 'TERM': 'linux', 10:10:13 INFO - 'TMOUT': '86400', 10:10:13 INFO - 'USER': 'cltbld', 10:10:13 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', 10:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:13 INFO - '_': '/tools/buildbot/bin/python'} 10:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:13 INFO - Running setup.py (path:/tmp/pip-KOwfMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:13 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)) 10:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:13 INFO - Running setup.py (path:/tmp/pip-KWD5Mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:14 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)) 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:14 INFO - Running setup.py (path:/tmp/pip-r4NQ3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:14 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)) 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:14 INFO - Running setup.py (path:/tmp/pip-I0jSii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:14 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)) 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:14 INFO - Running setup.py (path:/tmp/pip-2OEluC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:14 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)) 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:14 INFO - Running setup.py (path:/tmp/pip-9luCyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:14 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)) 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:14 INFO - Running setup.py (path:/tmp/pip-XlePBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:14 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)) 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:14 INFO - Running setup.py (path:/tmp/pip-UwZqKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:14 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)) 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:14 INFO - Running setup.py (path:/tmp/pip-Pmr3ZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:14 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)) 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:14 INFO - Running setup.py (path:/tmp/pip-iSiq5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:14 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)) 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:14 INFO - Running setup.py (path:/tmp/pip-rK5Nyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:14 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)) 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:14 INFO - Running setup.py (path:/tmp/pip-kYAe7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:14 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)) 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:14 INFO - Running setup.py (path:/tmp/pip-1OlITz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:14 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)) 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:14 INFO - Running setup.py (path:/tmp/pip-OP0cYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:14 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)) 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:14 INFO - Running setup.py (path:/tmp/pip-jWoNOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:14 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)) 10:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:14 INFO - Running setup.py (path:/tmp/pip-AU5bWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:15 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)) 10:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:15 INFO - Running setup.py (path:/tmp/pip-kFI42B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:15 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)) 10:10:15 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)) 10:10:15 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)) 10:10:15 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)) 10:10:15 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)) 10:10:15 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)) 10:10:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:10:15 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 10:10:15 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 10:10:15 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 10:10:15 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 10:10:15 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 10:10:15 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 10:10:17 INFO - Downloading blessings-1.6.tar.gz 10:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:10:17 INFO - Installing collected packages: blessings 10:10:17 INFO - Running setup.py install for blessings 10:10:17 INFO - Successfully installed blessings 10:10:17 INFO - Cleaning up... 10:10:17 INFO - Return code: 0 10:10:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:10:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:17 INFO - Reading from file tmpfile_stdout 10:10:17 INFO - Current package versions: 10:10:17 INFO - argparse == 1.2.1 10:10:17 INFO - blessings == 1.6 10:10:17 INFO - blobuploader == 1.2.4 10:10:17 INFO - docopt == 0.6.1 10:10:17 INFO - functools32 == 3.2.3-2 10:10:17 INFO - jsonschema == 2.5.1 10:10:17 INFO - manifestparser == 1.1 10:10:17 INFO - mozInstall == 1.12 10:10:17 INFO - mozcrash == 1.0 10:10:17 INFO - mozdebug == 0.1 10:10:17 INFO - mozdevice == 0.49 10:10:17 INFO - mozfile == 1.2 10:10:17 INFO - mozhttpd == 0.7 10:10:17 INFO - mozinfo == 0.9 10:10:17 INFO - mozleak == 0.1 10:10:17 INFO - mozlog == 3.4 10:10:17 INFO - moznetwork == 0.27 10:10:17 INFO - mozprocess == 0.24 10:10:17 INFO - mozprofile == 0.28 10:10:17 INFO - mozrunner == 6.13 10:10:17 INFO - mozscreenshot == 0.1 10:10:17 INFO - mozsystemmonitor == 0.3 10:10:17 INFO - moztest == 0.8 10:10:17 INFO - mozversion == 1.4 10:10:17 INFO - psutil == 3.1.1 10:10:17 INFO - requests == 1.2.3 10:10:17 INFO - wsgiref == 0.1.2 10:10:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:17 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')]} 10:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:17 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')]} 10:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:17 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb3f0>, '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 0x26bbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bc1a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', '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 10:10:17 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 10:10:17 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 10:10:17 INFO - Using env: {'DISPLAY': ':0', 10:10:17 INFO - 'HOME': '/home/cltbld', 10:10:17 INFO - 'LANG': 'en_US.UTF-8', 10:10:17 INFO - 'LANGUAGE': 'en_US:en', 10:10:17 INFO - 'LOGNAME': 'cltbld', 10:10:17 INFO - 'MAIL': '/var/mail/cltbld', 10:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:17 INFO - 'MOZ_NO_REMOTE': '1', 10:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:17 INFO - 'NO_EM_RESTART': '1', 10:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:17 INFO - 'PWD': '/builds/slave/test', 10:10:17 INFO - 'SHELL': '/bin/bash', 10:10:17 INFO - 'SHLVL': '1', 10:10:17 INFO - 'TERM': 'linux', 10:10:17 INFO - 'TMOUT': '86400', 10:10:17 INFO - 'USER': 'cltbld', 10:10:17 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', 10:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:17 INFO - '_': '/tools/buildbot/bin/python'} 10:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:17 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)) 10:10:17 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)) 10:10:17 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)) 10:10:17 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)) 10:10:17 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)) 10:10:17 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)) 10:10:17 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)) 10:10:17 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)) 10:10:17 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)) 10:10:17 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)) 10:10:17 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)) 10:10:17 INFO - Cleaning up... 10:10:17 INFO - Return code: 0 10:10:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:10:17 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')]} 10:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:17 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')]} 10:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:17 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 0x234c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bdc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26bb3f0>, '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 0x26bbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bc1a0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', '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 10:10:17 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 10:10:17 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 10:10:17 INFO - Using env: {'DISPLAY': ':0', 10:10:17 INFO - 'HOME': '/home/cltbld', 10:10:17 INFO - 'LANG': 'en_US.UTF-8', 10:10:17 INFO - 'LANGUAGE': 'en_US:en', 10:10:17 INFO - 'LOGNAME': 'cltbld', 10:10:17 INFO - 'MAIL': '/var/mail/cltbld', 10:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:17 INFO - 'MOZ_NO_REMOTE': '1', 10:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:17 INFO - 'NO_EM_RESTART': '1', 10:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:17 INFO - 'PWD': '/builds/slave/test', 10:10:17 INFO - 'SHELL': '/bin/bash', 10:10:17 INFO - 'SHLVL': '1', 10:10:17 INFO - 'TERM': 'linux', 10:10:17 INFO - 'TMOUT': '86400', 10:10:17 INFO - 'USER': 'cltbld', 10:10:17 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', 10:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:17 INFO - '_': '/tools/buildbot/bin/python'} 10:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:10:18 INFO - Cleaning up... 10:10:18 INFO - Return code: 0 10:10:18 INFO - Running post-action listener: _resource_record_post_action 10:10:18 INFO - Running post-action listener: _start_resource_monitoring 10:10:18 INFO - Starting resource monitoring. 10:10:18 INFO - [mozharness: 2017-01-12 18:10:18.057401Z] Finished create-virtualenv step (success) 10:10:18 INFO - [mozharness: 2017-01-12 18:10:18.057908Z] Running install step. 10:10:18 INFO - Running pre-action listener: _resource_record_pre_action 10:10:18 INFO - Running main action method: install 10:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:18 INFO - Reading from file tmpfile_stdout 10:10:18 INFO - Detecting whether we're running mozinstall >=1.0... 10:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:10:18 INFO - Reading from file tmpfile_stdout 10:10:18 INFO - Output received: 10:10:18 INFO - Usage: mozinstall [options] installer 10:10:18 INFO - Options: 10:10:18 INFO - -h, --help show this help message and exit 10:10:18 INFO - -d DEST, --destination=DEST 10:10:18 INFO - Directory to install application into. [default: 10:10:18 INFO - "/builds/slave/test"] 10:10:18 INFO - --app=APP Application being installed. [default: firefox] 10:10:18 INFO - mkdir: /builds/slave/test/build/application 10:10:18 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'] 10:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:10:34 INFO - Reading from file tmpfile_stdout 10:10:34 INFO - Output received: 10:10:34 INFO - /builds/slave/test/build/application/firefox/firefox 10:10:34 INFO - Running post-action listener: _resource_record_post_action 10:10:34 INFO - [mozharness: 2017-01-12 18:10:34.449285Z] Finished install step (success) 10:10:34 INFO - [mozharness: 2017-01-12 18:10:34.449563Z] Running run-tests step. 10:10:34 INFO - Running pre-action listener: _resource_record_pre_action 10:10:34 INFO - Running main action method: run_tests 10:10:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:10:34 INFO - Python 2.7.3 10:10:34 INFO - Return code: 0 10:10:34 INFO - grabbing minidump binary from tooltool 10:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:34 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 0x26bb3f0>, '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 0x26bbcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26bc1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:10:34 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 10:10:34 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 10:10:34 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 10:10:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:10:34 INFO - Return code: 0 10:10:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:10:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:10:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:10:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:10:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:10:34 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/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 10:10:34 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/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 10:10:34 INFO - Using env: {'DISPLAY': ':0', 10:10:34 INFO - 'HOME': '/home/cltbld', 10:10:34 INFO - 'LANG': 'en_US.UTF-8', 10:10:34 INFO - 'LANGUAGE': 'en_US:en', 10:10:34 INFO - 'LOGNAME': 'cltbld', 10:10:34 INFO - 'MAIL': '/var/mail/cltbld', 10:10:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:10:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:34 INFO - 'MOZ_NO_REMOTE': '1', 10:10:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:34 INFO - 'NO_EM_RESTART': '1', 10:10:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:34 INFO - 'PWD': '/builds/slave/test', 10:10:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:10:34 INFO - 'SHELL': '/bin/bash', 10:10:34 INFO - 'SHLVL': '1', 10:10:34 INFO - 'TERM': 'linux', 10:10:34 INFO - 'TMOUT': '86400', 10:10:34 INFO - 'USER': 'cltbld', 10:10:34 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983', 10:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:34 INFO - '_': '/tools/buildbot/bin/python'} 10:10:34 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/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 10:10:34 INFO - mozversion application_buildid: 20170112173435 10:10:34 INFO - mozversion application_changeset: 571286200177ae7ddfa1893c6b42853b60f2e81e 10:10:34 INFO - mozversion application_display_name: Nightly 10:10:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:10:34 INFO - mozversion application_name: Firefox 10:10:34 INFO - mozversion application_remotingname: firefox 10:10:34 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 10:10:34 INFO - mozversion application_vendor: Mozilla 10:10:34 INFO - mozversion application_version: 53.0a1 10:10:34 INFO - mozversion platform_buildid: 20170112173435 10:10:34 INFO - mozversion platform_changeset: 571286200177ae7ddfa1893c6b42853b60f2e81e 10:10:34 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 10:10:34 INFO - mozversion platform_version: 53.0a1 10:10:34 INFO - using testdate: 1484244634 10:10:34 INFO - actual date: 1484244634 10:10:34 INFO - starting webserver on 'localhost:46487' 10:10:34 INFO - SUITE-START | Running 2 tests 10:10:34 INFO - TEST-START | dromaeo_css 10:10:34 INFO - operating with platform_type : linux_ 10:10:34 INFO - Initialising browser for dromaeo_css test... 10:10:34 INFO - TEST-INFO | started process 9918 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1pyAT5/profile http://localhost:46487/getInfo.html) 10:10:38 INFO - PROCESS | 9918 | __metrics Screen width/height:1600/1200 10:10:38 INFO - PROCESS | 9918 | colorDepth:24 10:10:38 INFO - PROCESS | 9918 | Browser inner width/height: 1024/697 10:10:38 INFO - PROCESS | 9918 | __metrics 10:10:39 INFO - PROCESS | 9918 | 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" 10:10:39 INFO - PROCESS | 9918 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:10:39 INFO - PROCESS | 9918 | console.error: PushService: 10:10:39 INFO - PROCESS | 9918 | stateChangeProcessEnqueue: Error transitioning state 10:10:39 INFO - PROCESS | 9918 | UnknownError 10:10:40 INFO - TEST-INFO | 9918: exit 0 10:10:40 INFO - Browser initialized. 10:10:40 INFO - Running cycle 1/1 for dromaeo_css test... 10:10:40 INFO - TEST-INFO | started process 10005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1pyAT5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:52 INFO - PROCESS | 10005 | RSS: Main: 152231936 10:10:52 INFO - PROCESS | 10005 | 10:13:57 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:46487/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46487/tests/dromaeo/cssquery-ext.html) 10:13:59 INFO - PROCESS | 10005 | RSS: Main: 243748864 10:13:59 INFO - PROCESS | 10005 | 10:15:41 INFO - PROCESS | 10005 | ************************* 10:15:41 INFO - PROCESS | 10005 | A coding exception was thrown and uncaught in a Task. 10:15:41 INFO - PROCESS | 10005 | 10:15:41 INFO - PROCESS | 10005 | Full message: ReferenceError: fetch is not defined 10:15:41 INFO - PROCESS | 10005 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 10:15:41 INFO - PROCESS | 10005 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 10:15:41 INFO - PROCESS | 10005 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 10:15:41 INFO - PROCESS | 10005 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 10:15:41 INFO - PROCESS | 10005 | TaskImpl@resource://gre/modules/Task.jsm:277:3 10:15:41 INFO - PROCESS | 10005 | asyncFunction@resource://gre/modules/Task.jsm:252:14 10:15:41 INFO - PROCESS | 10005 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 10:15:41 INFO - PROCESS | 10005 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 10:15:41 INFO - PROCESS | 10005 | TaskImpl@resource://gre/modules/Task.jsm:277:3 10:15:41 INFO - PROCESS | 10005 | asyncFunction@resource://gre/modules/Task.jsm:252:14 10:15:41 INFO - PROCESS | 10005 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 10:15:41 INFO - PROCESS | 10005 | 10:15:41 INFO - PROCESS | 10005 | ************************* 10:17:02 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:46487/tests/dromaeo/cssquery-ext.html (next: http://localhost:46487/tests/dromaeo/cssquery-jquery.html) 10:17:02 INFO - PROCESS | 10005 | RSS: Main: 247877632 10:17:02 INFO - PROCESS | 10005 | 10:20:05 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:46487/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46487/tests/dromaeo/cssquery-mootools.html) 10:20:05 INFO - PROCESS | 10005 | RSS: Main: 183934976 10:20:05 INFO - PROCESS | 10005 | 10:23:07 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:46487/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46487/tests/dromaeo/cssquery-prototype.html) 10:23:08 INFO - PROCESS | 10005 | RSS: Main: 205787136 10:23:08 INFO - PROCESS | 10005 | 10:26:11 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:46487/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46487/tests/dromaeo/cssquery-yui.html) 10:26:12 INFO - PROCESS | 10005 | RSS: Main: 184750080 10:26:12 INFO - PROCESS | 10005 | 10:29:15 INFO - PROCESS | 10005 | Cycle 1(1): loaded http://localhost:46487/tests/dromaeo/cssquery-yui.html (next: http://localhost:46487/tests/dromaeo/cssquery-dojo.html) 10:29:15 INFO - PROCESS | 10005 | RSS: Main: 278999040 10:29:15 INFO - PROCESS | 10005 | 10:29:15 INFO - PROCESS | 10005 | __start_tp_report 10:29:15 INFO - PROCESS | 10005 | _x_x_mozilla_page_load 10:29:15 INFO - PROCESS | 10005 | _x_x_mozilla_page_load_details 10:29:15 INFO - PROCESS | 10005 | |i|pagename|runs| 10:29:15 INFO - PROCESS | 10005 | |0;dojo.html;2561.231630510846;2629.605559166126;2648.4173481833996;2655.6813182418114;2659.0959073914864;4760.9523904760945;4822.686555266592;4824.276358546211;4892.119418504668;4948.356713627228;4845.248986407104;4859.805607775694;4877.122118018755;4892.4862889396545;4974.204127339626;4305.763183024932;4375.1031038637;4395.274779661352;4466.441694788152;4476.9552304476865;4379.2336341140335;4443.711158774686;4474.865754027368;4493.123840851035;4549.454065512126;4459.264221403465;4492.0791237796175;4519;4543.7728113594185;4548.454185497745;4373.431453911003;4395.802188901507;4404.207242696313;4410.845620403303;4485.147821913859;4388.868333949987;4431.800568974404;4440.844570440051;4469.240229161051;4499.572540608637;4773.949731059161;4815.470298267188;4819.084373968934;4822.059698358787;4850.75746212688;5019.372578427697;5037.874053148664;5186.377634683824;5188.584913206934;5226.529612334908;5129.897402051975;5130.025295193901;5138.640295179339;5143.434222235551;5151.66514176581;4842.15262329091;4882.414110306786;4891.413030436299;4893.119238537026;4893.84994526286;5280.181571856291;5288.418273989858;5292.576593872481;5294.364676238799;5347.144456886879;5008.69947803133;5051.747412629354;5053.9241911371355;5057.468965758616;5065.164247899055;5071.568916642127;5198.844034678966;5201.973990130101;5203.427622961472;5207.557357624569;5044.722540260321;5083.415407228142;5109.131447653907;5124.128898087334;5178.456262092426;5143.202803565453;5152.948470515322;5157.071727089085;5157.8452646420665;5205.375354957429;4302.440682711227;4377.190219809346;4389.078293558325;4391.231534481453;4430.091831174602;3761.755485893408;3809.5999920008553;3815.5993620669983;3816.561095474056;3855.7300988930506;4434.268345722984;4438.7114837535455;4439.445069366329;4440.089781594766;4442.111577684476;5226.242194881721;5227.60792940531;5231.163013917755;5231.346081739783;5234.18870075139;4391.165678521071;4427.535108813592;4431.468223813099;4432.645388368987;4432.756198409118;4661.440627124767;4667.159911216014;4668.0197158597075;4668.346431499593;4679.742614156254;4802.063597598435;4866.780994855169;4870.09903167915;4872.926906096341;4873.19592267279;5183.740812959412;5184.274201611702;5186.559142472932;5189.6107791915;5194.662346947436;4883.218685010382;4886.731229782396;4900.387451568554;4900.754962251945;4945.357103576512;4965.379327584052;5003.549680528624;5005;5054.898902022012;5152.124138896322;5109;5125.256837758429;5148.6910785353;5150.124478838681;5162.432132465351;5031.345925029723;5032.370953630796;5032.974835125801;5059.822906198266;5075.974620126875;5017.8243761468175;5021.924671129863;5023.372078490189;5024.799008039638;5073.289739436408;4870.707757534559;4904.730239836843;4906.8773280668265;4966.155753521982;4975.139205547452;5012.348394708664;5013.924791128063;5023.924641130459;5053.393592768744;5107.69353838756;4936.185529387611;4937.136001199848;4937.851864444073;4942.20924652054;4982.8754281143265 10:29:15 INFO - PROCESS | 10005 | |1;ext.html;544.3359101895687;578.8408187748369;579.3135134865183;592.3247497852446;621.2048577820392;35779.46330805037;39913.60086399135;39935.80032099839;40047.199056018864;40062;40557.39163912544;41183;41263.38104928428;41296.38055429171;41346.17307653853;7681.615919204045;7849.843003139934;7880.133185349607;7902;8088.636011379502;10270.640527581536;10476.790464190712;10512.684619461428;10870;10878.456077196148;10433.061024507793;10482.056614904657;10499.527521261562;10503.422311772849;10523.73690657732;10486.842697359545;10560.78878422431;10563.94718026405;10568.418736969463;10575.841362379571;10312.02035806597;10379.688609341732;10386.948065259701;10397.688069357931;10399.06408423238;40136;40322.395164072266;40369.798151009054;40453.19093618111;40482.39276410856;3658.5426821647293;3690.2435000824767;3709.3508635988865;3758.755680880734;3799.25914446683;28812.567811482844;29416.41167176666;29473.115806525624;29543.26141846471;29544;3188.2348236423322;3231.951520727191;3328.783629064103;3360.8487618057247;3426.0749597608506;241232;242345;242520;242679;243203.99999999822;56699.43300567024;57559;57582.7120864393;58023.419765802646;58038.7098064507;61070;61268.08097878535;61307.38692613106;61376.38623613796;61412.69293653503;14681.48614798477;15189;15194.848051519344;15204.163770992702;15211.315490802941;10538;10855.348679079281;11183.776324473465;11466.656000320003;11494.540218391337;18700;18761.437156885044;18832.435026949213;18859.3399231029;18868.226354729108;6505.41451269388;6520.18497687789;6646.136002319764;6706.664666766642;6726.663666816639;797.2983774278598;805.9717909873126;815.7267315449272;818.1899919080187;830.8047608811925;26908.32729181747;27624.723752762617;27987.300317492227;28131.43737125246;28281.858590706914;954.7708549947962;962.815239932966;968.4721826604517;991.7917237380086;996.2627655534997;15136.772948405784;15138.772918406232;15391.230438478031;15410.460633877761;15439.84560154384;337776;383421;394286;395655;576281;45932.311015334795;45982;45992.62022139274;46026.30960535595;46101.30848037282;1208.7159517513378;1226.4848763519344;1250.8186312984567;1257.5787111317811;1258.3959699344366;25743.524624176247;26596.20211393661;26695.19914402571;27121.86439067792;27230.183094507196;40030.1993960125;40380.798096009334;40493;40545.1890962185;40604.79697601493;297086;298724;298921;298939;298940;19451.221951121795;19862.90068549648;21459.141634334454;24064.15775447851;24722.629160562246;38145;38415.15848415136;38536.80731596324;38901.41647875341;39192;31525.527117092803;32646.673533265315;32722.672773271963;32810.50784238286;34318.828405857814;32704.345913081128;32856.50715239225;33514.83242583869;33677.49483757795;34201.65798341985;30205.546916796706;30234.2441438957;30347.848260758554;30428.39143217079;33263.83368083144;27747.861260693568;30175.245618858826;31241.531377029816;31274.21814454657;31274.687253127177;23230.793074658555;23467.41331466727;23635.29094127179;23973.40066498282;24093.277201683977 10:29:15 INFO - PROCESS | 10005 | |2;jquery.html;361.6835269139503;376.80971109589655;386.63269893601085;387.3086540525162;421.881873075539;13691.178529288238;17406.477805665836;17716.291348346065;18215.36246231382;18351.174197161126;16194;17013.31946722133;17639.647207055885;17757.200925958332;17778.46664600064;4992.425871024833;5316.3354580677415;5348.411674715798;5349.384820745625;5350.3312085989255;3973.3245348290716;4155.584441555835;5274.841754747364;5355.143177091666;5364.812231571896;6047.969760151215;6308.369163083677;6320.273168585602;6430.7749228777;6435.8391040223905;6236.781712640036;6299.244090709099;6381.298057213703;6398.168238129037;6401.3598640135615;5675.460831221028;5677.17680936262;5684.431556844283;5693.886122277573;5694.174344720034;21887;22107.889460552757;22317.77682223173;22366.88816555923;22416.32751017472;2295.31140657802;2313.3866455398615;2313.4332088638225;2317.8261630377788;2409.6867407237123;13836.377363018688;13982.510612128526;14134.15195088298;14137.717245655133;14543.92728036353;1726.413019573351;1762.5769815244248;1784.3041213926579;1793.641271745643;1802.8016918138994;78983.21016789816;79701.60149199275;80322;80684;80892.59553702195;10139.797204055878;10270.178385729123;10296.588136474456;10497.475126243657;10499.212559058102;14530.273486325641;14583.562493125222;14591.124532528082;14597.78103328451;14602.926985365219;7616.961915190499;7821.1676827593055;7832.647530861125;7833.33416659579;7949.284564389232;7285.453590980697;7372;7608.391328693802;7610.429217808686;7622.885656715153;6674.666266686646;6784.457243420613;6792.694328755218;6818.318168183241;6906.551074180162;1852.2405813616622;1852.397970659541;1880.2760937039066;1913.3112079651314;1930.845532357408;986.7237173591406;1001.4692213127055;1018.2770233134557;1018.8573599696049;1026.9075783179549;16200.108994005208;16347.673046539003;16692;17181.31274749021;17325.56686082858;959.2469911119738;994.1351024608637;1003.4631472162358;1018.5976539266948;1025.190099821148;9358.298127640453;9606.471644059504;9920.603175872884;9933.205343572497;10088.49557522121;427400;441648;444355.34268901945;446258;510249;79654;97413;97821;99156.50421747845;100100.49949750205;825.3191117328348;837.2213841127688;868.5136323658771;870.303756994402;879.520661239626;16394.18029098564;16919.83080169232;17289.308427662752;17307.913460432617;17416.912915435343;40058;40277.59028433991;40450.797746011085;40552;40572.59427405688;54186.72906635599;56044.43955560555;58589.4141058601;59613;59901;8274.58627068632;8315.792105197177;8423.4945903246;8535.189157030072;8535.359848011549;12043.337616431181;12373.62879113628;12523.311217883103;13003.544875929298;13353.332333383098;10844.403557804397;10935.125189984623;10992.28550144238;11015.559377625126;11370.772584548427;5450.8909821802545;7498.062742157231;11061.281016733887;11334.14993875446;11345.092392608407;10551.314164579278;10830.458477076272;11311.321320720454;11373.31760094397;11485.827712584485;7321.267873212636;7339.449541284532;7445.516041457288;7842.686292548462;8447.239748422671;9636.903630963601;10550.261481696207;10933.180011499011;11089.05743011853;11243.269187503114 10:29:15 INFO - PROCESS | 10005 | |3;mootools.html;1359.938802753876;1367.1387026173509;1369.7671395862703;1384.6261509392464;1392.7423426666062;6687.364700353464;7076.575405475675;7125.180604230509;7134.536255143418;7136.3220494052985;6163.8150855474405;6378.744850205998;6798;7023.051887995119;7036.085308909835;2121.2575598540543;2153.666181741825;2158.2661894955713;2159.9784002160013;2161.8702877827304;2123.9150433982622;2153.3001774423296;2161.794629510202;2164;2164.2208804830248;1823.3891646298505;1885.5003424092627;2050.190174880921;2125.0543508138885;2129.744430668322;2106.378618307603;2109.9472513187293;2112.355731501891;2113.8837363944976;2115.481706981784;2012.1548949441124;2029.0869108900906;2034.4100210938957;2091.4248581640018;2126.53216292417;7071.823204419879;7125.358717715379;7130.144382674061;7136.0723105995885;7137.714491420337;4168.979155104205;4290.442242508454;4297.462817147856;4298.269294219959;4301.870943871689;2750.972490275112;2889.0754958413318;2924.8245105293536;2930.8974185903603;2935.060780550225;1102.7408558988632;1136.6078702847503;1157.7163594919214;1202.6452196602024;1207.5833837326109;9117;9147.405418647766;9176.632934682604;9194.034626364202;9203;3857.556381016219;4025.376066709665;4081.89795255121;4084.6732261419015;4091.059056416981;8152.38857085721;8155.714549990722;8156.225158609923;8163.10205877353;8166.142555031755;4452.398926144993;4455.242608756519;4455.6658250631335;4459;4459.509453960061;3434.845431955568;3538.929221415557;3935.193285376491;4100.200460910094;4118.279301122292;3417.3677869594203;3476.8526386292465;3568.6966607838103;3583.569971603424;3621.0947263184203;1125.6904351303458;1148.075798981811;1157.0859021373021;1157.9189456738115;1162.8953394194393;828.1552816127517;835.8662613981734;851.114840565817;870.0342619692136;871.7210492642294;4791.113643975806;4820.156472617278;4846.927296090562;5015.122353588107;5040.974795126074;545.3047364610075;545.4273013335982;559.9160125981053;567.1747607231468;569.163329905039;3257.4136655402253;3274.5743053402907;3285.967140328614;3311.089450401159;3405.4040542905386;8046.597670116471;8488.702895398632;8491.575421228914;8493.745187644381;8503.404761666749;8443.74668759926;8447.704330348408;8449.662013519513;8450.830983380298;8464.40749147566;6670.299618540081;6731.091302674175;6738.561993470409;6742.730290788313;6744.966275168593;4706.247000479907;4759.833405830779;4845.103655823684;5134.76893539799;5147.768350424315;7505.211952744883;7688.577128258;7693.961530192313;7776.339011184113;7978.162292959156;7825.530468171928;7854.096778870503;7894.84210315779;7928.524288542706;7951.761447156595;5527.281453411031;5721.342045664802;6035.818925432244;6076.574639775174;6128.662923539248;6517.804465866032;6805.6937437816405;6833.760818371532;6939.861202776017;6958.930410695828;5984.491318237824;6044.727987240497;6115.235595550556;6160.16837726919;6201.844953876009;5995.970020149872;6011.398860113954;6016.669083200466;6033.909491357721;6061.848453788691;5389.784408623611;5468.316460442445;5481.698506582176;5482.205080263419;5488.039593071277;4132.462779838602;4171.416001759817;4226.788660567021;4292.463442069741;4319.827206911688;4108.219438306712;4137.855175068858;4357;4386.7367957922625;4391.582799634158 10:29:15 INFO - PROCESS | 10005 | |4;prototype.html;357.06271038523874;367.52038589640506;367.81976831352637;372.7521198403062;378.71974738693376;4902.779374928128;4906.63200259981;4913.705177689341;4937.629677774168;4983.775730092146;4682.695624784386;4692.929606055912;4773.5226477352335;4820.927686084711;4859.902801943959;3951.9407208891816;3955.129871428281;3956.1889812588493;3964.6035396460265;3979.1444839359533;3962.5244970603426;3971.761694298337;3980;4000.459937908389;4016.7389119707127;3763.3978563429855;3852.0947577319307;3855.9228815423676;3881.165549406877;3908.609139086097;3887.5334959804864;3893.4743809585625;3894.9026274343087;3904.902377440558;3920.7059470539825;3512.947305790415;3525.2244506208594;3527.7775001748732;3537.876174333886;3547.733919955988;4536.570980141245;4716.646251531149;4796.664233503656;4851.714295711639;4869.099216644932;4295.656347492193;4308.9406521369865;4309.5690430956965;4347.500037495697;4362.1275744851155;5095.5923526118195;5112.71880046601;5125.718085505296;5139.922901156486;5154.355705536808;3589.6589823966942;3680.4663323818163;3689.8192578374933;3693.445983102529;3695.5195824542907;5283.471652834686;5305.946940530584;5324.840254792362;5329.680219186784;5331.360236771612;3741.7567858089137;3747.8500859965843;3755.830987605564;3764.4541541476333;3766.209096089797;3774.3772277573894;3793.7344385893275;3798.639129282714;3837.5609146570037;3841.2125514269505;4250.213710463574;4303.462067241595;4308.80610372534;4362.912741745147;4395.7362558246605;5054.646174767805;5075.949240507622;5087.491250874883;5098.286239926413;5107.565856902205;1206.945687444067;1270.30133426615;1285.7878450055823;1289.4648720780958;1289.619562229126;816.901267794815;862.3790870573177;869.7955980344614;884.5533005832013;891.4027601507006;4263.978680106579;4287.2711639021445;4323;4336.696431249782;4351.934720979188;5100.285959965608;5107.361579802525;5109.335786347751;5118.513741194581;5118.718470484085;4209.568746626162;4329.480462344539;4337.416842852399;4471.418715567021;4492.3710680504755;2740.9177724668293;2743.067357098596;2753.1740477856965;2753.3942532642786;2756.4487102579565;4785.688930219525;4790.718357924833;4790.976045119752;4846.830360937351;4859.781309841065;5064.417591976896;5174.275601415805;5182.870428239325;5213.60897932649;5220.851412689202;4699.436067671902;4727.834525791581;4821.975890120597;4831.782569784368;4846.588040016638;5118.41138269089;5123.949590333898;5131.538161565477;5135.974320128375;5175.611829112907;4904.798324410543;5052.7726252318;5059.468755780737;5072.402193309096;5114.795408183631;4828.227483602606;4836.685615434985;4840.91079507108;4850.563449289581;4865.391826021747;3644.1982763791925;3660.908477288089;3669.5779985302033;3670.724695647784;3698.1863989922176;4900.313956046085;5131.946491837351;5190.195519694454;5191.00292774554;5193.7403129842605;4981.37732783402;4994.700317980933;4997.800087996439;5001.749912504433;5023.296738456692;4997.675151115312;5003.799848006039;5007.974960125176;5043.672161309503;5052.166392545336;4818.95181048185;4882.316475693335;4927.659361803115;5107.591392688501;5135.589152867687;4990.3762029746285;5060.367454068241;5125.564327032244;5136.9743151284;5142.305788718625;4987.326710893983;5035.546800787946;5038.823641172688;5050.924236136388;5051.595872330278 10:29:15 INFO - PROCESS | 10005 | |5;yui.html;679.1035832700834;679.4835924697229;733.8348871503912;736.5102207032323;752.2364799728275;12973.870261297385;13775.448982040718;13834.16994980302;13853.168809871415;13864.098833575836;14471.927640361784;15049.24753762313;15055.548333549983;15337;15367.077975321488;650.5901282192212;800.2077942836579;815.1155995744624;815.7348861619968;817.0399780258202;668.0180135201247;796.4026979765176;818.6725309876037;828.3662997806682;831.5301854452246;859.2782063067023;860.0754189246554;861.1345597674328;861.625193041026;862.7153039496982;680.6562685843667;849.4478588917253;851.6167724523958;851.6337974670889;853.4154104438448;518.5229588778333;610.057461222408;620.7082671144555;626.4831514000967;627.9089532017878;14253.928730356385;14269.500567480089;14291.928540357336;14294.142351458842;14302.57092287233;12096.092793040558;12243.510259589606;12566;12589.118761686686;12968.740625187538;12197.20718153326;12324;12418.130730848845;12583.811242831365;12703.301318427482;3783.3190025795348;3880.301545721769;3890.9027274318087;3974.5826688197612;3982;64562.67718661424;65507.67246163739;66167.3383266166;66408.3359166407;67394;9847.507624618884;9869.259805514615;9923.503824808875;10053.849192262122;10103.343282686748;16951.576210594834;17086.572835679206;19089.713654295196;19864.10611522485;19871.304504342566;6668.566543174775;6721.294264102199;6841.863162736718;6874.759383421556;7096.787096387116;3533.116720819795;3591.6408359163875;3612.1862655121417;3613.584437789688;3672.6878215351994;2960.86676099576;3009.1574359179463;3041.4981528047624;3057.5413687946984;3070.7082827131385;492.7265367720949;494.29069285575315;501.42586738185304;501.90714717777325;504.9394072711298;640.4908098062052;645.7546132469631;662.9303923088103;668.6623255256064;674.5649056358621;7900.762977110696;8030.829816042887;8296.585170741439;8492.830143397097;8553.230209281195;599.7840777320162;611.5749554059886;612.7059011674332;619.6591874469115;624.5284809968445;3914.197589494147;4000.119973605802;4056.8985775355854;4119.588041195856;4152.148809494047;53149.46850531523;70129;70216;72131.63934180296;72162.63918680478;59013.70493147593;60202;61161;62586.68706656529;62851;54923.450765492635;54989.72505137529;55471.44528554663;56713.716431417575;57807.13289300664;7787.727429540166;7844.764657060297;7867.449278550446;7882.960585197037;8081.717139900075;37209.25581488409;37222.62777372191;38261;38477.23045539018;39816.40275395814;43562.782186088865;45052.549474504835;47855;48583.27125093056;48681.26978095261;9377;9490.478023708762;9521.571529281338;9665.033496650278;9916.355436896578;9727.464989425649;9746.171575416169;9866;10390.948045260027;10516.579336826748;9687.56365226111;9927.354721943051;10205.540750666387;10250.077493025663;10428.53071611764;10244.180465562886;10673.57305707763;10686.519106640064;10897.509612067317;11097.334159950105;9479.857802132836;9997.900020999989;10069.748256293651;10243.897561024593;10247.282690211614;8092.09869143937;8152.225538573826;8237.176282371714;8247.298979586802;8599.312055035707;7066.187388450394;7816.218378162365;7839.137694853447;7887.132415434183;8064.112947575879 10:29:15 INFO - PROCESS | 10005 | __end_tp_report 10:29:15 INFO - PROCESS | 10005 | __start_cc_report 10:29:15 INFO - PROCESS | 10005 | _x_x_mozilla_cycle_collect,1622 10:29:15 INFO - PROCESS | 10005 | __end_cc_report 10:29:15 INFO - PROCESS | 10005 | __startTimestamp1484245755783__endTimestamp 10:29:15 INFO - PROCESS | 10005 | 10:29:15 INFO - PROCESS | 10005 | ------- Summary: start ------- 10:29:15 INFO - PROCESS | 10005 | Number of tests: 6 10:29:15 INFO - PROCESS | 10005 | 10:29:15 INFO - PROCESS | 10005 | [#0] dojo.html Cycles:165 Average:4771.07 Median:4900.75 stddev:507.41 (10.4%) stddev-sans-first:478.44 10:29:15 INFO - PROCESS | 10005 | Values: 2561.2 2629.6 2648.4 2655.7 2659.1 4761.0 4822.7 4824.3 4892.1 4948.4 4845.2 4859.8 4877.1 4892.5 4974.2 4305.8 4375.1 4395.3 4466.4 4477.0 4379.2 4443.7 4474.9 4493.1 4549.5 4459.3 4492.1 4519.0 4543.8 4548.5 4373.4 4395.8 4404.2 4410.8 4485.1 4388.9 4431.8 4440.8 4469.2 4499.6 4773.9 4815.5 4819.1 4822.1 4850.8 5019.4 5037.9 5186.4 5188.6 5226.5 5129.9 5130.0 5138.6 5143.4 5151.7 4842.2 4882.4 4891.4 4893.1 4893.8 5280.2 5288.4 5292.6 5294.4 5347.1 5008.7 5051.7 5053.9 5057.5 5065.2 5071.6 5198.8 5202.0 5203.4 5207.6 5044.7 5083.4 5109.1 5124.1 5178.5 5143.2 5152.9 5157.1 5157.8 5205.4 4302.4 4377.2 4389.1 4391.2 4430.1 3761.8 3809.6 3815.6 3816.6 3855.7 4434.3 4438.7 4439.4 4440.1 4442.1 5226.2 5227.6 5231.2 5231.3 5234.2 4391.2 4427.5 4431.5 4432.6 4432.8 4661.4 4667.2 4668.0 4668.3 4679.7 4802.1 4866.8 4870.1 4872.9 4873.2 5183.7 5184.3 5186.6 5189.6 5194.7 4883.2 4886.7 4900.4 4900.8 4945.4 4965.4 5003.5 5005.0 5054.9 5152.1 5109.0 5125.3 5148.7 5150.1 5162.4 5031.3 5032.4 5033.0 5059.8 5076.0 5017.8 5021.9 5023.4 5024.8 5073.3 4870.7 4904.7 4906.9 4966.2 4975.1 5012.3 5013.9 5023.9 5053.4 5107.7 4936.2 4937.1 4937.9 4942.2 4982.9 10:29:15 INFO - PROCESS | 10005 | 10:29:15 INFO - PROCESS | 10005 | [#1] ext.html Cycles:180 Average:47424.31 Median:3210.09 stddev:87500.21 (2725.8%) stddev-sans-first:87674.88 10:29:15 INFO - PROCESS | 10005 | Values: 544.3 578.8 579.3 592.3 621.2 35779.5 39913.6 39935.8 40047.2 40062.0 40557.4 41183.0 41263.4 41296.4 41346.2 7681.6 7849.8 7880.1 7902.0 8088.6 10270.6 10476.8 10512.7 10870.0 10878.5 10433.1 10482.1 10499.5 10503.4 10523.7 10486.8 10560.8 10563.9 10568.4 10575.8 10312.0 10379.7 10386.9 10397.7 10399.1 40136.0 40322.4 40369.8 40453.2 40482.4 3658.5 3690.2 3709.4 3758.8 3799.3 28812.6 29416.4 29473.1 29543.3 29544.0 3188.2 3232.0 3328.8 3360.8 3426.1 241232.0 242345.0 242520.0 242679.0 243204.0 56699.4 57559.0 57582.7 58023.4 58038.7 61070.0 61268.1 61307.4 61376.4 61412.7 14681.5 15189.0 15194.8 15204.2 15211.3 10538.0 10855.3 11183.8 11466.7 11494.5 18700.0 18761.4 18832.4 18859.3 18868.2 6505.4 6520.2 6646.1 6706.7 6726.7 797.3 806.0 815.7 818.2 830.8 26908.3 27624.7 27987.3 28131.4 28281.9 954.8 962.8 968.5 991.8 996.3 15136.8 15138.8 15391.2 15410.5 15439.8 337776.0 383421.0 394286.0 395655.0 576281.0 45932.3 45982.0 45992.6 46026.3 46101.3 1208.7 1226.5 1250.8 1257.6 1258.4 25743.5 26596.2 26695.2 27121.9 27230.2 40030.2 40380.8 40493.0 40545.2 40604.8 297086.0 298724.0 298921.0 298939.0 298940.0 19451.2 19862.9 21459.1 24064.2 24722.6 38145.0 38415.2 38536.8 38901.4 39192.0 31525.5 32646.7 32722.7 32810.5 34318.8 32704.3 32856.5 33514.8 33677.5 34201.7 30205.5 30234.2 30347.8 30428.4 33263.8 27747.9 30175.2 31241.5 31274.2 31274.7 23230.8 23467.4 23635.3 23973.4 24093.3 10:29:15 INFO - PROCESS | 10005 | 10:29:15 INFO - PROCESS | 10005 | [#2] jquery.html Cycles:180 Average:27691.73 Median:22015.66 stddev:75324.35 (342.1%) stddev-sans-first:75507.71 10:29:15 INFO - PROCESS | 10005 | Values: 361.7 376.8 386.6 387.3 421.9 13691.2 17406.5 17716.3 18215.4 18351.2 16194.0 17013.3 17639.6 17757.2 17778.5 4992.4 5316.3 5348.4 5349.4 5350.3 3973.3 4155.6 5274.8 5355.1 5364.8 6048.0 6308.4 6320.3 6430.8 6435.8 6236.8 6299.2 6381.3 6398.2 6401.4 5675.5 5677.2 5684.4 5693.9 5694.2 21887.0 22107.9 22317.8 22366.9 22416.3 2295.3 2313.4 2313.4 2317.8 2409.7 13836.4 13982.5 14134.2 14137.7 14543.9 1726.4 1762.6 1784.3 1793.6 1802.8 78983.2 79701.6 80322.0 80684.0 80892.6 10139.8 10270.2 10296.6 10497.5 10499.2 14530.3 14583.6 14591.1 14597.8 14602.9 7617.0 7821.2 7832.6 7833.3 7949.3 7285.5 7372.0 7608.4 7610.4 7622.9 6674.7 6784.5 6792.7 6818.3 6906.6 1852.2 1852.4 1880.3 1913.3 1930.8 986.7 1001.5 1018.3 1018.9 1026.9 16200.1 16347.7 16692.0 17181.3 17325.6 959.2 994.1 1003.5 1018.6 1025.2 9358.3 9606.5 9920.6 9933.2 10088.5 427400.0 441648.0 444355.3 446258.0 510249.0 79654.0 97413.0 97821.0 99156.5 100100.5 825.3 837.2 868.5 870.3 879.5 16394.2 16919.8 17289.3 17307.9 17416.9 40058.0 40277.6 40450.8 40552.0 40572.6 54186.7 56044.4 58589.4 59613.0 59901.0 8274.6 8315.8 8423.5 8535.2 8535.4 12043.3 12373.6 12523.3 13003.5 13353.3 10844.4 10935.1 10992.3 11015.6 11370.8 5450.9 7498.1 11061.3 11334.1 11345.1 10551.3 10830.5 11311.3 11373.3 11485.8 7321.3 7339.4 7445.5 7842.7 8447.2 9636.9 10550.3 10933.2 11089.1 11243.3 10:29:15 INFO - PROCESS | 10005 | 10:29:15 INFO - PROCESS | 10005 | [#3] mootools.html Cycles:180 Average:4662.87 Median:4931.02 stddev:2477.00 (50.2%) stddev-sans-first:2471.51 10:29:15 INFO - PROCESS | 10005 | Values: 1359.9 1367.1 1369.8 1384.6 1392.7 6687.4 7076.6 7125.2 7134.5 7136.3 6163.8 6378.7 6798.0 7023.1 7036.1 2121.3 2153.7 2158.3 2160.0 2161.9 2123.9 2153.3 2161.8 2164.0 2164.2 1823.4 1885.5 2050.2 2125.1 2129.7 2106.4 2109.9 2112.4 2113.9 2115.5 2012.2 2029.1 2034.4 2091.4 2126.5 7071.8 7125.4 7130.1 7136.1 7137.7 4169.0 4290.4 4297.5 4298.3 4301.9 2751.0 2889.1 2924.8 2930.9 2935.1 1102.7 1136.6 1157.7 1202.6 1207.6 9117.0 9147.4 9176.6 9194.0 9203.0 3857.6 4025.4 4081.9 4084.7 4091.1 8152.4 8155.7 8156.2 8163.1 8166.1 4452.4 4455.2 4455.7 4459.0 4459.5 3434.8 3538.9 3935.2 4100.2 4118.3 3417.4 3476.9 3568.7 3583.6 3621.1 1125.7 1148.1 1157.1 1157.9 1162.9 828.2 835.9 851.1 870.0 871.7 4791.1 4820.2 4846.9 5015.1 5041.0 545.3 545.4 559.9 567.2 569.2 3257.4 3274.6 3286.0 3311.1 3405.4 8046.6 8488.7 8491.6 8493.7 8503.4 8443.7 8447.7 8449.7 8450.8 8464.4 6670.3 6731.1 6738.6 6742.7 6745.0 4706.2 4759.8 4845.1 5134.8 5147.8 7505.2 7688.6 7694.0 7776.3 7978.2 7825.5 7854.1 7894.8 7928.5 7951.8 5527.3 5721.3 6035.8 6076.6 6128.7 6517.8 6805.7 6833.8 6939.9 6958.9 5984.5 6044.7 6115.2 6160.2 6201.8 5996.0 6011.4 6016.7 6033.9 6061.8 5389.8 5468.3 5481.7 5482.2 5488.0 4132.5 4171.4 4226.8 4292.5 4319.8 4108.2 4137.9 4357.0 4386.7 4391.6 10:29:15 INFO - PROCESS | 10005 | 10:29:15 INFO - PROCESS | 10005 | [#4] prototype.html Cycles:180 Average:4217.62 Median:4807.81 stddev:1194.87 (24.9%) stddev-sans-first:1162.56 10:29:15 INFO - PROCESS | 10005 | Values: 357.1 367.5 367.8 372.8 378.7 4902.8 4906.6 4913.7 4937.6 4983.8 4682.7 4692.9 4773.5 4820.9 4859.9 3951.9 3955.1 3956.2 3964.6 3979.1 3962.5 3971.8 3980.0 4000.5 4016.7 3763.4 3852.1 3855.9 3881.2 3908.6 3887.5 3893.5 3894.9 3904.9 3920.7 3512.9 3525.2 3527.8 3537.9 3547.7 4536.6 4716.6 4796.7 4851.7 4869.1 4295.7 4308.9 4309.6 4347.5 4362.1 5095.6 5112.7 5125.7 5139.9 5154.4 3589.7 3680.5 3689.8 3693.4 3695.5 5283.5 5305.9 5324.8 5329.7 5331.4 3741.8 3747.9 3755.8 3764.5 3766.2 3774.4 3793.7 3798.6 3837.6 3841.2 4250.2 4303.5 4308.8 4362.9 4395.7 5054.6 5075.9 5087.5 5098.3 5107.6 1206.9 1270.3 1285.8 1289.5 1289.6 816.9 862.4 869.8 884.6 891.4 4264.0 4287.3 4323.0 4336.7 4351.9 5100.3 5107.4 5109.3 5118.5 5118.7 4209.6 4329.5 4337.4 4471.4 4492.4 2740.9 2743.1 2753.2 2753.4 2756.4 4785.7 4790.7 4791.0 4846.8 4859.8 5064.4 5174.3 5182.9 5213.6 5220.9 4699.4 4727.8 4822.0 4831.8 4846.6 5118.4 5123.9 5131.5 5136.0 5175.6 4904.8 5052.8 5059.5 5072.4 5114.8 4828.2 4836.7 4840.9 4850.6 4865.4 3644.2 3660.9 3669.6 3670.7 3698.2 4900.3 5131.9 5190.2 5191.0 5193.7 4981.4 4994.7 4997.8 5001.7 5023.3 4997.7 5003.8 5008.0 5043.7 5052.2 4819.0 4882.3 4927.7 5107.6 5135.6 4990.4 5060.4 5125.6 5137.0 5142.3 4987.3 5035.5 5038.8 5050.9 5051.6 10:29:15 INFO - PROCESS | 10005 | 10:29:15 INFO - PROCESS | 10005 | [#5] yui.html Cycles:180 Average:15069.46 Median:610.82 stddev:19473.53 (3188.1%) stddev-sans-first:19498.18 10:29:15 INFO - PROCESS | 10005 | Values: 679.1 679.5 733.8 736.5 752.2 12973.9 13775.4 13834.2 13853.2 13864.1 14471.9 15049.2 15055.5 15337.0 15367.1 650.6 800.2 815.1 815.7 817.0 668.0 796.4 818.7 828.4 831.5 859.3 860.1 861.1 861.6 862.7 680.7 849.4 851.6 851.6 853.4 518.5 610.1 620.7 626.5 627.9 14253.9 14269.5 14291.9 14294.1 14302.6 12096.1 12243.5 12566.0 12589.1 12968.7 12197.2 12324.0 12418.1 12583.8 12703.3 3783.3 3880.3 3890.9 3974.6 3982.0 64562.7 65507.7 66167.3 66408.3 67394.0 9847.5 9869.3 9923.5 10053.8 10103.3 16951.6 17086.6 19089.7 19864.1 19871.3 6668.6 6721.3 6841.9 6874.8 7096.8 3533.1 3591.6 3612.2 3613.6 3672.7 2960.9 3009.2 3041.5 3057.5 3070.7 492.7 494.3 501.4 501.9 504.9 640.5 645.8 662.9 668.7 674.6 7900.8 8030.8 8296.6 8492.8 8553.2 599.8 611.6 612.7 619.7 624.5 3914.2 4000.1 4056.9 4119.6 4152.1 53149.5 70129.0 70216.0 72131.6 72162.6 59013.7 60202.0 61161.0 62586.7 62851.0 54923.5 54989.7 55471.4 56713.7 57807.1 7787.7 7844.8 7867.4 7883.0 8081.7 37209.3 37222.6 38261.0 38477.2 39816.4 43562.8 45052.5 47855.0 48583.3 48681.3 9377.0 9490.5 9521.6 9665.0 9916.4 9727.5 9746.2 9866.0 10390.9 10516.6 9687.6 9927.4 10205.5 10250.1 10428.5 10244.2 10673.6 10686.5 10897.5 11097.3 9479.9 9997.9 10069.7 10243.9 10247.3 8092.1 8152.2 8237.2 8247.3 8599.3 7066.2 7816.2 7839.1 7887.1 8064.1 10:29:15 INFO - PROCESS | 10005 | -------- Summary: end -------- 10:29:15 INFO - PROCESS | 10005 | 10:29:16 INFO - TEST-INFO | 10005: exit 0 10:29:16 INFO - TEST-OK | dromaeo_css | took 1121941ms 10:29:16 INFO - TEST-START | kraken 10:29:16 INFO - operating with platform_type : linux_ 10:29:16 INFO - Initialising browser for kraken test... 10:29:16 INFO - TEST-INFO | started process 10312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmputCDCb/profile http://localhost:46487/getInfo.html) 10:29:20 INFO - PROCESS | 10312 | __metrics Screen width/height:1600/1200 10:29:20 INFO - PROCESS | 10312 | colorDepth:24 10:29:20 INFO - PROCESS | 10312 | Browser inner width/height: 1024/697 10:29:20 INFO - PROCESS | 10312 | __metrics 10:29:21 INFO - PROCESS | 10312 | 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" 10:29:21 INFO - PROCESS | 10312 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:29:21 INFO - PROCESS | 10312 | console.error: PushService: 10:29:21 INFO - PROCESS | 10312 | stateChangeProcessEnqueue: Error transitioning state 10:29:21 INFO - PROCESS | 10312 | UnknownError 10:29:22 INFO - TEST-INFO | 10312: exit 0 10:29:22 INFO - Browser initialized. 10:29:22 INFO - Running cycle 1/1 for kraken test... 10:29:22 INFO - TEST-INFO | started process 10393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmputCDCb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:29:34 INFO - PROCESS | 10393 | RSS: Main: 152518656 10:29:34 INFO - PROCESS | 10393 | 10:29:37 INFO - PROCESS | 10393 | Cycle 1(1): loaded http://localhost:46487/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46487/tests/kraken/driver.html?testName=audio-beat-detection) 10:29:38 INFO - PROCESS | 10393 | RSS: Main: 206065664 10:29:38 INFO - PROCESS | 10393 | 10:29:40 INFO - PROCESS | 10393 | Cycle 1(1): loaded http://localhost:46487/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46487/tests/kraken/driver.html?testName=audio-dft) 10:29:41 INFO - PROCESS | 10393 | RSS: Main: 185835520 10:29:41 INFO - PROCESS | 10393 | 10:29:44 INFO - PROCESS | 10393 | Cycle 1(1): loaded http://localhost:46487/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46487/tests/kraken/driver.html?testName=audio-fft) 10:29:45 INFO - PROCESS | 10393 | RSS: Main: 268017664 10:29:45 INFO - PROCESS | 10393 | 10:29:47 INFO - PROCESS | 10393 | Cycle 1(1): loaded http://localhost:46487/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46487/tests/kraken/driver.html?testName=audio-oscillator) 10:29:48 INFO - PROCESS | 10393 | RSS: Main: 179826688 10:29:48 INFO - PROCESS | 10393 | 10:29:50 INFO - PROCESS | 10393 | Cycle 1(1): loaded http://localhost:46487/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46487/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:29:50 INFO - PROCESS | 10393 | RSS: Main: 183083008 10:29:50 INFO - PROCESS | 10393 | 10:29:54 INFO - PROCESS | 10393 | Cycle 1(1): loaded http://localhost:46487/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46487/tests/kraken/driver.html?testName=imaging-darkroom) 10:29:54 INFO - PROCESS | 10393 | RSS: Main: 222076928 10:29:54 INFO - PROCESS | 10393 | 10:29:58 INFO - PROCESS | 10393 | Cycle 1(1): loaded http://localhost:46487/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46487/tests/kraken/driver.html?testName=imaging-desaturate) 10:29:58 INFO - PROCESS | 10393 | RSS: Main: 216580096 10:29:58 INFO - PROCESS | 10393 | 10:30:01 INFO - PROCESS | 10393 | Cycle 1(1): loaded http://localhost:46487/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46487/tests/kraken/driver.html?testName=json-parse-financial) 10:30:02 INFO - PROCESS | 10393 | RSS: Main: 218013696 10:30:02 INFO - PROCESS | 10393 | 10:30:03 INFO - PROCESS | 10393 | Cycle 1(1): loaded http://localhost:46487/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46487/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:30:04 INFO - PROCESS | 10393 | RSS: Main: 181989376 10:30:04 INFO - PROCESS | 10393 | 10:30:06 INFO - PROCESS | 10393 | Cycle 1(1): loaded http://localhost:46487/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46487/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:30:06 INFO - PROCESS | 10393 | RSS: Main: 189558784 10:30:06 INFO - PROCESS | 10393 | 10:30:09 INFO - PROCESS | 10393 | Cycle 1(1): loaded http://localhost:46487/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46487/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:30:09 INFO - PROCESS | 10393 | RSS: Main: 197857280 10:30:09 INFO - PROCESS | 10393 | 10:30:12 INFO - PROCESS | 10393 | Cycle 1(1): loaded http://localhost:46487/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:30:13 INFO - PROCESS | 10393 | RSS: Main: 206958592 10:30:13 INFO - PROCESS | 10393 | 10:30:16 INFO - PROCESS | 10393 | Cycle 1(1): loaded http://localhost:46487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:30:16 INFO - PROCESS | 10393 | RSS: Main: 203751424 10:30:16 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | Cycle 1(1): loaded http://localhost:46487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46487/tests/kraken/driver.html?testName=ai-astar) 10:30:18 INFO - PROCESS | 10393 | RSS: Main: 255004672 10:30:18 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | __start_tp_report 10:30:18 INFO - PROCESS | 10393 | _x_x_mozilla_page_load 10:30:18 INFO - PROCESS | 10393 | _x_x_mozilla_page_load_details 10:30:18 INFO - PROCESS | 10393 | |i|pagename|runs| 10:30:18 INFO - PROCESS | 10393 | |0;ai-astar;106;115;116;114;115;114;114;115;114;114 10:30:18 INFO - PROCESS | 10393 | |1;audio-beat-detection;150;123;124;176;128;125;128;123;150;125 10:30:18 INFO - PROCESS | 10393 | |2;audio-dft;161;160;160;162;163;162;161;161;162;161 10:30:18 INFO - PROCESS | 10393 | |3;audio-fft;76;76;75;107;77;76;78;77;93;76 10:30:18 INFO - PROCESS | 10393 | |4;audio-oscillator;86;86;123;86;85;84;117;85;85;115 10:30:18 INFO - PROCESS | 10393 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;116 10:30:18 INFO - PROCESS | 10393 | |6;imaging-darkroom;149;150;150;150;149;149;150;149;150;156 10:30:18 INFO - PROCESS | 10393 | |7;imaging-desaturate;95;96;96;95;96;96;95;95;95;95 10:30:18 INFO - PROCESS | 10393 | |8;json-parse-financial;65;58;58;58;60;61;60;60;61;60 10:30:18 INFO - PROCESS | 10393 | |9;json-stringify-tinderbox;67;68;67;68;67;66;67;73;68;68 10:30:18 INFO - PROCESS | 10393 | |10;stanford-crypto-aes;84;85;86;93;87;89;84;85;91;84 10:30:18 INFO - PROCESS | 10393 | |11;stanford-crypto-ccm;133;134;144;131;152;142;130;140;183;143 10:30:18 INFO - PROCESS | 10393 | |12;stanford-crypto-pbkdf2;171;173;174;171;174;171;178;176;170;171 10:30:18 INFO - PROCESS | 10393 | |13;stanford-crypto-sha256-iterative;68;69;67;67;68;67;73;68;66;66 10:30:18 INFO - PROCESS | 10393 | __end_tp_report 10:30:18 INFO - PROCESS | 10393 | __start_cc_report 10:30:18 INFO - PROCESS | 10393 | _x_x_mozilla_cycle_collect,1828 10:30:18 INFO - PROCESS | 10393 | __end_cc_report 10:30:18 INFO - PROCESS | 10393 | __startTimestamp1484245818928__endTimestamp 10:30:18 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | ------- Summary: start ------- 10:30:18 INFO - PROCESS | 10393 | Number of tests: 14 10:30:18 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.50 stddev:2.79 (2.4%) stddev-sans-first:0.73 10:30:18 INFO - PROCESS | 10393 | Values: 106.0 115.0 116.0 114.0 115.0 114.0 114.0 115.0 114.0 114.0 10:30:18 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:128.00 stddev:17.76 (13.9%) stddev-sans-first:18.01 10:30:18 INFO - PROCESS | 10393 | Values: 150.0 123.0 124.0 176.0 128.0 125.0 128.0 123.0 150.0 125.0 10:30:18 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 10:30:18 INFO - PROCESS | 10393 | Values: 161.0 160.0 160.0 162.0 163.0 162.0 161.0 161.0 162.0 161.0 10:30:18 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.50 stddev:10.52 (13.8%) stddev-sans-first:11.00 10:30:18 INFO - PROCESS | 10393 | Values: 76.0 76.0 75.0 107.0 77.0 76.0 78.0 77.0 93.0 76.0 10:30:18 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:85.00 stddev:16.10 (18.9%) stddev-sans-first:16.72 10:30:18 INFO - PROCESS | 10393 | Values: 86.0 86.0 123.0 86.0 85.0 84.0 117.0 85.0 85.0 115.0 10:30:18 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:30:18 INFO - PROCESS | 10393 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 10:30:18 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.00 stddev:2.10 (1.4%) stddev-sans-first:2.18 10:30:18 INFO - PROCESS | 10393 | Values: 149.0 150.0 150.0 150.0 149.0 149.0 150.0 149.0 150.0 156.0 10:30:18 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:30:18 INFO - PROCESS | 10393 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 10:30:18 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:60.00 stddev:2.08 (3.5%) stddev-sans-first:1.24 10:30:18 INFO - PROCESS | 10393 | Values: 65.0 58.0 58.0 58.0 60.0 61.0 60.0 60.0 61.0 60.0 10:30:18 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:1.91 (2.8%) stddev-sans-first:2.00 10:30:18 INFO - PROCESS | 10393 | Values: 67.0 68.0 67.0 68.0 67.0 66.0 67.0 73.0 68.0 68.0 10:30:18 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.50 stddev:3.19 (3.7%) stddev-sans-first:3.22 10:30:18 INFO - PROCESS | 10393 | Values: 84.0 85.0 86.0 93.0 87.0 89.0 84.0 85.0 91.0 84.0 10:30:18 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:142.50 stddev:15.58 (10.9%) stddev-sans-first:16.09 10:30:18 INFO - PROCESS | 10393 | Values: 133.0 134.0 144.0 131.0 152.0 142.0 130.0 140.0 183.0 143.0 10:30:18 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:173.50 stddev:2.60 (1.5%) stddev-sans-first:2.67 10:30:18 INFO - PROCESS | 10393 | Values: 171.0 173.0 174.0 171.0 174.0 171.0 178.0 176.0 170.0 171.0 10:30:18 INFO - PROCESS | 10393 | 10:30:18 INFO - PROCESS | 10393 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:2.02 (3.0%) stddev-sans-first:2.15 10:30:18 INFO - PROCESS | 10393 | Values: 68.0 69.0 67.0 67.0 68.0 67.0 73.0 68.0 66.0 66.0 10:30:18 INFO - PROCESS | 10393 | -------- Summary: end -------- 10:30:18 INFO - PROCESS | 10393 | 10:30:19 INFO - TEST-INFO | 10393: exit 0 10:30:20 INFO - TEST-OK | kraken | took 63351ms 10:30:20 INFO - SUITE-END | took 1185s 10:30:20 INFO - Completed test suite (00:19:45) 10:30:20 INFO - javascript benchmark 10:30:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2561.231630510846, 2629.605559166126, 2648.4173481833996, 2655.6813182418114, 2659.0959073914864, 4760.9523904760945, 4822.686555266592, 4824.276358546211, 4892.119418504668, 4948.356713627228, 4845.248986407104, 4859.805607775694, 4877.122118018755, 4892.4862889396545, 4974.204127339626, 4305.763183024932, 4375.1031038637, 4395.274779661352, 4466.441694788152, 4476.9552304476865, 4379.2336341140335, 4443.711158774686, 4474.865754027368, 4493.123840851035, 4549.454065512126, 4459.264221403465, 4492.0791237796175, 4519.0, 4543.7728113594185, 4548.454185497745, 4373.431453911003, 4395.802188901507, 4404.207242696313, 4410.845620403303, 4485.147821913859, 4388.868333949987, 4431.800568974404, 4440.844570440051, 4469.240229161051, 4499.572540608637, 4773.949731059161, 4815.470298267188, 4819.084373968934, 4822.059698358787, 4850.75746212688, 5019.372578427697, 5037.874053148664, 5186.377634683824, 5188.584913206934, 5226.529612334908, 5129.897402051975, 5130.025295193901, 5138.640295179339, 5143.434222235551, 5151.66514176581, 4842.15262329091, 4882.414110306786, 4891.413030436299, 4893.119238537026, 4893.84994526286, 5280.181571856291, 5288.418273989858, 5292.576593872481, 5294.364676238799, 5347.144456886879, 5008.69947803133, 5051.747412629354, 5053.9241911371355, 5057.468965758616, 5065.164247899055, 5071.568916642127, 5198.844034678966, 5201.973990130101, 5203.427622961472, 5207.557357624569, 5044.722540260321, 5083.415407228142, 5109.131447653907, 5124.128898087334, 5178.456262092426, 5143.202803565453, 5152.948470515322, 5157.071727089085, 5157.8452646420665, 5205.375354957429, 4302.440682711227, 4377.190219809346, 4389.078293558325, 4391.231534481453, 4430.091831174602, 3761.755485893408, 3809.5999920008553, 3815.5993620669983, 3816.561095474056, 3855.7300988930506, 4434.268345722984, 4438.7114837535455, 4439.445069366329, 4440.089781594766, 4442.111577684476, 5226.242194881721, 5227.60792940531, 5231.163013917755, 5231.346081739783, 5234.18870075139, 4391.165678521071, 4427.535108813592, 4431.468223813099, 4432.645388368987, 4432.756198409118, 4661.440627124767, 4667.159911216014, 4668.0197158597075, 4668.346431499593, 4679.742614156254, 4802.063597598435, 4866.780994855169, 4870.09903167915, 4872.926906096341, 4873.19592267279, 5183.740812959412, 5184.274201611702, 5186.559142472932, 5189.6107791915, 5194.662346947436, 4883.218685010382, 4886.731229782396, 4900.387451568554, 4900.754962251945, 4945.357103576512, 4965.379327584052, 5003.549680528624, 5005.0, 5054.898902022012, 5152.124138896322, 5109.0, 5125.256837758429, 5148.6910785353, 5150.124478838681, 5162.432132465351, 5031.345925029723, 5032.370953630796, 5032.974835125801, 5059.822906198266, 5075.974620126875, 5017.8243761468175, 5021.924671129863, 5023.372078490189, 5024.799008039638, 5073.289739436408, 4870.707757534559, 4904.730239836843, 4906.8773280668265, 4966.155753521982, 4975.139205547452, 5012.348394708664, 5013.924791128063, 5023.924641130459, 5053.393592768744, 5107.69353838756, 4936.185529387611, 4937.136001199848, 4937.851864444073, 4942.20924652054, 4982.8754281143265], "value": 4737.560268422585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.3359101895687, 578.8408187748369, 579.3135134865183, 592.3247497852446, 621.2048577820392, 35779.46330805037, 39913.60086399135, 39935.80032099839, 40047.199056018864, 40062.0, 40557.39163912544, 41183.0, 41263.38104928428, 41296.38055429171, 41346.17307653853, 7681.615919204045, 7849.843003139934, 7880.133185349607, 7902.0, 8088.636011379502, 10270.640527581536, 10476.790464190712, 10512.684619461428, 10870.0, 10878.456077196148, 10433.061024507793, 10482.056614904657, 10499.527521261562, 10503.422311772849, 10523.73690657732, 10486.842697359545, 10560.78878422431, 10563.94718026405, 10568.418736969463, 10575.841362379571, 10312.02035806597, 10379.688609341732, 10386.948065259701, 10397.688069357931, 10399.06408423238, 40136.0, 40322.395164072266, 40369.798151009054, 40453.19093618111, 40482.39276410856, 3658.5426821647293, 3690.2435000824767, 3709.3508635988865, 3758.755680880734, 3799.25914446683, 28812.567811482844, 29416.41167176666, 29473.115806525624, 29543.26141846471, 29544.0, 3188.2348236423322, 3231.951520727191, 3328.783629064103, 3360.8487618057247, 3426.0749597608506, 241232.0, 242345.0, 242520.0, 242679.0, 243203.99999999822, 56699.43300567024, 57559.0, 57582.7120864393, 58023.419765802646, 58038.7098064507, 61070.0, 61268.08097878535, 61307.38692613106, 61376.38623613796, 61412.69293653503, 14681.48614798477, 15189.0, 15194.848051519344, 15204.163770992702, 15211.315490802941, 10538.0, 10855.348679079281, 11183.776324473465, 11466.656000320003, 11494.540218391337, 18700.0, 18761.437156885044, 18832.435026949213, 18859.3399231029, 18868.226354729108, 6505.41451269388, 6520.18497687789, 6646.136002319764, 6706.664666766642, 6726.663666816639, 797.2983774278598, 805.9717909873126, 815.7267315449272, 818.1899919080187, 830.8047608811925, 26908.32729181747, 27624.723752762617, 27987.300317492227, 28131.43737125246, 28281.858590706914, 954.7708549947962, 962.815239932966, 968.4721826604517, 991.7917237380086, 996.2627655534997, 15136.772948405784, 15138.772918406232, 15391.230438478031, 15410.460633877761, 15439.84560154384, 337776.0, 383421.0, 394286.0, 395655.0, 576281.0, 45932.311015334795, 45982.0, 45992.62022139274, 46026.30960535595, 46101.30848037282, 1208.7159517513378, 1226.4848763519344, 1250.8186312984567, 1257.5787111317811, 1258.3959699344366, 25743.524624176247, 26596.20211393661, 26695.19914402571, 27121.86439067792, 27230.183094507196, 40030.1993960125, 40380.798096009334, 40493.0, 40545.1890962185, 40604.79697601493, 297086.0, 298724.0, 298921.0, 298939.0, 298940.0, 19451.221951121795, 19862.90068549648, 21459.141634334454, 24064.15775447851, 24722.629160562246, 38145.0, 38415.15848415136, 38536.80731596324, 38901.41647875341, 39192.0, 31525.527117092803, 32646.673533265315, 32722.672773271963, 32810.50784238286, 34318.828405857814, 32704.345913081128, 32856.50715239225, 33514.83242583869, 33677.49483757795, 34201.65798341985, 30205.546916796706, 30234.2441438957, 30347.848260758554, 30428.39143217079, 33263.83368083144, 27747.861260693568, 30175.245618858826, 31241.531377029816, 31274.21814454657, 31274.687253127177, 23230.793074658555, 23467.41331466727, 23635.29094127179, 23973.40066498282, 24093.277201683977], "value": 17895.410091997874, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.6835269139503, 376.80971109589655, 386.63269893601085, 387.3086540525162, 421.881873075539, 13691.178529288238, 17406.477805665836, 17716.291348346065, 18215.36246231382, 18351.174197161126, 16194.0, 17013.31946722133, 17639.647207055885, 17757.200925958332, 17778.46664600064, 4992.425871024833, 5316.3354580677415, 5348.411674715798, 5349.384820745625, 5350.3312085989255, 3973.3245348290716, 4155.584441555835, 5274.841754747364, 5355.143177091666, 5364.812231571896, 6047.969760151215, 6308.369163083677, 6320.273168585602, 6430.7749228777, 6435.8391040223905, 6236.781712640036, 6299.244090709099, 6381.298057213703, 6398.168238129037, 6401.3598640135615, 5675.460831221028, 5677.17680936262, 5684.431556844283, 5693.886122277573, 5694.174344720034, 21887.0, 22107.889460552757, 22317.77682223173, 22366.88816555923, 22416.32751017472, 2295.31140657802, 2313.3866455398615, 2313.4332088638225, 2317.8261630377788, 2409.6867407237123, 13836.377363018688, 13982.510612128526, 14134.15195088298, 14137.717245655133, 14543.92728036353, 1726.413019573351, 1762.5769815244248, 1784.3041213926579, 1793.641271745643, 1802.8016918138994, 78983.21016789816, 79701.60149199275, 80322.0, 80684.0, 80892.59553702195, 10139.797204055878, 10270.178385729123, 10296.588136474456, 10497.475126243657, 10499.212559058102, 14530.273486325641, 14583.562493125222, 14591.124532528082, 14597.78103328451, 14602.926985365219, 7616.961915190499, 7821.1676827593055, 7832.647530861125, 7833.33416659579, 7949.284564389232, 7285.453590980697, 7372.0, 7608.391328693802, 7610.429217808686, 7622.885656715153, 6674.666266686646, 6784.457243420613, 6792.694328755218, 6818.318168183241, 6906.551074180162, 1852.2405813616622, 1852.397970659541, 1880.2760937039066, 1913.3112079651314, 1930.845532357408, 986.7237173591406, 1001.4692213127055, 1018.2770233134557, 1018.8573599696049, 1026.9075783179549, 16200.108994005208, 16347.673046539003, 16692.0, 17181.31274749021, 17325.56686082858, 959.2469911119738, 994.1351024608637, 1003.4631472162358, 1018.5976539266948, 1025.190099821148, 9358.298127640453, 9606.471644059504, 9920.603175872884, 9933.205343572497, 10088.49557522121, 427400.0, 441648.0, 444355.34268901945, 446258.0, 510249.0, 79654.0, 97413.0, 97821.0, 99156.50421747845, 100100.49949750205, 825.3191117328348, 837.2213841127688, 868.5136323658771, 870.303756994402, 879.520661239626, 16394.18029098564, 16919.83080169232, 17289.308427662752, 17307.913460432617, 17416.912915435343, 40058.0, 40277.59028433991, 40450.797746011085, 40552.0, 40572.59427405688, 54186.72906635599, 56044.43955560555, 58589.4141058601, 59613.0, 59901.0, 8274.58627068632, 8315.792105197177, 8423.4945903246, 8535.189157030072, 8535.359848011549, 12043.337616431181, 12373.62879113628, 12523.311217883103, 13003.544875929298, 13353.332333383098, 10844.403557804397, 10935.125189984623, 10992.28550144238, 11015.559377625126, 11370.772584548427, 5450.8909821802545, 7498.062742157231, 11061.281016733887, 11334.14993875446, 11345.092392608407, 10551.314164579278, 10830.458477076272, 11311.321320720454, 11373.31760094397, 11485.827712584485, 7321.267873212636, 7339.449541284532, 7445.516041457288, 7842.686292548462, 8447.239748422671, 9636.903630963601, 10550.261481696207, 10933.180011499011, 11089.05743011853, 11243.269187503114], "value": 8957.19345301614, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.938802753876, 1367.1387026173509, 1369.7671395862703, 1384.6261509392464, 1392.7423426666062, 6687.364700353464, 7076.575405475675, 7125.180604230509, 7134.536255143418, 7136.3220494052985, 6163.8150855474405, 6378.744850205998, 6798.0, 7023.051887995119, 7036.085308909835, 2121.2575598540543, 2153.666181741825, 2158.2661894955713, 2159.9784002160013, 2161.8702877827304, 2123.9150433982622, 2153.3001774423296, 2161.794629510202, 2164.0, 2164.2208804830248, 1823.3891646298505, 1885.5003424092627, 2050.190174880921, 2125.0543508138885, 2129.744430668322, 2106.378618307603, 2109.9472513187293, 2112.355731501891, 2113.8837363944976, 2115.481706981784, 2012.1548949441124, 2029.0869108900906, 2034.4100210938957, 2091.4248581640018, 2126.53216292417, 7071.823204419879, 7125.358717715379, 7130.144382674061, 7136.0723105995885, 7137.714491420337, 4168.979155104205, 4290.442242508454, 4297.462817147856, 4298.269294219959, 4301.870943871689, 2750.972490275112, 2889.0754958413318, 2924.8245105293536, 2930.8974185903603, 2935.060780550225, 1102.7408558988632, 1136.6078702847503, 1157.7163594919214, 1202.6452196602024, 1207.5833837326109, 9117.0, 9147.405418647766, 9176.632934682604, 9194.034626364202, 9203.0, 3857.556381016219, 4025.376066709665, 4081.89795255121, 4084.6732261419015, 4091.059056416981, 8152.38857085721, 8155.714549990722, 8156.225158609923, 8163.10205877353, 8166.142555031755, 4452.398926144993, 4455.242608756519, 4455.6658250631335, 4459.0, 4459.509453960061, 3434.845431955568, 3538.929221415557, 3935.193285376491, 4100.200460910094, 4118.279301122292, 3417.3677869594203, 3476.8526386292465, 3568.6966607838103, 3583.569971603424, 3621.0947263184203, 1125.6904351303458, 1148.075798981811, 1157.0859021373021, 1157.9189456738115, 1162.8953394194393, 828.1552816127517, 835.8662613981734, 851.114840565817, 870.0342619692136, 871.7210492642294, 4791.113643975806, 4820.156472617278, 4846.927296090562, 5015.122353588107, 5040.974795126074, 545.3047364610075, 545.4273013335982, 559.9160125981053, 567.1747607231468, 569.163329905039, 3257.4136655402253, 3274.5743053402907, 3285.967140328614, 3311.089450401159, 3405.4040542905386, 8046.597670116471, 8488.702895398632, 8491.575421228914, 8493.745187644381, 8503.404761666749, 8443.74668759926, 8447.704330348408, 8449.662013519513, 8450.830983380298, 8464.40749147566, 6670.299618540081, 6731.091302674175, 6738.561993470409, 6742.730290788313, 6744.966275168593, 4706.247000479907, 4759.833405830779, 4845.103655823684, 5134.76893539799, 5147.768350424315, 7505.211952744883, 7688.577128258, 7693.961530192313, 7776.339011184113, 7978.162292959156, 7825.530468171928, 7854.096778870503, 7894.84210315779, 7928.524288542706, 7951.761447156595, 5527.281453411031, 5721.342045664802, 6035.818925432244, 6076.574639775174, 6128.662923539248, 6517.804465866032, 6805.6937437816405, 6833.760818371532, 6939.861202776017, 6958.930410695828, 5984.491318237824, 6044.727987240497, 6115.235595550556, 6160.16837726919, 6201.844953876009, 5995.970020149872, 6011.398860113954, 6016.669083200466, 6033.909491357721, 6061.848453788691, 5389.784408623611, 5468.316460442445, 5481.698506582176, 5482.205080263419, 5488.039593071277, 4132.462779838602, 4171.416001759817, 4226.788660567021, 4292.463442069741, 4319.827206911688, 4108.219438306712, 4137.855175068858, 4357.0, 4386.7367957922625, 4391.582799634158], "value": 3819.3143933014676, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.06271038523874, 367.52038589640506, 367.81976831352637, 372.7521198403062, 378.71974738693376, 4902.779374928128, 4906.63200259981, 4913.705177689341, 4937.629677774168, 4983.775730092146, 4682.695624784386, 4692.929606055912, 4773.5226477352335, 4820.927686084711, 4859.902801943959, 3951.9407208891816, 3955.129871428281, 3956.1889812588493, 3964.6035396460265, 3979.1444839359533, 3962.5244970603426, 3971.761694298337, 3980.0, 4000.459937908389, 4016.7389119707127, 3763.3978563429855, 3852.0947577319307, 3855.9228815423676, 3881.165549406877, 3908.609139086097, 3887.5334959804864, 3893.4743809585625, 3894.9026274343087, 3904.902377440558, 3920.7059470539825, 3512.947305790415, 3525.2244506208594, 3527.7775001748732, 3537.876174333886, 3547.733919955988, 4536.570980141245, 4716.646251531149, 4796.664233503656, 4851.714295711639, 4869.099216644932, 4295.656347492193, 4308.9406521369865, 4309.5690430956965, 4347.500037495697, 4362.1275744851155, 5095.5923526118195, 5112.71880046601, 5125.718085505296, 5139.922901156486, 5154.355705536808, 3589.6589823966942, 3680.4663323818163, 3689.8192578374933, 3693.445983102529, 3695.5195824542907, 5283.471652834686, 5305.946940530584, 5324.840254792362, 5329.680219186784, 5331.360236771612, 3741.7567858089137, 3747.8500859965843, 3755.830987605564, 3764.4541541476333, 3766.209096089797, 3774.3772277573894, 3793.7344385893275, 3798.639129282714, 3837.5609146570037, 3841.2125514269505, 4250.213710463574, 4303.462067241595, 4308.80610372534, 4362.912741745147, 4395.7362558246605, 5054.646174767805, 5075.949240507622, 5087.491250874883, 5098.286239926413, 5107.565856902205, 1206.945687444067, 1270.30133426615, 1285.7878450055823, 1289.4648720780958, 1289.619562229126, 816.901267794815, 862.3790870573177, 869.7955980344614, 884.5533005832013, 891.4027601507006, 4263.978680106579, 4287.2711639021445, 4323.0, 4336.696431249782, 4351.934720979188, 5100.285959965608, 5107.361579802525, 5109.335786347751, 5118.513741194581, 5118.718470484085, 4209.568746626162, 4329.480462344539, 4337.416842852399, 4471.418715567021, 4492.3710680504755, 2740.9177724668293, 2743.067357098596, 2753.1740477856965, 2753.3942532642786, 2756.4487102579565, 4785.688930219525, 4790.718357924833, 4790.976045119752, 4846.830360937351, 4859.781309841065, 5064.417591976896, 5174.275601415805, 5182.870428239325, 5213.60897932649, 5220.851412689202, 4699.436067671902, 4727.834525791581, 4821.975890120597, 4831.782569784368, 4846.588040016638, 5118.41138269089, 5123.949590333898, 5131.538161565477, 5135.974320128375, 5175.611829112907, 4904.798324410543, 5052.7726252318, 5059.468755780737, 5072.402193309096, 5114.795408183631, 4828.227483602606, 4836.685615434985, 4840.91079507108, 4850.563449289581, 4865.391826021747, 3644.1982763791925, 3660.908477288089, 3669.5779985302033, 3670.724695647784, 3698.1863989922176, 4900.313956046085, 5131.946491837351, 5190.195519694454, 5191.00292774554, 5193.7403129842605, 4981.37732783402, 4994.700317980933, 4997.800087996439, 5001.749912504433, 5023.296738456692, 4997.675151115312, 5003.799848006039, 5007.974960125176, 5043.672161309503, 5052.166392545336, 4818.95181048185, 4882.316475693335, 4927.659361803115, 5107.591392688501, 5135.589152867687, 4990.3762029746285, 5060.367454068241, 5125.564327032244, 5136.9743151284, 5142.305788718625, 4987.326710893983, 5035.546800787946, 5038.823641172688, 5050.924236136388, 5051.595872330278], "value": 3853.083046803615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.1035832700834, 679.4835924697229, 733.8348871503912, 736.5102207032323, 752.2364799728275, 12973.870261297385, 13775.448982040718, 13834.16994980302, 13853.168809871415, 13864.098833575836, 14471.927640361784, 15049.24753762313, 15055.548333549983, 15337.0, 15367.077975321488, 650.5901282192212, 800.2077942836579, 815.1155995744624, 815.7348861619968, 817.0399780258202, 668.0180135201247, 796.4026979765176, 818.6725309876037, 828.3662997806682, 831.5301854452246, 859.2782063067023, 860.0754189246554, 861.1345597674328, 861.625193041026, 862.7153039496982, 680.6562685843667, 849.4478588917253, 851.6167724523958, 851.6337974670889, 853.4154104438448, 518.5229588778333, 610.057461222408, 620.7082671144555, 626.4831514000967, 627.9089532017878, 14253.928730356385, 14269.500567480089, 14291.928540357336, 14294.142351458842, 14302.57092287233, 12096.092793040558, 12243.510259589606, 12566.0, 12589.118761686686, 12968.740625187538, 12197.20718153326, 12324.0, 12418.130730848845, 12583.811242831365, 12703.301318427482, 3783.3190025795348, 3880.301545721769, 3890.9027274318087, 3974.5826688197612, 3982.0, 64562.67718661424, 65507.67246163739, 66167.3383266166, 66408.3359166407, 67394.0, 9847.507624618884, 9869.259805514615, 9923.503824808875, 10053.849192262122, 10103.343282686748, 16951.576210594834, 17086.572835679206, 19089.713654295196, 19864.10611522485, 19871.304504342566, 6668.566543174775, 6721.294264102199, 6841.863162736718, 6874.759383421556, 7096.787096387116, 3533.116720819795, 3591.6408359163875, 3612.1862655121417, 3613.584437789688, 3672.6878215351994, 2960.86676099576, 3009.1574359179463, 3041.4981528047624, 3057.5413687946984, 3070.7082827131385, 492.7265367720949, 494.29069285575315, 501.42586738185304, 501.90714717777325, 504.9394072711298, 640.4908098062052, 645.7546132469631, 662.9303923088103, 668.6623255256064, 674.5649056358621, 7900.762977110696, 8030.829816042887, 8296.585170741439, 8492.830143397097, 8553.230209281195, 599.7840777320162, 611.5749554059886, 612.7059011674332, 619.6591874469115, 624.5284809968445, 3914.197589494147, 4000.119973605802, 4056.8985775355854, 4119.588041195856, 4152.148809494047, 53149.46850531523, 70129.0, 70216.0, 72131.63934180296, 72162.63918680478, 59013.70493147593, 60202.0, 61161.0, 62586.68706656529, 62851.0, 54923.450765492635, 54989.72505137529, 55471.44528554663, 56713.716431417575, 57807.13289300664, 7787.727429540166, 7844.764657060297, 7867.449278550446, 7882.960585197037, 8081.717139900075, 37209.25581488409, 37222.62777372191, 38261.0, 38477.23045539018, 39816.40275395814, 43562.782186088865, 45052.549474504835, 47855.0, 48583.27125093056, 48681.26978095261, 9377.0, 9490.478023708762, 9521.571529281338, 9665.033496650278, 9916.355436896578, 9727.464989425649, 9746.171575416169, 9866.0, 10390.948045260027, 10516.579336826748, 9687.56365226111, 9927.354721943051, 10205.540750666387, 10250.077493025663, 10428.53071611764, 10244.180465562886, 10673.57305707763, 10686.519106640064, 10897.509612067317, 11097.334159950105, 9479.857802132836, 9997.900020999989, 10069.748256293651, 10243.897561024593, 10247.282690211614, 8092.09869143937, 8152.225538573826, 8237.176282371714, 8247.298979586802, 8599.312055035707, 7066.187388450394, 7816.218378162365, 7839.137694853447, 7887.132415434183, 8064.112947575879], "value": 6250.0110702655265, "unit": "score"}], "name": "dromaeo_css", "value": 6417.504769821857, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 116.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 124.0, 176.0, 128.0, 125.0, 128.0, 123.0, 150.0, 125.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 162.0, 163.0, 162.0, 161.0, 161.0, 162.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 107.0, 77.0, 76.0, 78.0, 77.0, 93.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 123.0, 86.0, 85.0, 84.0, 117.0, 85.0, 85.0, 115.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 150.0, 149.0, 149.0, 150.0, 149.0, 150.0, 156.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 58.0, 58.0, 58.0, 60.0, 61.0, 60.0, 60.0, 61.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 66.0, 67.0, 73.0, 68.0, 68.0], "value": 67.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 93.0, 87.0, 89.0, 84.0, 85.0, 91.0, 84.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 134.0, 144.0, 131.0, 152.0, 142.0, 130.0, 140.0, 183.0, 143.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 174.0, 171.0, 174.0, 171.0, 178.0, 176.0, 170.0, 171.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 67.0, 68.0, 67.0, 73.0, 68.0, 66.0, 66.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1547.7000000000003, "alertThreshold": 2.0}]} 10:30:20 INFO - Return code: 0 10:30:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:30:20 INFO - # TBPL SUCCESS # 10:30:20 INFO - Running post-action listener: _resource_record_post_action 10:30:20 INFO - [mozharness: 2017-01-12 18:30:20.243469Z] Finished run-tests step (success) 10:30:20 INFO - Running post-run listener: _resource_record_post_run 10:30:20 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 383713280; Read time: 180; Write time: 231880 10:30:20 INFO - TinderboxPrint: CPU usage
13.1% 10:30:20 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 180 10:30:20 INFO - TinderboxPrint: I/O write bytes / time
383,713,280 / 231,880 10:30:20 INFO - TinderboxPrint: CPU idle
8,334.3 (86.9%) 10:30:20 INFO - TinderboxPrint: CPU user
1,216.1 (12.7%) 10:30:20 INFO - TinderboxPrint: Swap in / out
0 / 0 10:30:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100057088; Read time: 0; Write time: 79016 10:30:20 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283656192; Read time: 168; Write time: 152864 10:30:20 INFO - Running post-run listener: _upload_blobber_files 10:30:20 INFO - Blob upload gear active. 10:30:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:30:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:30:20 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'] 10:30:20 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 10:30:21 INFO - (blobuploader) - INFO - Open directory for files ... 10:30:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:30:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:30:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:22 INFO - (blobuploader) - INFO - Done attempting. 10:30:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:30:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:30:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:22 INFO - (blobuploader) - INFO - Done attempting. 10:30:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:30:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:30:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:26 INFO - (blobuploader) - INFO - Done attempting. 10:30:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:30:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:30:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:27 INFO - (blobuploader) - INFO - Done attempting. 10:30:27 INFO - (blobuploader) - INFO - Iteration through files over. 10:30:27 INFO - Return code: 0 10:30:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:30:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:30:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d6cefca87dd7598a4385933ed4bc20ff7bd4ebb9f288c501718dc0a0d97397f0517e7414d8a76a6f903d181e4af6eb25eb817f34cde0942bc5bbac4950dd3125", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8c2bc23de7dabca84e73cfa6816a6762a18d4e7bb3501f9d0e259adc4f7fe28ae550a43a1dd66f5ff8834f2f58c5e8117d4d44231bb2d1e179987415d282eaa4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b2e695e2d49d899ffed5ffd6c164b6c842f1a653e622dc98a869e8341809fe9dc0156349dbcb94b20f5051cbc889bca7106a2689db9b37e3b9692c97f4a20221", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ec1c9f93cf0934bb5b0233ca9d8bd004d1134ec627ea740c4cee16b2118a89620cbb646b25664a4290a97c02120c8ab4d04a0f2c5076591df1c3c0d1e3ac4a80"} 10:30:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:30:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:30:27 INFO - Contents: 10:30:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d6cefca87dd7598a4385933ed4bc20ff7bd4ebb9f288c501718dc0a0d97397f0517e7414d8a76a6f903d181e4af6eb25eb817f34cde0942bc5bbac4950dd3125", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8c2bc23de7dabca84e73cfa6816a6762a18d4e7bb3501f9d0e259adc4f7fe28ae550a43a1dd66f5ff8834f2f58c5e8117d4d44231bb2d1e179987415d282eaa4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b2e695e2d49d899ffed5ffd6c164b6c842f1a653e622dc98a869e8341809fe9dc0156349dbcb94b20f5051cbc889bca7106a2689db9b37e3b9692c97f4a20221", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ec1c9f93cf0934bb5b0233ca9d8bd004d1134ec627ea740c4cee16b2118a89620cbb646b25664a4290a97c02120c8ab4d04a0f2c5076591df1c3c0d1e3ac4a80"} 10:30:27 INFO - Running post-run listener: copy_logs_to_upload_dir 10:30:27 INFO - Copying logs to upload dir... 10:30:27 INFO - mkdir: /builds/slave/test/build/upload/logs 10:30:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.467979 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-12 10:30:26.322789) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 10:30:26.326512) ========= 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=bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d6cefca87dd7598a4385933ed4bc20ff7bd4ebb9f288c501718dc0a0d97397f0517e7414d8a76a6f903d181e4af6eb25eb817f34cde0942bc5bbac4950dd3125", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8c2bc23de7dabca84e73cfa6816a6762a18d4e7bb3501f9d0e259adc4f7fe28ae550a43a1dd66f5ff8834f2f58c5e8117d4d44231bb2d1e179987415d282eaa4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b2e695e2d49d899ffed5ffd6c164b6c842f1a653e622dc98a869e8341809fe9dc0156349dbcb94b20f5051cbc889bca7106a2689db9b37e3b9692c97f4a20221", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ec1c9f93cf0934bb5b0233ca9d8bd004d1134ec627ea740c4cee16b2118a89620cbb646b25664a4290a97c02120c8ab4d04a0f2c5076591df1c3c0d1e3ac4a80"} build_url:https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011824 build_url: 'https://queue.taskcluster.net/v1/task/J4jnKgKAQieAhwvSQBKa3Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d6cefca87dd7598a4385933ed4bc20ff7bd4ebb9f288c501718dc0a0d97397f0517e7414d8a76a6f903d181e4af6eb25eb817f34cde0942bc5bbac4950dd3125", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8c2bc23de7dabca84e73cfa6816a6762a18d4e7bb3501f9d0e259adc4f7fe28ae550a43a1dd66f5ff8834f2f58c5e8117d4d44231bb2d1e179987415d282eaa4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b2e695e2d49d899ffed5ffd6c164b6c842f1a653e622dc98a869e8341809fe9dc0156349dbcb94b20f5051cbc889bca7106a2689db9b37e3b9692c97f4a20221", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ec1c9f93cf0934bb5b0233ca9d8bd004d1134ec627ea740c4cee16b2118a89620cbb646b25664a4290a97c02120c8ab4d04a0f2c5076591df1c3c0d1e3ac4a80"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 10:30:26.352341) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 10:30:26.352670) ========= 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=bb9b54edd4a927dc735d112f000001d9-1484242926.771042-1661341983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 10:30:26.437041) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 10:30:26.437361) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 10:30:26.437666) ========= ========= Total master_lag: 0.18 =========