builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1486081696.94 results: success (0) revision: b4b23e49820c6de9658539e6a748f5b9515f42f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 16:28:16.941418) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 16:28:16.941885) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 16:28:16.942157) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 16:28:16.959963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 16:28:16.960336) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-02 16:28:17-- 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% 46.3M=0s 2017-02-02 16:28:17 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.205666 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 16:28:17.180366) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 16:28:17.180751) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.012968 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 16:28:17.230694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 16:28:17.231027) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b4b23e49820c6de9658539e6a748f5b9515f42f5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev b4b23e49820c6de9658539e6a748f5b9515f42f5 --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=e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-02 16:28:17,284 truncating revision to first 12 chars 2017-02-02 16:28:17,284 Setting DEBUG logging. 2017-02-02 16:28:17,284 attempt 1/10 2017-02-02 16:28:17,284 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b4b23e49820c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-02 16:28:18,695 unpacking tar archive at: mozilla-central-b4b23e49820c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.725324 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 16:28:18.969093) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 16:28:18.969408) ========= script_repo_revision: b4b23e49820c6de9658539e6a748f5b9515f42f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 16:28:18.969797) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 16:28:18.970062) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 16:28:18.977052) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-02-02 16:28:18.977318) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:28:19 INFO - MultiFileLogger online at 20170202 16:28:19 in /builds/slave/test 16:28:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:28:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:28:19 INFO - {'append_to_log': False, 16:28:19 INFO - 'base_work_dir': '/builds/slave/test', 16:28:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:28:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:28:19 INFO - 'branch': 'Firefox-Non-PGO', 16:28:19 INFO - 'buildbot_json_path': 'buildprops.json', 16:28:19 INFO - 'config_files': ('talos/linux_config.py',), 16:28:19 INFO - 'default_actions': ('clobber', 16:28:19 INFO - 'read-buildbot-config', 16:28:19 INFO - 'download-and-extract', 16:28:19 INFO - 'populate-webroot', 16:28:19 INFO - 'create-virtualenv', 16:28:19 INFO - 'install', 16:28:19 INFO - 'run-tests'), 16:28:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:28:19 INFO - 'download_minidump_stackwalk': True, 16:28:19 INFO - 'download_symbols': 'ondemand', 16:28:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:28:19 INFO - 'tooltool.py': '/tools/tooltool.py', 16:28:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:28:19 INFO - '/tools/misc-python/virtualenv.py')}, 16:28:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:28:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:28:19 INFO - 'installer_path': 'installer.exe', 16:28:19 INFO - 'log_level': 'info', 16:28:19 INFO - 'log_name': 'talos', 16:28:19 INFO - 'log_to_console': True, 16:28:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:28:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:28:19 INFO - 'opt_config_files': (), 16:28:19 INFO - 'pip_index': False, 16:28:19 INFO - 'sps_profile': False, 16:28:19 INFO - 'sps_profile_interval': 0, 16:28:19 INFO - 'suite': 'dromaeojs-e10s', 16:28:19 INFO - 'system_bits': '32', 16:28:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:28:19 INFO - 'title': 'talos-linux64-ix-006', 16:28:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:28:19 INFO - 'use_talos_json': True, 16:28:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:28:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:28:19 INFO - 'work_dir': 'build'} 16:28:19 INFO - [mozharness: 2017-02-03 00:28:19.228140Z] Running clobber step. 16:28:19 INFO - Running pre-action listener: _resource_record_pre_action 16:28:19 INFO - Running main action method: clobber 16:28:19 INFO - rmtree: /builds/slave/test/build 16:28:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:28:19 INFO - Running post-action listener: _resource_record_post_action 16:28:19 INFO - [mozharness: 2017-02-03 00:28:19.674286Z] Finished clobber step (success) 16:28:19 INFO - [mozharness: 2017-02-03 00:28:19.674385Z] Running read-buildbot-config step. 16:28:19 INFO - Running pre-action listener: _resource_record_pre_action 16:28:19 INFO - Running main action method: read_buildbot_config 16:28:19 INFO - Using buildbot properties: 16:28:19 INFO - { 16:28:19 INFO - "project": "", 16:28:19 INFO - "product": "firefox", 16:28:19 INFO - "who": "kwierso@gmail.com", 16:28:19 INFO - "installer_path": "public/build/target.tar.bz2", 16:28:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:28:19 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:28:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:28:19 INFO - "stage_platform": "linux64", 16:28:19 INFO - "basedir": "/builds/slave/test", 16:28:19 INFO - "buildnumber": 678, 16:28:19 INFO - "platform": "ubuntu64_hw", 16:28:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:28:19 INFO - "slavebuilddir": "test", 16:28:19 INFO - "taskId": "Wcli2rO1SEafiJ2OjfBGmQ", 16:28:19 INFO - "branch": "mozilla-central", 16:28:19 INFO - "script_repo_revision": "production", 16:28:19 INFO - "revision": "b4b23e49820c6de9658539e6a748f5b9515f42f5", 16:28:19 INFO - "slavename": "talos-linux64-ix-006", 16:28:19 INFO - "repo_path": "mozilla-central" 16:28:19 INFO - } 16:28:19 INFO - Finding installer, test and symbols from parent task. 16:28:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wcli2rO1SEafiJ2OjfBGmQ'}, attempt #1 16:28:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wcli2rO1SEafiJ2OjfBGmQ'}, attempt #1 16:28:20 INFO - Task dependencies: bO8mJI50R5G6lSjJATtzsA 16:28:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA'}, attempt #1 16:28:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.tar.bz2 16:28:21 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/test_packages.json 16:28:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.crashreporter-symbols.zip 16:28:21 INFO - Running post-action listener: _resource_record_post_action 16:28:21 INFO - [mozharness: 2017-02-03 00:28:21.065705Z] Finished read-buildbot-config step (success) 16:28:21 INFO - [mozharness: 2017-02-03 00:28:21.065966Z] Running download-and-extract step. 16:28:21 INFO - Running pre-action listener: _resource_record_pre_action 16:28:21 INFO - Running main action method: download_and_extract 16:28:21 INFO - mkdir: /builds/slave/test/build/tests 16:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:21 INFO - trying https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.test_packages.json 16:28:21 INFO - Downloading https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:28:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:28:21 INFO - Downloaded 896 bytes. 16:28:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:28:21 INFO - Using the following test package requirements: 16:28:21 INFO - {u'common': [u'target.common.tests.zip'], 16:28:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:28:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:28:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:28:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:28:21 INFO - u'mozbase': [u'target.common.tests.zip'], 16:28:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:28:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:28:21 INFO - u'web-platform': [u'target.common.tests.zip', 16:28:21 INFO - u'target.web-platform.tests.zip'], 16:28:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:28:21 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:28:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.common.tests.zip 16:28:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:28:21 INFO - Fetch https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.common.tests.zip into memory 16:28:24 INFO - Expected file size: 39899893 16:28:24 INFO - Obtained file size: 39899893 16:28:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:28:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.common.tests.zip 16:28:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:28:28 INFO - Fetch https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.common.tests.zip into memory 16:28:30 INFO - Expected file size: 39899893 16:28:30 INFO - Obtained file size: 39899893 16:28:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.talos.tests.zip 16:28:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:28:35 INFO - Fetch https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.talos.tests.zip into memory 16:28:37 INFO - Expected file size: 14403454 16:28:37 INFO - Obtained file size: 14403454 16:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:37 INFO - trying https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.tar.bz2 16:28:37 INFO - Downloading https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:28:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:28:39 INFO - Downloaded 56189475 bytes. 16:28:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.tar.bz2 16:28:39 INFO - mkdir: /builds/slave/test/properties 16:28:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:28:39 INFO - Writing to file /builds/slave/test/properties/build_url 16:28:39 INFO - Contents: 16:28:39 INFO - build_url:https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.tar.bz2 16:28:39 INFO - Running post-action listener: _resource_record_post_action 16:28:39 INFO - Running post-action listener: set_extra_try_arguments 16:28:39 INFO - [mozharness: 2017-02-03 00:28:39.634318Z] Finished download-and-extract step (success) 16:28:39 INFO - [mozharness: 2017-02-03 00:28:39.634415Z] Running populate-webroot step. 16:28:39 INFO - Running pre-action listener: _resource_record_pre_action 16:28:39 INFO - Running main action method: populate_webroot 16:28:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:28:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:28:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:28:39 INFO - '--tppagecycles', 16:28:39 INFO - '7'], 16:28:39 INFO - 'tests': ['tsvgm']}}, 16:28:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:28:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:28:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:28:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:28:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:28:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:28:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:28:39 INFO - 'talos_options': ['--disable-e10s'], 16:28:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:28:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:28:39 INFO - 'talos_options': ['--disable-e10s'], 16:28:39 INFO - 'tests': ['damp', 'tps']}, 16:28:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:28:39 INFO - 'tests': ['damp', 'tps']}, 16:28:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:28:39 INFO - 'tests': ['dromaeo_dom']}, 16:28:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:28:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:28:39 INFO - 'tests': ['basic_compositor_video']}, 16:28:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:28:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:28:39 INFO - 'tests': ['a11yr', 16:28:39 INFO - 'ts_paint', 16:28:39 INFO - 'tpaint', 16:28:39 INFO - 'sessionrestore', 16:28:39 INFO - 'sessionrestore_no_auto_restore', 16:28:39 INFO - 'tabpaint']}, 16:28:39 INFO - 'other-e10s': {'tests': ['a11yr', 16:28:39 INFO - 'ts_paint', 16:28:39 INFO - 'tpaint', 16:28:39 INFO - 'sessionrestore', 16:28:39 INFO - 'sessionrestore_no_auto_restore', 16:28:39 INFO - 'tabpaint']}, 16:28:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:28:39 INFO - 'ts_paint', 16:28:39 INFO - 'tpaint', 16:28:39 INFO - 'sessionrestore', 16:28:39 INFO - 'sessionrestore_no_auto_restore', 16:28:39 INFO - 'tabpaint']}, 16:28:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:28:39 INFO - 'ts_paint', 16:28:39 INFO - 'tpaint', 16:28:39 INFO - 'sessionrestore', 16:28:39 INFO - 'sessionrestore_no_auto_restore', 16:28:39 INFO - 'tabpaint']}, 16:28:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:28:39 INFO - 'tests': ['a11yr', 16:28:39 INFO - 'ts_paint', 16:28:39 INFO - 'tpaint', 16:28:39 INFO - 'sessionrestore', 16:28:39 INFO - 'sessionrestore_no_auto_restore', 16:28:39 INFO - 'tabpaint']}, 16:28:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:28:39 INFO - 'tests': ['a11yr', 16:28:39 INFO - 'ts_paint', 16:28:39 INFO - 'tpaint', 16:28:39 INFO - 'sessionrestore', 16:28:39 INFO - 'sessionrestore_no_auto_restore', 16:28:39 INFO - 'tabpaint']}, 16:28:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:28:39 INFO - 'tests': ['tsvgx', 16:28:39 INFO - 'tsvgr_opacity', 16:28:39 INFO - 'tart', 16:28:39 INFO - 'tscrollx', 16:28:39 INFO - 'cart', 16:28:39 INFO - 'tsvg_static']}, 16:28:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:28:39 INFO - 'tsvgr_opacity', 16:28:39 INFO - 'tart', 16:28:39 INFO - 'tscrollx', 16:28:39 INFO - 'cart', 16:28:39 INFO - 'tsvg_static']}, 16:28:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:28:39 INFO - 'talos_options': ['--disable-e10s'], 16:28:39 INFO - 'tests': ['tp5o']}, 16:28:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:28:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:28:39 INFO - 'talos_options': ['--disable-e10s', 16:28:39 INFO - '--xperf_path', 16:28:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:39 INFO - 'tests': ['tp5n']}, 16:28:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:28:39 INFO - 'talos_options': ['--xperf_path', 16:28:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:39 INFO - 'tests': ['tp5n']}}, 16:28:39 INFO - 'talos.zip': {'path': '', 16:28:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:28:39 INFO - Running post-action listener: _resource_record_post_action 16:28:39 INFO - [mozharness: 2017-02-03 00:28:39.647555Z] Finished populate-webroot step (success) 16:28:39 INFO - [mozharness: 2017-02-03 00:28:39.647645Z] Running create-virtualenv step. 16:28:39 INFO - Running pre-action listener: _resource_record_pre_action 16:28:39 INFO - Running main action method: create_virtualenv 16:28:39 INFO - Creating virtualenv /builds/slave/test/build/venv 16:28:39 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 16:28:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:28:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:28:39 INFO - Using real prefix '/usr' 16:28:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:28:40 INFO - Installing distribute.............................................................................................................................................................................................done. 16:28:42 INFO - Installing pip.................done. 16:28:42 INFO - Return code: 0 16:28:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:28:42 INFO - Reading from file tmpfile_stdout 16:28:42 INFO - Output received: 16:28:42 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) 16:28:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:28:42 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')]} 16:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:42 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')]} 16:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:42 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 0x1ee91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258820>, '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 0x2259520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22599b0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', '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 16:28:42 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 16:28:42 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 16:28:42 INFO - Using env: {'DISPLAY': ':0', 16:28:42 INFO - 'HOME': '/home/cltbld', 16:28:42 INFO - 'LANG': 'en_US.UTF-8', 16:28:42 INFO - 'LANGUAGE': 'en_US:en', 16:28:42 INFO - 'LOGNAME': 'cltbld', 16:28:42 INFO - 'MAIL': '/var/mail/cltbld', 16:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:42 INFO - 'MOZ_NO_REMOTE': '1', 16:28:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:42 INFO - 'NO_EM_RESTART': '1', 16:28:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:42 INFO - 'PWD': '/builds/slave/test', 16:28:42 INFO - 'SHELL': '/bin/bash', 16:28:42 INFO - 'SHLVL': '1', 16:28:42 INFO - 'TERM': 'linux', 16:28:42 INFO - 'TMOUT': '86400', 16:28:42 INFO - 'USER': 'cltbld', 16:28:42 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', 16:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:42 INFO - '_': '/tools/buildbot/bin/python'} 16:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:42 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 16:28:42 INFO - Cleaning up... 16:28:42 INFO - Return code: 0 16:28:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:28:42 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')]} 16:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:42 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')]} 16:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:43 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 0x1ee91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258820>, '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 0x2259520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22599b0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', '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 16:28:43 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 16:28:43 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 16:28:43 INFO - Using env: {'DISPLAY': ':0', 16:28:43 INFO - 'HOME': '/home/cltbld', 16:28:43 INFO - 'LANG': 'en_US.UTF-8', 16:28:43 INFO - 'LANGUAGE': 'en_US:en', 16:28:43 INFO - 'LOGNAME': 'cltbld', 16:28:43 INFO - 'MAIL': '/var/mail/cltbld', 16:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:43 INFO - 'MOZ_NO_REMOTE': '1', 16:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:43 INFO - 'NO_EM_RESTART': '1', 16:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:43 INFO - 'PWD': '/builds/slave/test', 16:28:43 INFO - 'SHELL': '/bin/bash', 16:28:43 INFO - 'SHLVL': '1', 16:28:43 INFO - 'TERM': 'linux', 16:28:43 INFO - 'TMOUT': '86400', 16:28:43 INFO - 'USER': 'cltbld', 16:28:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', 16:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:43 INFO - '_': '/tools/buildbot/bin/python'} 16:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:43 INFO - Downloading/unpacking psutil>=3.1.1 16:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:28:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:28:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:28:45 INFO - Installing collected packages: psutil 16:28:45 INFO - Running setup.py install for psutil 16:28:45 INFO - building 'psutil._psutil_linux' extension 16:28:45 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 16:28:46 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 16:28:46 INFO - building 'psutil._psutil_posix' extension 16:28:46 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 16:28:47 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 16:28:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:28:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:28:47 INFO - Successfully installed psutil 16:28:47 INFO - Cleaning up... 16:28:47 INFO - Return code: 0 16:28:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:47 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 0x1ee91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258820>, '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 0x2259520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22599b0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', '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 16:28:47 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 16:28:47 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 16:28:47 INFO - Using env: {'DISPLAY': ':0', 16:28:47 INFO - 'HOME': '/home/cltbld', 16:28:47 INFO - 'LANG': 'en_US.UTF-8', 16:28:47 INFO - 'LANGUAGE': 'en_US:en', 16:28:47 INFO - 'LOGNAME': 'cltbld', 16:28:47 INFO - 'MAIL': '/var/mail/cltbld', 16:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:47 INFO - 'MOZ_NO_REMOTE': '1', 16:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:47 INFO - 'NO_EM_RESTART': '1', 16:28:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:47 INFO - 'PWD': '/builds/slave/test', 16:28:47 INFO - 'SHELL': '/bin/bash', 16:28:47 INFO - 'SHLVL': '1', 16:28:47 INFO - 'TERM': 'linux', 16:28:47 INFO - 'TMOUT': '86400', 16:28:47 INFO - 'USER': 'cltbld', 16:28:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', 16:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:47 INFO - '_': '/tools/buildbot/bin/python'} 16:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:28:47 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 16:28:47 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 16:28:47 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 16:28:47 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 16:28:47 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 16:28:47 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 16:28:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:28:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:28:49 INFO - Installing collected packages: mozsystemmonitor 16:28:49 INFO - Running setup.py install for mozsystemmonitor 16:28:49 INFO - Successfully installed mozsystemmonitor 16:28:49 INFO - Cleaning up... 16:28:50 INFO - Return code: 0 16:28:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258820>, '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 0x2259520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22599b0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', '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 16:28:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:28:50 INFO - Using env: {'DISPLAY': ':0', 16:28:50 INFO - 'HOME': '/home/cltbld', 16:28:50 INFO - 'LANG': 'en_US.UTF-8', 16:28:50 INFO - 'LANGUAGE': 'en_US:en', 16:28:50 INFO - 'LOGNAME': 'cltbld', 16:28:50 INFO - 'MAIL': '/var/mail/cltbld', 16:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:50 INFO - 'MOZ_NO_REMOTE': '1', 16:28:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:50 INFO - 'NO_EM_RESTART': '1', 16:28:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:50 INFO - 'PWD': '/builds/slave/test', 16:28:50 INFO - 'SHELL': '/bin/bash', 16:28:50 INFO - 'SHLVL': '1', 16:28:50 INFO - 'TERM': 'linux', 16:28:50 INFO - 'TMOUT': '86400', 16:28:50 INFO - 'USER': 'cltbld', 16:28:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', 16:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:50 INFO - '_': '/tools/buildbot/bin/python'} 16:28:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:50 INFO - Downloading/unpacking jsonschema==2.5.1 16:28:50 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 16:28:50 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 16:28:50 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 16:28:50 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 16:28:50 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 16:28:50 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 16:28:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:28:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:28:52 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 16:28:52 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 16:28:52 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 16:28:52 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 16:28:52 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 16:28:52 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 16:28:53 INFO - Downloading functools32-3.2.3-2.tar.gz 16:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:28:53 INFO - warning: no files found matching '*.txt' 16:28:53 INFO - no previously-included directories found matching 'build' 16:28:53 INFO - no previously-included directories found matching 'dist' 16:28:53 INFO - no previously-included directories found matching '.git*' 16:28:53 INFO - Installing collected packages: jsonschema, functools32 16:28:53 INFO - Running setup.py install for functools32 16:28:53 INFO - warning: no files found matching '*.txt' 16:28:53 INFO - no previously-included directories found matching 'build' 16:28:53 INFO - no previously-included directories found matching 'dist' 16:28:53 INFO - no previously-included directories found matching '.git*' 16:28:53 INFO - Successfully installed jsonschema functools32 16:28:53 INFO - Cleaning up... 16:28:53 INFO - Return code: 0 16:28:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:28: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')]} 16:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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')]} 16:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:53 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 0x1ee91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258820>, '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 0x2259520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22599b0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', '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 16:28:53 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 16:28:53 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 16:28:53 INFO - Using env: {'DISPLAY': ':0', 16:28:53 INFO - 'HOME': '/home/cltbld', 16:28:53 INFO - 'LANG': 'en_US.UTF-8', 16:28:53 INFO - 'LANGUAGE': 'en_US:en', 16:28:53 INFO - 'LOGNAME': 'cltbld', 16:28:53 INFO - 'MAIL': '/var/mail/cltbld', 16:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:53 INFO - 'MOZ_NO_REMOTE': '1', 16:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:53 INFO - 'NO_EM_RESTART': '1', 16:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:53 INFO - 'PWD': '/builds/slave/test', 16:28:53 INFO - 'SHELL': '/bin/bash', 16:28:53 INFO - 'SHLVL': '1', 16:28:53 INFO - 'TERM': 'linux', 16:28:53 INFO - 'TMOUT': '86400', 16:28:53 INFO - 'USER': 'cltbld', 16:28:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', 16:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:53 INFO - '_': '/tools/buildbot/bin/python'} 16:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:28:53 INFO - Cleaning up... 16:28:53 INFO - Return code: 0 16:28:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:28: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')]} 16:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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')]} 16:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:53 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 0x1ee91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258820>, '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 0x2259520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22599b0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', '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 16:28:53 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 16:28:53 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 16:28:53 INFO - Using env: {'DISPLAY': ':0', 16:28:53 INFO - 'HOME': '/home/cltbld', 16:28:53 INFO - 'LANG': 'en_US.UTF-8', 16:28:53 INFO - 'LANGUAGE': 'en_US:en', 16:28:53 INFO - 'LOGNAME': 'cltbld', 16:28:53 INFO - 'MAIL': '/var/mail/cltbld', 16:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:53 INFO - 'MOZ_NO_REMOTE': '1', 16:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:53 INFO - 'NO_EM_RESTART': '1', 16:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:53 INFO - 'PWD': '/builds/slave/test', 16:28:53 INFO - 'SHELL': '/bin/bash', 16:28:53 INFO - 'SHLVL': '1', 16:28:53 INFO - 'TERM': 'linux', 16:28:53 INFO - 'TMOUT': '86400', 16:28:53 INFO - 'USER': 'cltbld', 16:28:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', 16:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:53 INFO - '_': '/tools/buildbot/bin/python'} 16:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:53 INFO - Downloading/unpacking blobuploader==1.2.4 16:28:53 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 16:28:53 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 16:28:53 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 16:28:53 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 16:28:53 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 16:28:53 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 16:28:55 INFO - Downloading blobuploader-1.2.4.tar.gz 16:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:28:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:28:55 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 16:28:55 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 16:28:55 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 16:28:55 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 16:28:55 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 16:28:55 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 16:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:28:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:28:56 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 16:28:56 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 16:28:56 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 16:28:56 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 16:28:56 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 16:28:56 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 16:28:56 INFO - Downloading docopt-0.6.1.tar.gz 16:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:28:56 INFO - Installing collected packages: blobuploader, requests, docopt 16:28:56 INFO - Running setup.py install for blobuploader 16:28:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:28:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:28:56 INFO - Running setup.py install for requests 16:28:57 INFO - Running setup.py install for docopt 16:28:57 INFO - Successfully installed blobuploader requests docopt 16:28:57 INFO - Cleaning up... 16:28:57 INFO - Return code: 0 16:28:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:57 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 0x1ee91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258820>, '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 0x2259520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22599b0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', '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 16:28:57 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 16:28:57 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 16:28:57 INFO - Using env: {'DISPLAY': ':0', 16:28:57 INFO - 'HOME': '/home/cltbld', 16:28:57 INFO - 'LANG': 'en_US.UTF-8', 16:28:57 INFO - 'LANGUAGE': 'en_US:en', 16:28:57 INFO - 'LOGNAME': 'cltbld', 16:28:57 INFO - 'MAIL': '/var/mail/cltbld', 16:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:57 INFO - 'MOZ_NO_REMOTE': '1', 16:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:57 INFO - 'NO_EM_RESTART': '1', 16:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:57 INFO - 'PWD': '/builds/slave/test', 16:28:57 INFO - 'SHELL': '/bin/bash', 16:28:57 INFO - 'SHLVL': '1', 16:28:57 INFO - 'TERM': 'linux', 16:28:57 INFO - 'TMOUT': '86400', 16:28:57 INFO - 'USER': 'cltbld', 16:28:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', 16:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:57 INFO - '_': '/tools/buildbot/bin/python'} 16:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:28:57 INFO - Running setup.py (path:/tmp/pip-wGyV_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:28:57 INFO - Running setup.py (path:/tmp/pip-R16s4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:28:57 INFO - Running setup.py (path:/tmp/pip-HXnLX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:28:57 INFO - Running setup.py (path:/tmp/pip-rtcz07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:28:57 INFO - Running setup.py (path:/tmp/pip-vLWpfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:28:57 INFO - Running setup.py (path:/tmp/pip-NilOQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:28:57 INFO - Running setup.py (path:/tmp/pip-n55mGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:28:58 INFO - Running setup.py (path:/tmp/pip-hDSaW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:28:58 INFO - Running setup.py (path:/tmp/pip-eHzlXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:28:58 INFO - Running setup.py (path:/tmp/pip-P_7MQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:28:58 INFO - Running setup.py (path:/tmp/pip-k124tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:28:58 INFO - Running setup.py (path:/tmp/pip-2Ag_DK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:28:58 INFO - Running setup.py (path:/tmp/pip-q5qWaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:28:58 INFO - Running setup.py (path:/tmp/pip-E0UiCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:58 INFO - Running setup.py (path:/tmp/pip-qdEcI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:28:58 INFO - Running setup.py (path:/tmp/pip-gAsnNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:28:58 INFO - Running setup.py (path:/tmp/pip-Xn5OTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:28:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:28:58 INFO - Running setup.py install for manifestparser 16:28:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:28:58 INFO - Running setup.py install for mozcrash 16:28:58 INFO - Running setup.py install for mozdebug 16:28:59 INFO - Running setup.py install for mozdevice 16:28:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:28:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:28:59 INFO - Running setup.py install for mozfile 16:28:59 INFO - Running setup.py install for mozhttpd 16:28:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:28:59 INFO - Running setup.py install for mozinfo 16:28:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:28:59 INFO - Running setup.py install for mozInstall 16:28:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:28:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:28:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:28:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:28:59 INFO - Running setup.py install for mozleak 16:28:59 INFO - Running setup.py install for mozlog 16:28:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:28:59 INFO - Running setup.py install for moznetwork 16:28:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:28:59 INFO - Running setup.py install for mozprocess 16:28:59 INFO - Running setup.py install for mozprofile 16:29:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:29:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:29:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:29:00 INFO - Running setup.py install for mozrunner 16:29:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:29:00 INFO - Running setup.py install for mozscreenshot 16:29:00 INFO - Running setup.py install for moztest 16:29:00 INFO - Running setup.py install for mozversion 16:29:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:29:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:29:00 INFO - Cleaning up... 16:29:00 INFO - Return code: 0 16:29:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29:00 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')]} 16:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:00 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')]} 16:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:00 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 0x1ee91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258820>, '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 0x2259520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22599b0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', '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 16:29:00 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 16:29:00 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 16:29:00 INFO - Using env: {'DISPLAY': ':0', 16:29:00 INFO - 'HOME': '/home/cltbld', 16:29:00 INFO - 'LANG': 'en_US.UTF-8', 16:29:00 INFO - 'LANGUAGE': 'en_US:en', 16:29:00 INFO - 'LOGNAME': 'cltbld', 16:29:00 INFO - 'MAIL': '/var/mail/cltbld', 16:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:00 INFO - 'MOZ_NO_REMOTE': '1', 16:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:00 INFO - 'NO_EM_RESTART': '1', 16:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:00 INFO - 'PWD': '/builds/slave/test', 16:29:00 INFO - 'SHELL': '/bin/bash', 16:29:00 INFO - 'SHLVL': '1', 16:29:00 INFO - 'TERM': 'linux', 16:29:00 INFO - 'TMOUT': '86400', 16:29:00 INFO - 'USER': 'cltbld', 16:29:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', 16:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:00 INFO - '_': '/tools/buildbot/bin/python'} 16:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:29:00 INFO - Running setup.py (path:/tmp/pip-VUUCgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:29:00 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)) 16:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:29:00 INFO - Running setup.py (path:/tmp/pip-Ch_Lpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:29:00 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)) 16:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:29:00 INFO - Running setup.py (path:/tmp/pip-JtuMKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:29:00 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)) 16:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:29:00 INFO - Running setup.py (path:/tmp/pip-I6GmMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:29:01 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)) 16:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:29:01 INFO - Running setup.py (path:/tmp/pip-eNqBRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:29:01 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)) 16:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:29:01 INFO - Running setup.py (path:/tmp/pip-ZWbqc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:29:01 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)) 16:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:29:01 INFO - Running setup.py (path:/tmp/pip-lSJkoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:29:01 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)) 16:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:29:01 INFO - Running setup.py (path:/tmp/pip-cUw72T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:29:01 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)) 16:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:29:01 INFO - Running setup.py (path:/tmp/pip-jrKBk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:29:01 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)) 16:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:29:01 INFO - Running setup.py (path:/tmp/pip-8mtSYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:29:01 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)) 16:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:29:01 INFO - Running setup.py (path:/tmp/pip-kMwJ_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:29:01 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)) 16:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:29:01 INFO - Running setup.py (path:/tmp/pip-rMNAbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:29:01 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)) 16:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:29:01 INFO - Running setup.py (path:/tmp/pip-JSs8IF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:29:01 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)) 16:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:29:01 INFO - Running setup.py (path:/tmp/pip-8gyVyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:29:01 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)) 16:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:01 INFO - Running setup.py (path:/tmp/pip-JjZb8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:01 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)) 16:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:29:01 INFO - Running setup.py (path:/tmp/pip-vzAAxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:29:01 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)) 16:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:29:01 INFO - Running setup.py (path:/tmp/pip-QYSpDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:29:01 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)) 16:29:01 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)) 16:29:01 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)) 16:29:01 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)) 16:29:01 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)) 16:29:01 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)) 16:29:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29:03 INFO - Downloading blessings-1.6.tar.gz 16:29:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:29:04 INFO - Installing collected packages: blessings 16:29:04 INFO - Running setup.py install for blessings 16:29:04 INFO - Successfully installed blessings 16:29:04 INFO - Cleaning up... 16:29:04 INFO - Return code: 0 16:29:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:29:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:29:04 INFO - Reading from file tmpfile_stdout 16:29:04 INFO - Current package versions: 16:29:04 INFO - argparse == 1.2.1 16:29:04 INFO - blessings == 1.6 16:29:04 INFO - blobuploader == 1.2.4 16:29:04 INFO - docopt == 0.6.1 16:29:04 INFO - functools32 == 3.2.3-2 16:29:04 INFO - jsonschema == 2.5.1 16:29:04 INFO - manifestparser == 1.1 16:29:04 INFO - mozInstall == 1.12 16:29:04 INFO - mozcrash == 1.0 16:29:04 INFO - mozdebug == 0.1 16:29:04 INFO - mozdevice == 0.49 16:29:04 INFO - mozfile == 1.2 16:29:04 INFO - mozhttpd == 0.7 16:29:04 INFO - mozinfo == 0.9 16:29:04 INFO - mozleak == 0.1 16:29:04 INFO - mozlog == 3.4 16:29:04 INFO - moznetwork == 0.27 16:29:04 INFO - mozprocess == 0.24 16:29:04 INFO - mozprofile == 0.28 16:29:04 INFO - mozrunner == 6.13 16:29:04 INFO - mozscreenshot == 0.1 16:29:04 INFO - mozsystemmonitor == 0.3 16:29:04 INFO - moztest == 0.8 16:29:04 INFO - mozversion == 1.4 16:29:04 INFO - psutil == 3.1.1 16:29:04 INFO - requests == 1.2.3 16:29:04 INFO - wsgiref == 0.1.2 16:29:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:04 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 0x1ee91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258820>, '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 0x2259520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22599b0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', '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 16:29:04 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 16:29:04 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 16:29:04 INFO - Using env: {'DISPLAY': ':0', 16:29:04 INFO - 'HOME': '/home/cltbld', 16:29:04 INFO - 'LANG': 'en_US.UTF-8', 16:29:04 INFO - 'LANGUAGE': 'en_US:en', 16:29:04 INFO - 'LOGNAME': 'cltbld', 16:29:04 INFO - 'MAIL': '/var/mail/cltbld', 16:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:04 INFO - 'MOZ_NO_REMOTE': '1', 16:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:04 INFO - 'NO_EM_RESTART': '1', 16:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:04 INFO - 'PWD': '/builds/slave/test', 16:29:04 INFO - 'SHELL': '/bin/bash', 16:29:04 INFO - 'SHLVL': '1', 16:29:04 INFO - 'TERM': 'linux', 16:29:04 INFO - 'TMOUT': '86400', 16:29:04 INFO - 'USER': 'cltbld', 16:29:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', 16:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:04 INFO - '_': '/tools/buildbot/bin/python'} 16:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:04 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)) 16:29:04 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)) 16:29:04 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)) 16:29:04 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)) 16:29:04 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)) 16:29:04 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)) 16:29:04 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)) 16:29:04 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)) 16:29:04 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)) 16:29:04 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)) 16:29:04 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)) 16:29:04 INFO - Cleaning up... 16:29:04 INFO - Return code: 0 16:29:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:04 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 0x1ee91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225b480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2258820>, '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 0x2259520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22599b0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', '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 16:29:04 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 16:29:04 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 16:29:04 INFO - Using env: {'DISPLAY': ':0', 16:29:04 INFO - 'HOME': '/home/cltbld', 16:29:04 INFO - 'LANG': 'en_US.UTF-8', 16:29:04 INFO - 'LANGUAGE': 'en_US:en', 16:29:04 INFO - 'LOGNAME': 'cltbld', 16:29:04 INFO - 'MAIL': '/var/mail/cltbld', 16:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:04 INFO - 'MOZ_NO_REMOTE': '1', 16:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:04 INFO - 'NO_EM_RESTART': '1', 16:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:04 INFO - 'PWD': '/builds/slave/test', 16:29:04 INFO - 'SHELL': '/bin/bash', 16:29:04 INFO - 'SHLVL': '1', 16:29:04 INFO - 'TERM': 'linux', 16:29:04 INFO - 'TMOUT': '86400', 16:29:04 INFO - 'USER': 'cltbld', 16:29:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', 16:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:04 INFO - '_': '/tools/buildbot/bin/python'} 16:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:29:04 INFO - Cleaning up... 16:29:04 INFO - Return code: 0 16:29:04 INFO - Running post-action listener: _resource_record_post_action 16:29:04 INFO - Running post-action listener: _start_resource_monitoring 16:29:04 INFO - Starting resource monitoring. 16:29:04 INFO - [mozharness: 2017-02-03 00:29:04.991338Z] Finished create-virtualenv step (success) 16:29:04 INFO - [mozharness: 2017-02-03 00:29:04.992280Z] Running install step. 16:29:04 INFO - Running pre-action listener: _resource_record_pre_action 16:29:04 INFO - Running main action method: install 16:29:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:29:05 INFO - Reading from file tmpfile_stdout 16:29:05 INFO - Detecting whether we're running mozinstall >=1.0... 16:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:29:05 INFO - Reading from file tmpfile_stdout 16:29:05 INFO - Output received: 16:29:05 INFO - Usage: mozinstall [options] installer 16:29:05 INFO - Options: 16:29:05 INFO - -h, --help show this help message and exit 16:29:05 INFO - -d DEST, --destination=DEST 16:29:05 INFO - Directory to install application into. [default: 16:29:05 INFO - "/builds/slave/test"] 16:29:05 INFO - --app=APP Application being installed. [default: firefox] 16:29:05 INFO - mkdir: /builds/slave/test/build/application 16:29:05 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'] 16:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:29:21 INFO - Reading from file tmpfile_stdout 16:29:21 INFO - Output received: 16:29:21 INFO - /builds/slave/test/build/application/firefox/firefox 16:29:21 INFO - Running post-action listener: _resource_record_post_action 16:29:21 INFO - [mozharness: 2017-02-03 00:29:21.500979Z] Finished install step (success) 16:29:21 INFO - [mozharness: 2017-02-03 00:29:21.501256Z] Running run-tests step. 16:29:21 INFO - Running pre-action listener: _resource_record_pre_action 16:29:21 INFO - Running main action method: run_tests 16:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:29:21 INFO - Python 2.7.3 16:29:21 INFO - Return code: 0 16:29:21 INFO - grabbing minidump binary from tooltool 16:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:21 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 0x2258820>, '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 0x2259520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22599b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:29:21 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 16:29:21 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 16:29:21 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 16:29:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:29:21 INFO - Return code: 0 16:29:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:29:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:29:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:29:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:29:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:29:21 INFO - Using env: {'DISPLAY': ':0', 16:29:21 INFO - 'HOME': '/home/cltbld', 16:29:21 INFO - 'LANG': 'en_US.UTF-8', 16:29:21 INFO - 'LANGUAGE': 'en_US:en', 16:29:21 INFO - 'LOGNAME': 'cltbld', 16:29:21 INFO - 'MAIL': '/var/mail/cltbld', 16:29:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:29:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:21 INFO - 'MOZ_NO_REMOTE': '1', 16:29:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:21 INFO - 'NO_EM_RESTART': '1', 16:29:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:21 INFO - 'PWD': '/builds/slave/test', 16:29:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:29:21 INFO - 'SHELL': '/bin/bash', 16:29:21 INFO - 'SHLVL': '1', 16:29:21 INFO - 'TERM': 'linux', 16:29:21 INFO - 'TMOUT': '86400', 16:29:21 INFO - 'USER': 'cltbld', 16:29:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002', 16:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:21 INFO - '_': '/tools/buildbot/bin/python'} 16:29:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:29:22 INFO - mozversion application_buildid: 20170202235549 16:29:22 INFO - mozversion application_changeset: b4b23e49820c6de9658539e6a748f5b9515f42f5 16:29:22 INFO - mozversion application_display_name: Nightly 16:29:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:29:22 INFO - mozversion application_name: Firefox 16:29:22 INFO - mozversion application_remotingname: firefox 16:29:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:29:22 INFO - mozversion application_vendor: Mozilla 16:29:22 INFO - mozversion application_version: 54.0a1 16:29:22 INFO - mozversion platform_buildid: 20170202235549 16:29:22 INFO - mozversion platform_changeset: b4b23e49820c6de9658539e6a748f5b9515f42f5 16:29:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:29:22 INFO - mozversion platform_version: 54.0a1 16:29:22 INFO - using testdate: 1486081762 16:29:22 INFO - actual date: 1486081762 16:29:22 INFO - starting webserver on 'localhost:43660' 16:29:22 INFO - SUITE-START | Running 2 tests 16:29:22 INFO - TEST-START | dromaeo_css 16:29:22 INFO - operating with platform_type : linux_ 16:29:22 INFO - Initialising browser for dromaeo_css test... 16:29:22 INFO - TEST-INFO | started process 3304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmQ6xzH/profile http://localhost:43660/getInfo.html) 16:29:28 INFO - PROCESS | 3304 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 16:29:28 INFO - PROCESS | 3304 | __metrics Screen width/height:1600/1200 16:29:28 INFO - PROCESS | 3304 | colorDepth:24 16:29:28 INFO - PROCESS | 3304 | Browser inner width/height: 1024/697 16:29:28 INFO - PROCESS | 3304 | __metrics 16:29:29 INFO - PROCESS | 3304 | 1486081769259 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6301:36 < canClose@browser.js:5167:12 < forceQuit@jar:file:///tmp/tmpmQ6xzH/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpmQ6xzH/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpmQ6xzH/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpmQ6xzH/profile/extensions/talos-powers@TalosPowersService.js:55:9 16:29:29 ERROR - PROCESS | 3304 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 16:29:30 INFO - TEST-INFO | 3304: exit 0 16:29:30 INFO - Browser initialized. 16:29:30 INFO - Running cycle 1/1 for dromaeo_css test... 16:29:30 INFO - TEST-INFO | started process 3426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmQ6xzH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:29:42 INFO - PROCESS | 3426 | RSS: Main: 160763904 16:29:42 INFO - PROCESS | 3426 | 16:32:45 INFO - PROCESS | 3426 | Cycle 1(1): loaded http://localhost:43660/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43660/tests/dromaeo/cssquery-ext.html) 16:32:47 INFO - PROCESS | 3426 | RSS: Main: 169881600 16:32:47 INFO - PROCESS | 3426 | 16:34:30 INFO - PROCESS | 3426 | ************************* 16:34:30 INFO - PROCESS | 3426 | A coding exception was thrown and uncaught in a Task. 16:34:30 INFO - PROCESS | 3426 | 16:34:30 ERROR - PROCESS | 3426 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:34:30 INFO - PROCESS | 3426 | Full stack: 16:34:30 INFO - PROCESS | 3426 | ************************* 16:35:49 INFO - PROCESS | 3426 | Cycle 1(1): loaded http://localhost:43660/tests/dromaeo/cssquery-ext.html (next: http://localhost:43660/tests/dromaeo/cssquery-jquery.html) 16:35:50 INFO - PROCESS | 3426 | RSS: Main: 164696064 16:35:50 INFO - PROCESS | 3426 | 16:38:52 INFO - PROCESS | 3426 | Cycle 1(1): loaded http://localhost:43660/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43660/tests/dromaeo/cssquery-mootools.html) 16:38:53 INFO - PROCESS | 3426 | RSS: Main: 172257280 16:38:53 INFO - PROCESS | 3426 | 16:41:55 INFO - PROCESS | 3426 | Cycle 1(1): loaded http://localhost:43660/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43660/tests/dromaeo/cssquery-prototype.html) 16:41:56 INFO - PROCESS | 3426 | RSS: Main: 164679680 16:41:56 INFO - PROCESS | 3426 | 16:44:58 INFO - PROCESS | 3426 | Cycle 1(1): loaded http://localhost:43660/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43660/tests/dromaeo/cssquery-yui.html) 16:44:59 INFO - PROCESS | 3426 | RSS: Main: 168935424 16:44:59 INFO - PROCESS | 3426 | 16:48:02 INFO - PROCESS | 3426 | Cycle 1(1): loaded http://localhost:43660/tests/dromaeo/cssquery-yui.html (next: http://localhost:43660/tests/dromaeo/cssquery-dojo.html) 16:48:02 INFO - PROCESS | 3426 | RSS: Main: 169971712 16:48:02 INFO - PROCESS | 3426 | 16:48:02 INFO - PROCESS | 3426 | __start_tp_report 16:48:02 INFO - PROCESS | 3426 | _x_x_mozilla_page_load 16:48:02 INFO - PROCESS | 3426 | _x_x_mozilla_page_load_details 16:48:02 INFO - PROCESS | 3426 | |i|pagename|runs| 16:48:02 INFO - PROCESS | 3426 | |0;dojo.html;2578.6003169508726;2581.62566427868;2588.534063868503;2604.5832666773313;2622.8164028517986;4681.063787242557;4762.761861906908;4773.498782627822;4794.6643734938525;4801.927971080437;4723.362346083286;4727.716337019781;4743.241081426972;4768;4770.4275486941615;4326.113146804905;4347.304431290994;4390.934135987963;4395.494518130408;4447.666425018137;4364.454443194601;4455.754933478657;4456.910861782762;4457.910841783162;4458.71018383804;307.76497458211065;4340.283853164224;4341.044970106572;4456.59890609845;4457.955420445803;3925.2738243425056;4393.450818647669;4397.31841564558;4403.889902752425;4454.420925279725;4371.540988196257;4402.80187391565;4404.537523560044;4418.977905110454;4435.3125265583885;4652.697574657636;4676.672632915697;4718.150732868083;4785.760711964388;4820.951790482085;5093.083245015896;5110.872228194287;5135.74321283938;5184.6629969052265;5185.455527169631;5156.407013193493;5165.509276618715;5165.948340516585;5177.637565370425;5225.477452254782;4666.416697912761;4725.149473094876;4830.4203495580405;4837.758112094381;4851.51484851512;5157.32954715892;5159.690418574897;5160.845174644766;5167.328247327823;5169.689818610896;4901.705897646153;4944.134776414113;4944.159492886218;4980.2778597103215;4986.950130498649;5024.673396229234;5025.748712564357;5031.496850314939;5043.293938848564;5048.419431765321;4927.90144197114;4974.875628109254;4993.975030124826;4995.325631039836;5016.824411145592;4997.475265097185;5037.370328708911;5046.066477701564;5073.365829271341;5109.489051094935;4162.5629308922735;4273.67947403946;4283.121959998193;4290.849820256276;4328.2425575524785;3695.1685870678884;3703.2963736889906;3765.3410653135593;3771.2268984858038;3784.810759462016;4343;4382.956170438255;4409.845655402046;4411.536788637211;4492.528284530143;5145.665531740425;5192.7403629818355;5195.9088591395475;5206.453322401093;5226.686398816083;4301.720388174758;4374.431323927869;4391.121775644884;4430.202563538594;4473.664475164375;4527.750973696412;4569.497355290915;4641.976790116096;4648.7443190624845;4722.268048452495;4858;4867.58625516835;4877.609791216765;4890.217565189552;4918.655694101379;5209.426963033988;5210.895782084262;5223.738813059408;5229.320188375486;5284.603654725988;4665.720056796467;4675.719456832601;4713.057388522241;4721.102990431807;4729.314249433882;4974.204127339608;4982.950170498394;4991.301217829434;5000.374953130859;5019.0463811875625;5042.621803364836;5044.167712327425;5044.369453818273;5047.4952504749235;5096.133657278346;4864.440589332272;4909.4354149273295;4925.926111108264;4941.481144479778;4977.129002424489;4967.329410529533;5002.049610573979;5007.84976450707;5022.673526220784;5044.571211446922;4867.63492738039;4935.383077115361;4941.678790878582;4948.430930443045;4962.057209130254;4945.23348880924;4951.183054795918;5062.898742025212;5068.366454193226;5116.667416617908;4968.056069346812;5002.174641184164;5005.749712514433;5020.146575082172;5032.547070763649 16:48:02 INFO - PROCESS | 3426 | |1;ext.html;514.5600511562614;523.3249108649842;531.7235037780355;540.789092254021;548.6378989866689;38665.80667096664;40966;41012;41189.17621647573;45091;41816.58183418165;42230.366544501856;42291.577084229146;42346.364804527955;42402.36396454056;7713.460057795956;7889.842203155933;7890.329322007637;7895.8420831583335;9664.468454235015;9527.285453590974;9861.556229969632;9862.802743945116;9872.407655540655;9914;9908.810942686887;9915.603375864994;9973.750656233617;9976.700698979006;9984.700458986243;9792.706218813411;9884.80230395388;9891.208703303719;9894.80210395788;9897.703068907944;9731.12419882214;9861.359011664219;9889.258305627034;9911.90088099117;9944.552495137665;34007.65992340069;34094.82952585221;34285.65714342875;34305.313893721985;34318.485222721676;3476.148343655795;3516.894493165209;3541.1324225564645;3556.893293201208;3605.170810713524;25805.870970645028;25865.224043278733;25914.352141196432;26081.60877586838;26848.59727104095;2953.246922034889;2953.320736230679;2961.748251398634;2965.6737758846725;3014.5478178273215;228350;228861.8556907205;229337;229532;229885.99999999834;44964.55035449604;45339;45582.31626525605;45672.54327456683;45708.542914571095;48346.27480587794;48454;48517.5148248513;48520;48568.5143148564;13499.325033748273;13908.304584770722;13936.303184840717;13942.37259323333;13970.511032113827;9808.313418060667;10106;10357.792844143074;10780.730481738019;11094.22340436178;16380.754288685679;16467;16500.917495412446;16511.504654860135;16532.256048477848;6715.496337774686;6780.627065511444;6804.455643548505;6903.206131294965;6923.826904327331;785.9567723775133;802.5104686141449;819.2258315891545;830.9709160179365;838.7944953486435;24444.633330500055;25932.8703356482;26471;26503;28652.283692907844;851.3614788908319;854.2866706300309;876.1294635952161;880.854658981261;993.7267251505749;12545.686357840945;13142.211467311992;13185.142965707199;13328.800067998987;13385.866141338656;349359;349813;352006;352049;352309;41063.1787364257;41372;41569;41599.37600935988;41827.58172418237;1242.310517662706;1252.092233130991;1262.501311981762;1270.4918032786775;1280.3790161771533;23264.76735232626;23417.180398685963;24269.757302427457;24538.754612453646;24743.62884556769;36066.4590031155;36380;36704;36770.26459470742;36795.26409471742;246332;246606;247114;247191;247814;22605.43486412853;23233.88383058074;23697.644535331638;23948.880255599306;25074.37314067163;33877.153071173416;34213;35991.64008359988;36221.63778362182;36695.449568255965;30572.08283751491;30959.69040309568;31107;31325.373492530478;31577.684223157474;30192.698073019867;30279.848600757738;30380.5442918352;31421.214469638442;31432;29899.850500747358;29903.252418689706;30159.69840301569;31832.204194895312;32605.836970814995;27051.1884643461;27759.722402775715;29471.26321841971;29831.254218644706;29842.55236171416;22615.321540353816;23494.53010939806;23583.64624530599;23625.52748945046;23729 16:48:02 INFO - PROCESS | 3426 | |2;jquery.html;369.82248520710044;375.768902125193;384.74222271078366;385.7087898636529;400.1337105167313;16720.2475888585;17403.60346852589;17531.47405577833;17632.911835440806;17664.293428262856;10975.121990240781;11052.336859788418;11055.0603198728;11056.502457389437;11129.833052504218;4760.547747963947;4772.642051846108;4822.87942801431;4879.878003049935;4880.829170978998;4799.13615549201;4877.9268310975185;5232.633715639907;5498.065328894098;5524.4199359067325;5570.6657600543895;5573.777048918038;5574.331080270353;5575;5576.386597474295;5542.5565954723725;5615.943840561583;6043.637381757087;6079.331273559905;6097.969510152465;5390.946090539083;5390.946090539122;5394.352677678665;5397.217403476474;5412.539934105605;12252.938735306267;18144.637107257913;18321.26714931401;21434.57130857374;21620.243291484723;2131.7548481924623;2152.9892350538303;2226.499037716501;2242.2264318809985;2242.8766417847014;8432.957835210786;8921.330900182447;9154.450732956044;9302.20931220847;9496.430214187101;1717.9828201718074;1770.2211027148014;1781.5189898727272;1790.588164722108;1801.7567628370264;70756.64621676858;71952.2804771956;77088.22911770923;78504.60747696225;79985;10360.756709194795;10408.791824163474;10542.314749541256;10744.409057501756;10867.29362591429;14850.777238341434;14872.182029988238;14927.25363731809;14983.625409364635;15018.849811501963;7219.133703955559;7471.887921681179;7491.775246742606;7723.227677232232;7725.150233474314;7063.470239731938;7065.116860392451;7227.710891564384;7274.599897005715;7278.745243916437;4373.606375426227;4411.977940110279;4422.115576884572;4455.576720211575;4485.798139083749;1523.451557439321;1574.1735588815734;1777.70667839805;1883.8681292309682;1937.3897222374908;929.3448119076036;960.4237457525569;972.3242346569208;1004.7287232447344;1011.4588695048114;16972.74540881888;17402.21690023952;17571.648567028587;17823;17845;967.2165545907837;968.1867231525412;974.7855471796194;982.5824024789435;991.0485933503772;9544.475053872104;9653.420794752337;9717.902820971842;9832.410055396698;9841.803163936682;500450;500456;504569;527293;528499;89365.55317223372;89921;90351.54824225837;91784;92043.53978230066;903.3270213690711;906.5376657904516;927.8561822917459;929.2426672262085;933.9346245762731;14671.26643667791;14952.401903923721;14958;16554.503364899072;17058.402955896483;39247.60752392554;40366.39450408187;41375.37936930888;41970.160596788504;43480.34779478247;52173;52194.47805522048;52712.73643631911;53214.201786974;55369;7351.228121047427;7500;7528;7700.3454706350585;7855.5286682799215;9030.548472576213;11823.645290641294;12457.813132802834;12568.183068100545;12849.486020559072;9640.807183856425;10534.262601617813;10787.892121078688;11113.666590002313;11340.319580825177;10015.349002314826;10249.538770755185;10358.015988481384;10696.465176741287;10866.836997445203;10896.782064358827;10935.28920620189;10983.286086404358;11239;11317;6760.86478270422;6839.418649414656;7138.964305178441;7213.71145154188;7306.853862922818;8995.415298005608;9949.502524873582;9968;10152.898471015194;10299.330543514647 16:48:02 INFO - PROCESS | 3426 | |3;mootools.html;1090.2695194219873;1111.827666711659;1112.6050252160485;1128.3286444565485;1160.054555537237;6497.545171837974;6722.731090756364;6906.965465172673;7444.069491313586;7446.441516886228;6996;7237.384822290099;7243.492955493118;7425.665845036973;7479.925200747991;2105.105330234652;2147.4631342164457;2151.2148065955894;2151.247063527768;2152.881591512466;2116.7036614873855;2127.2129312154525;2171.913123475067;2173.836962227839;2190.3319487556287;2023.8380929525604;2042.3974927396453;2044.2436298569476;2045.1614837916457;2047.1299697628522;2031.7155598216261;2035.867668601551;2047.836173106148;2068.5449201175793;2076.9376918692387;1974.5261137327082;1996.5308152584132;2022.6258142243732;2022.9696554551547;2086.9478263043393;7476;7505.399568034599;7526.8118297042465;7529.7364592239555;7530.209328020534;4340.826366945318;4441.133978874121;4444.6666500012625;4444.911101777946;4468.352088947117;2664.7468490493566;2774.153883065664;2823.8023338366324;2826.307554649124;2827.067067867599;1050.3592808386877;1054.2620165883911;1090.6946055104584;1091.476091476096;1105.077260487494;9553.952230238805;9563.90436095637;9622.566984485715;9641.855372169422;9658.75853103678;3665.9083522911606;3829.1384438501673;3842.212346468967;3847.2690188864026;3893.9610603894166;7893.329067029367;7893.565853877977;7894.802629934297;7896.881546776803;7906.327962123169;4401.867943961686;4402.779861006937;4405.889852753707;4408.096340250241;4408.735475871458;3943.408488726714;4026.91946161081;4160.791960401968;4166.145940082276;4182.121754431542;3120.5943227380294;3139.5447660089158;3192.4995252231415;3208.197950512372;3211.4861622140347;848.4061157189992;880.5949263338807;894.1014280647908;915.4919019943995;946.4652471353801;684.1482354468718;701.5404909784099;783.2793829676712;814.242754238552;834.0908409833311;4838.790302424394;4907.092187945242;4914.975425122923;4943.950560494421;4986.90026199474;871.2550769092461;879.1252703559871;890.6882591093195;912.0788004115891;915.4208989493071;3181.7772755907326;3229.564008858774;3234.75739319552;3249.6425393206728;3304.7521435892404;8569.614367353359;8880.1563851434;9015;9024.8646270306;9030.774230644154;8936.374453788303;8943.686970955985;8944.37389382737;8948.910510894937;8952.8657070144;7006.50954433195;7107.36033756954;7110.893336599956;7115.466340024519;7139.89290160648;4758.952410475851;4832.251001094836;4938.950610493849;4986.975065124796;5082.263071854634;7756.650950707119;8051.114377418362;8070.43506954531;8147.144549822184;8224.671013159406;8045.839083218186;8163.918360816316;8201.30288925448;8212.712555060783;8224.136465671258;6368.4586810121655;6454.548181627429;6494.383033611799;6498.3826536478955;6526.934730652632;6753.527253092433;6939.89590156138;6973.267806880204;7001.334873187243;7095.219525852049;5597.384287728428;6069.635821850703;6136.7852125175405;6220.377962203925;6293.087502312231;6295.087212354275;6434.871302573829;6436.967815160894;6440.0983862260255;6447.774327898501;5641.266635337544;5657.43425657431;5673.914891276717;5677.8864422710485;5694.772209111589;4291.163223171577;4310.741355518679;4312.116016216605;4357.67317451186;4436.157130145262;4128.731632443882;4289.420928174656;4315.244832154423;4346.956530434655;4427.911441771211 16:48:02 INFO - PROCESS | 3426 | |4;prototype.html;333.06820441439646;337.38764143080306;348.0671799577132;348.16614208969503;350.74570936071353;4789.467370441452;4903.779329930153;4983.252512123183;5021.372328458938;5032.974835125829;4814.975925120379;4909.779059942302;4924.414682291798;4933.481984391641;4938.012397520492;3962.841486340543;3971.98014009931;3973.040085136577;3976.224636195943;4007.939880901789;3881.340172170738;3991.900202494932;3993.400989851531;3995.6204160604843;3997.8001099944886;3924.9795053286066;3941.9014524636827;3954.567940716453;3955.4857868477056;3956.6834653227816;3944.5660977292473;3947.519680119955;3953.9802300988313;3958.7426817256787;3975.7614543127506;3563.127033876691;3566.6076731559506;3570.6786389225094;3572.982135089308;3588.9592018314656;4598.149342371672;4767.69010014348;4791.9520804791855;4829.372181616367;4845.442774080955;4541.43232095988;4542.727436353829;4543.591896294969;4545.386372839657;4553.54464553542;5239.580833533309;5240.371155461331;5246.921296180561;5247.239150323182;5258.158694608883;3466.116140384211;3653.7077033837495;3918.1380096378753;3929.607039296076;3937.803109844525;5334.706591137486;5379.354477462691;5401.4868587484125;5422.701751403672;5432.587527242906;3679.411294192916;3687.391580389259;3688.151725103188;3695.0762309422644;3697.7411581189594;3726.807421625054;3728.5525736911745;3735.6824669902817;3743.7005039596766;3752.099496120911;4207.326827707552;4275.674540892333;4279.170142722309;4280.143971205771;4288.24955632763;5082.593392528589;5137.922931155961;5147.819826306061;5155.97422012895;5183.222516622462;1250.7060840702427;1265.1839563481687;1275.948962041508;1282.2114399644151;1283.544341758681;843.8987121806102;858.8969323681198;871.7210492642421;878.8945326560854;880.8986966498807;4358.3244597087505;4390.363397307373;4391.670624703096;4403.2734598791485;4406.339049142654;5106.238347770013;5155.432902380735;5184.766685499161;5186.948130518722;5222.869428264324;4371.7103454481;4437.29003359461;4441.555844415597;4445.955540444619;4464.330350447459;2562.820602557803;2717.96152885336;2731;2744.533429317021;2768.224897028835;4775.5463230993;4820.396985627722;4827.686200396963;4862.610991120702;4882.8779280517565;5023.522765337287;5248.9737551312;5280.973595132076;5289.550388216968;5320.255164277004;4788.976055119702;4821.46963833985;4829.213191119238;4843.685160464559;4874.2444921037295;5130.537342075899;5144.639875208849;5176.327077479904;5182.66312689689;5194.6234947284565;4963.228887107467;5014.36745708506;5106.872328191676;5107.361579802525;5122.820701275437;4794.856154315376;4796.640251981185;4826.613870890391;4830.516948305141;4838.346823178967;3669.1930673034617;3671.1372827386076;3698.4452332150395;3702.685821361649;3712.5730540988134;5014.949850501448;5219.2953951216095;5229.084910140787;5230.443298557017;5249.632525723163;4913.631477639263;4936.802527898843;4962.875928101682;4986.78088250725;5017.37282839645;4991.101601711582;5031.320771695774;5035.597152227886;5063.189889617791;5091.159958606937;4674.966389620526;4898.24077268024;4945.975270123627;4948.604111671129;4958.181899986462;4994.877177199748;4996.800127994839;5003.77483013258;5009.924851127309;5013.874653133701;4924.458309585871;4928.673145626759;4932.358793356841;4971.950280497149;4975.616580725142 16:48:02 INFO - PROCESS | 3426 | |5;yui.html;659.337365947223;682.2699711308899;724.6376811594203;746.1568427676724;747.9775606731798;12856.485740570377;13253.204807711543;13340.39968201431;13362.933185334059;13409.865901340983;13206.867931320683;13417.262050587215;13427;13441.596752097428;13484.393202305895;652.3834975947708;670.993290067098;775.9689612415497;790.8971833661616;815.5392203405087;790.0322105420871;790.3835008693228;790.746960972489;791.4103992525577;792.742358733414;863.240348493325;863.8920134983127;863.896332440108;868.5570359116864;868.6916144768611;860.2257967828941;860.5224100624151;867.6095756909353;868.8392647360258;868.9832895512266;626.1171747835575;627.1251604012377;629.5876201088295;630.7256343490596;631.6052467207995;13348.399322030435;13426.664333391645;13814.309284535833;13927.442902283896;13930.233837138954;13134.73730525384;13580.357587529299;13651.795223071662;13654.180749155083;14087;10570.947145264301;10828.675139745741;10851.77538604592;10869.83695244572;10965.451727413598;3294.1929227339215;3323.268880846234;3353.446681297583;3476.200473890994;3480.8781692640637;58039.70980145072;60724.39275607232;62034.68982655103;63172.68413657948;63394.68302658457;10407.53166107527;10445.68662940113;10478;10798.190135739695;10834.620788272372;20519.589608207752;20663.58672826535;20692.793072069086;20892;21042.47393815136;6310.242770867525;6323.620582765049;6547.410733034049;6595.373439523238;6627.5029372797235;3497.370473314777;3546.8049257291095;3576.1417259857967;3577.3203091412547;3645.0340659725193;2642.5771876499666;2670.9599356009285;2691.515527205083;2705.959410608803;2711.864406779653;473.8483685220765;478.2085648252148;478.69794159885055;490.9091818013679;495.982640607577;551.9392866784731;576.8298351986174;586.1266712598198;587.632729544035;608.0909040983757;8215.424920255644;8261.339092872557;8415.747527574182;8755.781105472413;8812.427192232613;521.8747500599904;544.4392275955772;548.3173449055871;576.8961586914396;605.9363766804511;4095.7542547447247;4102.517976624099;4105.692073094529;4121.690873184523;4247.299195632748;68617.3138268611;68651.65674171697;69034.65482672655;71348.64325678338;71711.28288717046;58490;58673.70663146657;58742;58829;61743.6912815433;53282.46717532775;53702.7314863431;54046;54563.45436545584;54714;7830.2952734254195;8088.919110808816;8250.298724608476;8279.461834980708;8313.916860831314;36673.26653466969;37286.813565931996;37810.243795124494;39054.6094539051;39077.609223908534;44743.55256447394;46306.76846615745;49078.619779428445;50326.7483662594;50897.491025090756;11429.714257143638;12223.44994475233;12356.25862448256;13049.739005220032;13064.085514013928;13143.408546615616;13177.604671859859;13335.733285334045;13639.659008524866;13766.724665506434;11369.54521819118;11497.367644779617;11823.349715765715;11886.34625095628;12239.449224784728;12579.874201258237;12697.541976890774;12827.807582886451;13090.672733181747;13127.844765631284;11689.649310520697;12033;12076.335801531;12560.183588067111;12637.368131593568;9583.329166958247;9796.07205850301;10059.39643621385;10309.329893556895;10326;9095.818083638158;10150.593976240867;10285.640002599874;10296.948515257376;10324.845127323246 16:48:02 INFO - PROCESS | 3426 | __end_tp_report 16:48:02 INFO - PROCESS | 3426 | __start_cc_report 16:48:02 INFO - PROCESS | 3426 | _x_x_mozilla_cycle_collect,360 16:48:02 INFO - PROCESS | 3426 | __end_cc_report 16:48:02 INFO - PROCESS | 3426 | __startTimestamp1486082882738__endTimestamp 16:48:02 INFO - PROCESS | 3426 | 16:48:02 INFO - PROCESS | 3426 | ------- Summary: start ------- 16:48:02 INFO - PROCESS | 3426 | Number of tests: 6 16:48:02 INFO - PROCESS | 3426 | 16:48:02 INFO - PROCESS | 3426 | [#0] dojo.html Cycles:165 Average:4685.91 Median:4867.59 stddev:613.26 (12.6%) stddev-sans-first:592.44 16:48:02 INFO - PROCESS | 3426 | Values: 2578.6 2581.6 2588.5 2604.6 2622.8 4681.1 4762.8 4773.5 4794.7 4801.9 4723.4 4727.7 4743.2 4768.0 4770.4 4326.1 4347.3 4390.9 4395.5 4447.7 4364.5 4455.8 4456.9 4457.9 4458.7 307.8 4340.3 4341.0 4456.6 4458.0 3925.3 4393.5 4397.3 4403.9 4454.4 4371.5 4402.8 4404.5 4419.0 4435.3 4652.7 4676.7 4718.2 4785.8 4821.0 5093.1 5110.9 5135.7 5184.7 5185.5 5156.4 5165.5 5165.9 5177.6 5225.5 4666.4 4725.1 4830.4 4837.8 4851.5 5157.3 5159.7 5160.8 5167.3 5169.7 4901.7 4944.1 4944.2 4980.3 4987.0 5024.7 5025.7 5031.5 5043.3 5048.4 4927.9 4974.9 4994.0 4995.3 5016.8 4997.5 5037.4 5046.1 5073.4 5109.5 4162.6 4273.7 4283.1 4290.8 4328.2 3695.2 3703.3 3765.3 3771.2 3784.8 4343.0 4383.0 4409.8 4411.5 4492.5 5145.7 5192.7 5195.9 5206.5 5226.7 4301.7 4374.4 4391.1 4430.2 4473.7 4527.8 4569.5 4642.0 4648.7 4722.3 4858.0 4867.6 4877.6 4890.2 4918.7 5209.4 5210.9 5223.7 5229.3 5284.6 4665.7 4675.7 4713.1 4721.1 4729.3 4974.2 4983.0 4991.3 5000.4 5019.0 5042.6 5044.2 5044.4 5047.5 5096.1 4864.4 4909.4 4925.9 4941.5 4977.1 4967.3 5002.0 5007.8 5022.7 5044.6 4867.6 4935.4 4941.7 4948.4 4962.1 4945.2 4951.2 5062.9 5068.4 5116.7 4968.1 5002.2 5005.7 5020.1 5032.5 16:48:02 INFO - PROCESS | 3426 | 16:48:02 INFO - PROCESS | 3426 | [#1] ext.html Cycles:180 Average:42113.76 Median:18897.32 stddev:73692.17 (390.0%) stddev-sans-first:73832.71 16:48:02 INFO - PROCESS | 3426 | Values: 514.6 523.3 531.7 540.8 548.6 38665.8 40966.0 41012.0 41189.2 45091.0 41816.6 42230.4 42291.6 42346.4 42402.4 7713.5 7889.8 7890.3 7895.8 9664.5 9527.3 9861.6 9862.8 9872.4 9914.0 9908.8 9915.6 9973.8 9976.7 9984.7 9792.7 9884.8 9891.2 9894.8 9897.7 9731.1 9861.4 9889.3 9911.9 9944.6 34007.7 34094.8 34285.7 34305.3 34318.5 3476.1 3516.9 3541.1 3556.9 3605.2 25805.9 25865.2 25914.4 26081.6 26848.6 2953.2 2953.3 2961.7 2965.7 3014.5 228350.0 228861.9 229337.0 229532.0 229886.0 44964.6 45339.0 45582.3 45672.5 45708.5 48346.3 48454.0 48517.5 48520.0 48568.5 13499.3 13908.3 13936.3 13942.4 13970.5 9808.3 10106.0 10357.8 10780.7 11094.2 16380.8 16467.0 16500.9 16511.5 16532.3 6715.5 6780.6 6804.5 6903.2 6923.8 786.0 802.5 819.2 831.0 838.8 24444.6 25932.9 26471.0 26503.0 28652.3 851.4 854.3 876.1 880.9 993.7 12545.7 13142.2 13185.1 13328.8 13385.9 349359.0 349813.0 352006.0 352049.0 352309.0 41063.2 41372.0 41569.0 41599.4 41827.6 1242.3 1252.1 1262.5 1270.5 1280.4 23264.8 23417.2 24269.8 24538.8 24743.6 36066.5 36380.0 36704.0 36770.3 36795.3 246332.0 246606.0 247114.0 247191.0 247814.0 22605.4 23233.9 23697.6 23948.9 25074.4 33877.2 34213.0 35991.6 36221.6 36695.4 30572.1 30959.7 31107.0 31325.4 31577.7 30192.7 30279.8 30380.5 31421.2 31432.0 29899.9 29903.3 30159.7 31832.2 32605.8 27051.2 27759.7 29471.3 29831.3 29842.6 22615.3 23494.5 23583.6 23625.5 23729.0 16:48:02 INFO - PROCESS | 3426 | 16:48:02 INFO - PROCESS | 3426 | [#2] jquery.html Cycles:180 Average:28352.63 Median:4850.40 stddev:84387.40 (1739.8%) stddev-sans-first:84597.97 16:48:02 INFO - PROCESS | 3426 | Values: 369.8 375.8 384.7 385.7 400.1 16720.2 17403.6 17531.5 17632.9 17664.3 10975.1 11052.3 11055.1 11056.5 11129.8 4760.5 4772.6 4822.9 4879.9 4880.8 4799.1 4877.9 5232.6 5498.1 5524.4 5570.7 5573.8 5574.3 5575.0 5576.4 5542.6 5615.9 6043.6 6079.3 6098.0 5390.9 5390.9 5394.4 5397.2 5412.5 12252.9 18144.6 18321.3 21434.6 21620.2 2131.8 2153.0 2226.5 2242.2 2242.9 8433.0 8921.3 9154.5 9302.2 9496.4 1718.0 1770.2 1781.5 1790.6 1801.8 70756.6 71952.3 77088.2 78504.6 79985.0 10360.8 10408.8 10542.3 10744.4 10867.3 14850.8 14872.2 14927.3 14983.6 15018.8 7219.1 7471.9 7491.8 7723.2 7725.2 7063.5 7065.1 7227.7 7274.6 7278.7 4373.6 4412.0 4422.1 4455.6 4485.8 1523.5 1574.2 1777.7 1883.9 1937.4 929.3 960.4 972.3 1004.7 1011.5 16972.7 17402.2 17571.6 17823.0 17845.0 967.2 968.2 974.8 982.6 991.0 9544.5 9653.4 9717.9 9832.4 9841.8 500450.0 500456.0 504569.0 527293.0 528499.0 89365.6 89921.0 90351.5 91784.0 92043.5 903.3 906.5 927.9 929.2 933.9 14671.3 14952.4 14958.0 16554.5 17058.4 39247.6 40366.4 41375.4 41970.2 43480.3 52173.0 52194.5 52712.7 53214.2 55369.0 7351.2 7500.0 7528.0 7700.3 7855.5 9030.5 11823.6 12457.8 12568.2 12849.5 9640.8 10534.3 10787.9 11113.7 11340.3 10015.3 10249.5 10358.0 10696.5 10866.8 10896.8 10935.3 10983.3 11239.0 11317.0 6760.9 6839.4 7139.0 7213.7 7306.9 8995.4 9949.5 9968.0 10152.9 10299.3 16:48:02 INFO - PROCESS | 3426 | 16:48:02 INFO - PROCESS | 3426 | [#3] mootools.html Cycles:180 Average:4767.14 Median:5619.33 stddev:2629.31 (46.8%) stddev-sans-first:2622.16 16:48:02 INFO - PROCESS | 3426 | Values: 1090.3 1111.8 1112.6 1128.3 1160.1 6497.5 6722.7 6907.0 7444.1 7446.4 6996.0 7237.4 7243.5 7425.7 7479.9 2105.1 2147.5 2151.2 2151.2 2152.9 2116.7 2127.2 2171.9 2173.8 2190.3 2023.8 2042.4 2044.2 2045.2 2047.1 2031.7 2035.9 2047.8 2068.5 2076.9 1974.5 1996.5 2022.6 2023.0 2086.9 7476.0 7505.4 7526.8 7529.7 7530.2 4340.8 4441.1 4444.7 4444.9 4468.4 2664.7 2774.2 2823.8 2826.3 2827.1 1050.4 1054.3 1090.7 1091.5 1105.1 9554.0 9563.9 9622.6 9641.9 9658.8 3665.9 3829.1 3842.2 3847.3 3894.0 7893.3 7893.6 7894.8 7896.9 7906.3 4401.9 4402.8 4405.9 4408.1 4408.7 3943.4 4026.9 4160.8 4166.1 4182.1 3120.6 3139.5 3192.5 3208.2 3211.5 848.4 880.6 894.1 915.5 946.5 684.1 701.5 783.3 814.2 834.1 4838.8 4907.1 4915.0 4944.0 4986.9 871.3 879.1 890.7 912.1 915.4 3181.8 3229.6 3234.8 3249.6 3304.8 8569.6 8880.2 9015.0 9024.9 9030.8 8936.4 8943.7 8944.4 8948.9 8952.9 7006.5 7107.4 7110.9 7115.5 7139.9 4759.0 4832.3 4939.0 4987.0 5082.3 7756.7 8051.1 8070.4 8147.1 8224.7 8045.8 8163.9 8201.3 8212.7 8224.1 6368.5 6454.5 6494.4 6498.4 6526.9 6753.5 6939.9 6973.3 7001.3 7095.2 5597.4 6069.6 6136.8 6220.4 6293.1 6295.1 6434.9 6437.0 6440.1 6447.8 5641.3 5657.4 5673.9 5677.9 5694.8 4291.2 4310.7 4312.1 4357.7 4436.2 4128.7 4289.4 4315.2 4347.0 4427.9 16:48:02 INFO - PROCESS | 3426 | 16:48:02 INFO - PROCESS | 3426 | [#4] prototype.html Cycles:180 Average:4241.38 Median:4820.93 stddev:1207.25 (25.0%) stddev-sans-first:1174.45 16:48:02 INFO - PROCESS | 3426 | Values: 333.1 337.4 348.1 348.2 350.7 4789.5 4903.8 4983.3 5021.4 5033.0 4815.0 4909.8 4924.4 4933.5 4938.0 3962.8 3972.0 3973.0 3976.2 4007.9 3881.3 3991.9 3993.4 3995.6 3997.8 3925.0 3941.9 3954.6 3955.5 3956.7 3944.6 3947.5 3954.0 3958.7 3975.8 3563.1 3566.6 3570.7 3573.0 3589.0 4598.1 4767.7 4792.0 4829.4 4845.4 4541.4 4542.7 4543.6 4545.4 4553.5 5239.6 5240.4 5246.9 5247.2 5258.2 3466.1 3653.7 3918.1 3929.6 3937.8 5334.7 5379.4 5401.5 5422.7 5432.6 3679.4 3687.4 3688.2 3695.1 3697.7 3726.8 3728.6 3735.7 3743.7 3752.1 4207.3 4275.7 4279.2 4280.1 4288.2 5082.6 5137.9 5147.8 5156.0 5183.2 1250.7 1265.2 1275.9 1282.2 1283.5 843.9 858.9 871.7 878.9 880.9 4358.3 4390.4 4391.7 4403.3 4406.3 5106.2 5155.4 5184.8 5186.9 5222.9 4371.7 4437.3 4441.6 4446.0 4464.3 2562.8 2718.0 2731.0 2744.5 2768.2 4775.5 4820.4 4827.7 4862.6 4882.9 5023.5 5249.0 5281.0 5289.6 5320.3 4789.0 4821.5 4829.2 4843.7 4874.2 5130.5 5144.6 5176.3 5182.7 5194.6 4963.2 5014.4 5106.9 5107.4 5122.8 4794.9 4796.6 4826.6 4830.5 4838.3 3669.2 3671.1 3698.4 3702.7 3712.6 5014.9 5219.3 5229.1 5230.4 5249.6 4913.6 4936.8 4962.9 4986.8 5017.4 4991.1 5031.3 5035.6 5063.2 5091.2 4675.0 4898.2 4946.0 4948.6 4958.2 4994.9 4996.8 5003.8 5009.9 5013.9 4924.5 4928.7 4932.4 4972.0 4975.6 16:48:02 INFO - PROCESS | 3426 | 16:48:02 INFO - PROCESS | 3426 | [#5] yui.html Cycles:180 Average:15358.78 Median:4184.50 stddev:19059.77 (455.5%) stddev-sans-first:19081.27 16:48:02 INFO - PROCESS | 3426 | Values: 659.3 682.3 724.6 746.2 748.0 12856.5 13253.2 13340.4 13362.9 13409.9 13206.9 13417.3 13427.0 13441.6 13484.4 652.4 671.0 776.0 790.9 815.5 790.0 790.4 790.7 791.4 792.7 863.2 863.9 863.9 868.6 868.7 860.2 860.5 867.6 868.8 869.0 626.1 627.1 629.6 630.7 631.6 13348.4 13426.7 13814.3 13927.4 13930.2 13134.7 13580.4 13651.8 13654.2 14087.0 10570.9 10828.7 10851.8 10869.8 10965.5 3294.2 3323.3 3353.4 3476.2 3480.9 58039.7 60724.4 62034.7 63172.7 63394.7 10407.5 10445.7 10478.0 10798.2 10834.6 20519.6 20663.6 20692.8 20892.0 21042.5 6310.2 6323.6 6547.4 6595.4 6627.5 3497.4 3546.8 3576.1 3577.3 3645.0 2642.6 2671.0 2691.5 2706.0 2711.9 473.8 478.2 478.7 490.9 496.0 551.9 576.8 586.1 587.6 608.1 8215.4 8261.3 8415.7 8755.8 8812.4 521.9 544.4 548.3 576.9 605.9 4095.8 4102.5 4105.7 4121.7 4247.3 68617.3 68651.7 69034.7 71348.6 71711.3 58490.0 58673.7 58742.0 58829.0 61743.7 53282.5 53702.7 54046.0 54563.5 54714.0 7830.3 8088.9 8250.3 8279.5 8313.9 36673.3 37286.8 37810.2 39054.6 39077.6 44743.6 46306.8 49078.6 50326.7 50897.5 11429.7 12223.4 12356.3 13049.7 13064.1 13143.4 13177.6 13335.7 13639.7 13766.7 11369.5 11497.4 11823.3 11886.3 12239.4 12579.9 12697.5 12827.8 13090.7 13127.8 11689.6 12033.0 12076.3 12560.2 12637.4 9583.3 9796.1 10059.4 10309.3 10326.0 9095.8 10150.6 10285.6 10296.9 10324.8 16:48:02 INFO - PROCESS | 3426 | -------- Summary: end -------- 16:48:02 INFO - PROCESS | 3426 | 16:48:03 INFO - TEST-INFO | 3426: exit 0 16:48:03 INFO - TEST-OK | dromaeo_css | took 1121583ms 16:48:03 INFO - TEST-START | kraken 16:48:03 INFO - operating with platform_type : linux_ 16:48:03 INFO - Initialising browser for kraken test... 16:48:03 INFO - TEST-INFO | started process 3766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzAXOWS/profile http://localhost:43660/getInfo.html) 16:48:08 INFO - PROCESS | 3766 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 16:48:08 INFO - PROCESS | 3766 | __metrics Screen width/height:1600/1200 16:48:08 INFO - PROCESS | 3766 | colorDepth:24 16:48:08 INFO - PROCESS | 3766 | Browser inner width/height: 1024/697 16:48:08 INFO - PROCESS | 3766 | __metrics 16:48:08 INFO - PROCESS | 3766 | 1486082888815 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6301:36 < canClose@browser.js:5167:12 < forceQuit@jar:file:///tmp/tmpzAXOWS/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpzAXOWS/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpzAXOWS/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpzAXOWS/profile/extensions/talos-powers@TalosPowersService.js:55:9 16:48:08 ERROR - PROCESS | 3766 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 16:48:09 INFO - TEST-INFO | 3766: exit 0 16:48:09 INFO - Browser initialized. 16:48:09 INFO - Running cycle 1/1 for kraken test... 16:48:09 INFO - TEST-INFO | started process 3887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzAXOWS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:48:21 INFO - PROCESS | 3887 | RSS: Main: 160215040 16:48:21 INFO - PROCESS | 3887 | 16:48:24 INFO - PROCESS | 3887 | Cycle 1(1): loaded http://localhost:43660/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43660/tests/kraken/driver.html?testName=audio-beat-detection) 16:48:25 INFO - PROCESS | 3887 | RSS: Main: 166735872 16:48:25 INFO - PROCESS | 3887 | 16:48:28 INFO - PROCESS | 3887 | Cycle 1(1): loaded http://localhost:43660/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43660/tests/kraken/driver.html?testName=audio-dft) 16:48:29 INFO - PROCESS | 3887 | RSS: Main: 165007360 16:48:29 INFO - PROCESS | 3887 | 16:48:32 INFO - PROCESS | 3887 | Cycle 1(1): loaded http://localhost:43660/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43660/tests/kraken/driver.html?testName=audio-fft) 16:48:32 INFO - PROCESS | 3887 | RSS: Main: 162131968 16:48:32 INFO - PROCESS | 3887 | 16:48:34 INFO - PROCESS | 3887 | Cycle 1(1): loaded http://localhost:43660/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43660/tests/kraken/driver.html?testName=audio-oscillator) 16:48:35 INFO - PROCESS | 3887 | RSS: Main: 163373056 16:48:35 INFO - PROCESS | 3887 | 16:48:37 INFO - PROCESS | 3887 | Cycle 1(1): loaded http://localhost:43660/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43660/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:48:38 INFO - PROCESS | 3887 | RSS: Main: 163319808 16:48:38 INFO - PROCESS | 3887 | 16:48:41 INFO - PROCESS | 3887 | Cycle 1(1): loaded http://localhost:43660/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43660/tests/kraken/driver.html?testName=imaging-darkroom) 16:48:42 INFO - PROCESS | 3887 | RSS: Main: 167280640 16:48:42 INFO - PROCESS | 3887 | 16:48:45 INFO - PROCESS | 3887 | Cycle 1(1): loaded http://localhost:43660/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43660/tests/kraken/driver.html?testName=imaging-desaturate) 16:48:46 INFO - PROCESS | 3887 | RSS: Main: 164384768 16:48:46 INFO - PROCESS | 3887 | 16:48:49 INFO - PROCESS | 3887 | Cycle 1(1): loaded http://localhost:43660/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43660/tests/kraken/driver.html?testName=json-parse-financial) 16:48:49 INFO - PROCESS | 3887 | RSS: Main: 165072896 16:48:49 INFO - PROCESS | 3887 | 16:48:51 INFO - PROCESS | 3887 | Cycle 1(1): loaded http://localhost:43660/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43660/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:48:52 INFO - PROCESS | 3887 | RSS: Main: 165203968 16:48:52 INFO - PROCESS | 3887 | 16:48:53 INFO - PROCESS | 3887 | Cycle 1(1): loaded http://localhost:43660/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43660/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:48:54 INFO - PROCESS | 3887 | RSS: Main: 165126144 16:48:54 INFO - PROCESS | 3887 | 16:48:56 INFO - PROCESS | 3887 | Cycle 1(1): loaded http://localhost:43660/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43660/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:48:57 INFO - PROCESS | 3887 | RSS: Main: 166203392 16:48:57 INFO - PROCESS | 3887 | 16:49:00 INFO - PROCESS | 3887 | Cycle 1(1): loaded http://localhost:43660/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:49:00 INFO - PROCESS | 3887 | RSS: Main: 166342656 16:49:00 INFO - PROCESS | 3887 | 16:49:03 INFO - PROCESS | 3887 | Cycle 1(1): loaded http://localhost:43660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:49:04 INFO - PROCESS | 3887 | RSS: Main: 166367232 16:49:04 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | Cycle 1(1): loaded http://localhost:43660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43660/tests/kraken/driver.html?testName=ai-astar) 16:49:06 INFO - PROCESS | 3887 | RSS: Main: 167763968 16:49:06 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | __start_tp_report 16:49:06 INFO - PROCESS | 3887 | _x_x_mozilla_page_load 16:49:06 INFO - PROCESS | 3887 | _x_x_mozilla_page_load_details 16:49:06 INFO - PROCESS | 3887 | |i|pagename|runs| 16:49:06 INFO - PROCESS | 3887 | |0;ai-astar;110;115;117;118;118;120;118;118;118;118 16:49:06 INFO - PROCESS | 3887 | |1;audio-beat-detection;155;125;127;175;131;133;126;127;146;131 16:49:06 INFO - PROCESS | 3887 | |2;audio-dft;162;167;172;164;162;165;165;166;166;166 16:49:06 INFO - PROCESS | 3887 | |3;audio-fft;76;78;76;104;77;78;78;79;97;77 16:49:06 INFO - PROCESS | 3887 | |4;audio-oscillator;84;85;109;84;84;85;100;86;84;109 16:49:06 INFO - PROCESS | 3887 | |5;imaging-gaussian-blur;117;117;117;117;118;120;118;118;118;117 16:49:06 INFO - PROCESS | 3887 | |6;imaging-darkroom;151;150;150;149;151;150;150;149;150;150 16:49:06 INFO - PROCESS | 3887 | |7;imaging-desaturate;101;102;95;97;96;96;96;96;96;96 16:49:06 INFO - PROCESS | 3887 | |8;json-parse-financial;66;65;66;64;67;68;65;65;66;67 16:49:06 INFO - PROCESS | 3887 | |9;json-stringify-tinderbox;67;67;67;67;67;67;67;67;68;67 16:49:06 INFO - PROCESS | 3887 | |10;stanford-crypto-aes;93;86;95;83;86;84;86;85;84;87 16:49:06 INFO - PROCESS | 3887 | |11;stanford-crypto-ccm;142;145;137;144;139;134;133;136;212;134 16:49:06 INFO - PROCESS | 3887 | |12;stanford-crypto-pbkdf2;185;187;178;181;178;180;179;187;179;178 16:49:06 INFO - PROCESS | 3887 | |13;stanford-crypto-sha256-iterative;73;69;74;68;79;69;67;68;67;67 16:49:06 INFO - PROCESS | 3887 | __end_tp_report 16:49:06 INFO - PROCESS | 3887 | __start_cc_report 16:49:06 INFO - PROCESS | 3887 | _x_x_mozilla_cycle_collect,809 16:49:06 INFO - PROCESS | 3887 | __end_cc_report 16:49:06 INFO - PROCESS | 3887 | __startTimestamp1486082946685__endTimestamp 16:49:06 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | ------- Summary: start ------- 16:49:06 INFO - PROCESS | 3887 | Number of tests: 14 16:49:06 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | [#0] ai-astar Cycles:10 Average:117.00 Median:118.00 stddev:2.75 (2.3%) stddev-sans-first:1.30 16:49:06 INFO - PROCESS | 3887 | Values: 110.0 115.0 117.0 118.0 118.0 120.0 118.0 118.0 118.0 118.0 16:49:06 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:132.00 stddev:16.32 (12.4%) stddev-sans-first:16.05 16:49:06 INFO - PROCESS | 3887 | Values: 155.0 125.0 127.0 175.0 131.0 133.0 126.0 127.0 146.0 131.0 16:49:06 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | [#2] audio-dft Cycles:10 Average:165.50 Median:166.00 stddev:2.84 (1.7%) stddev-sans-first:2.71 16:49:06 INFO - PROCESS | 3887 | Values: 162.0 167.0 172.0 164.0 162.0 165.0 165.0 166.0 166.0 166.0 16:49:06 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | [#3] audio-fft Cycles:10 Average:82.00 Median:78.00 stddev:9.93 (12.7%) stddev-sans-first:10.30 16:49:06 INFO - PROCESS | 3887 | Values: 76.0 78.0 76.0 104.0 77.0 78.0 78.0 79.0 97.0 77.0 16:49:06 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:84.00 stddev:10.66 (12.7%) stddev-sans-first:11.00 16:49:06 INFO - PROCESS | 3887 | Values: 84.0 85.0 109.0 84.0 84.0 85.0 100.0 86.0 84.0 109.0 16:49:06 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 16:49:06 INFO - PROCESS | 3887 | Values: 117.0 117.0 117.0 117.0 118.0 120.0 118.0 118.0 118.0 117.0 16:49:06 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 16:49:06 INFO - PROCESS | 3887 | Values: 151.0 150.0 150.0 149.0 151.0 150.0 150.0 149.0 150.0 150.0 16:49:06 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:96.00 stddev:2.38 (2.5%) stddev-sans-first:2.06 16:49:06 INFO - PROCESS | 3887 | Values: 101.0 102.0 95.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 16:49:06 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 16:49:06 INFO - PROCESS | 3887 | Values: 66.0 65.0 66.0 64.0 67.0 68.0 65.0 65.0 66.0 67.0 16:49:06 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 16:49:06 INFO - PROCESS | 3887 | Values: 67.0 67.0 67.0 67.0 67.0 67.0 67.0 67.0 68.0 67.0 16:49:06 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.00 stddev:3.96 (4.6%) stddev-sans-first:3.53 16:49:06 INFO - PROCESS | 3887 | Values: 93.0 86.0 95.0 83.0 86.0 84.0 86.0 85.0 84.0 87.0 16:49:06 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:140.50 stddev:23.72 (16.9%) stddev-sans-first:25.12 16:49:06 INFO - PROCESS | 3887 | Values: 142.0 145.0 137.0 144.0 139.0 134.0 133.0 136.0 212.0 134.0 16:49:06 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.20 Median:180.50 stddev:3.71 (2.1%) stddev-sans-first:3.67 16:49:06 INFO - PROCESS | 3887 | Values: 185.0 187.0 178.0 181.0 178.0 180.0 179.0 187.0 179.0 178.0 16:49:06 INFO - PROCESS | 3887 | 16:49:06 INFO - PROCESS | 3887 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:69.00 stddev:3.98 (5.8%) stddev-sans-first:4.09 16:49:06 INFO - PROCESS | 3887 | Values: 73.0 69.0 74.0 68.0 79.0 69.0 67.0 68.0 67.0 67.0 16:49:06 INFO - PROCESS | 3887 | -------- Summary: end -------- 16:49:06 INFO - PROCESS | 3887 | 16:49:07 INFO - TEST-INFO | 3887: exit 0 16:49:07 INFO - TEST-OK | kraken | took 64185ms 16:49:07 INFO - SUITE-END | took 1185s 16:49:08 INFO - Completed test suite (00:19:46) 16:49:08 INFO - javascript benchmark 16:49:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6294.375155417989, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2578.6003169508726, 2581.62566427868, 2588.534063868503, 2604.5832666773313, 2622.8164028517986, 4681.063787242557, 4762.761861906908, 4773.498782627822, 4794.6643734938525, 4801.927971080437, 4723.362346083286, 4727.716337019781, 4743.241081426972, 4768.0, 4770.4275486941615, 4326.113146804905, 4347.304431290994, 4390.934135987963, 4395.494518130408, 4447.666425018137, 4364.454443194601, 4455.754933478657, 4456.910861782762, 4457.910841783162, 4458.71018383804, 307.76497458211065, 4340.283853164224, 4341.044970106572, 4456.59890609845, 4457.955420445803, 3925.2738243425056, 4393.450818647669, 4397.31841564558, 4403.889902752425, 4454.420925279725, 4371.540988196257, 4402.80187391565, 4404.537523560044, 4418.977905110454, 4435.3125265583885, 4652.697574657636, 4676.672632915697, 4718.150732868083, 4785.760711964388, 4820.951790482085, 5093.083245015896, 5110.872228194287, 5135.74321283938, 5184.6629969052265, 5185.455527169631, 5156.407013193493, 5165.509276618715, 5165.948340516585, 5177.637565370425, 5225.477452254782, 4666.416697912761, 4725.149473094876, 4830.4203495580405, 4837.758112094381, 4851.51484851512, 5157.32954715892, 5159.690418574897, 5160.845174644766, 5167.328247327823, 5169.689818610896, 4901.705897646153, 4944.134776414113, 4944.159492886218, 4980.2778597103215, 4986.950130498649, 5024.673396229234, 5025.748712564357, 5031.496850314939, 5043.293938848564, 5048.419431765321, 4927.90144197114, 4974.875628109254, 4993.975030124826, 4995.325631039836, 5016.824411145592, 4997.475265097185, 5037.370328708911, 5046.066477701564, 5073.365829271341, 5109.489051094935, 4162.5629308922735, 4273.67947403946, 4283.121959998193, 4290.849820256276, 4328.2425575524785, 3695.1685870678884, 3703.2963736889906, 3765.3410653135593, 3771.2268984858038, 3784.810759462016, 4343.0, 4382.956170438255, 4409.845655402046, 4411.536788637211, 4492.528284530143, 5145.665531740425, 5192.7403629818355, 5195.9088591395475, 5206.453322401093, 5226.686398816083, 4301.720388174758, 4374.431323927869, 4391.121775644884, 4430.202563538594, 4473.664475164375, 4527.750973696412, 4569.497355290915, 4641.976790116096, 4648.7443190624845, 4722.268048452495, 4858.0, 4867.58625516835, 4877.609791216765, 4890.217565189552, 4918.655694101379, 5209.426963033988, 5210.895782084262, 5223.738813059408, 5229.320188375486, 5284.603654725988, 4665.720056796467, 4675.719456832601, 4713.057388522241, 4721.102990431807, 4729.314249433882, 4974.204127339608, 4982.950170498394, 4991.301217829434, 5000.374953130859, 5019.0463811875625, 5042.621803364836, 5044.167712327425, 5044.369453818273, 5047.4952504749235, 5096.133657278346, 4864.440589332272, 4909.4354149273295, 4925.926111108264, 4941.481144479778, 4977.129002424489, 4967.329410529533, 5002.049610573979, 5007.84976450707, 5022.673526220784, 5044.571211446922, 4867.63492738039, 4935.383077115361, 4941.678790878582, 4948.430930443045, 4962.057209130254, 4945.23348880924, 4951.183054795918, 5062.898742025212, 5068.366454193226, 5116.667416617908, 4968.056069346812, 5002.174641184164, 5005.749712514433, 5020.146575082172, 5032.547070763649], "value": 4647.815235666436, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.5600511562614, 523.3249108649842, 531.7235037780355, 540.789092254021, 548.6378989866689, 38665.80667096664, 40966.0, 41012.0, 41189.17621647573, 45091.0, 41816.58183418165, 42230.366544501856, 42291.577084229146, 42346.364804527955, 42402.36396454056, 7713.460057795956, 7889.842203155933, 7890.329322007637, 7895.8420831583335, 9664.468454235015, 9527.285453590974, 9861.556229969632, 9862.802743945116, 9872.407655540655, 9914.0, 9908.810942686887, 9915.603375864994, 9973.750656233617, 9976.700698979006, 9984.700458986243, 9792.706218813411, 9884.80230395388, 9891.208703303719, 9894.80210395788, 9897.703068907944, 9731.12419882214, 9861.359011664219, 9889.258305627034, 9911.90088099117, 9944.552495137665, 34007.65992340069, 34094.82952585221, 34285.65714342875, 34305.313893721985, 34318.485222721676, 3476.148343655795, 3516.894493165209, 3541.1324225564645, 3556.893293201208, 3605.170810713524, 25805.870970645028, 25865.224043278733, 25914.352141196432, 26081.60877586838, 26848.59727104095, 2953.246922034889, 2953.320736230679, 2961.748251398634, 2965.6737758846725, 3014.5478178273215, 228350.0, 228861.8556907205, 229337.0, 229532.0, 229885.99999999834, 44964.55035449604, 45339.0, 45582.31626525605, 45672.54327456683, 45708.542914571095, 48346.27480587794, 48454.0, 48517.5148248513, 48520.0, 48568.5143148564, 13499.325033748273, 13908.304584770722, 13936.303184840717, 13942.37259323333, 13970.511032113827, 9808.313418060667, 10106.0, 10357.792844143074, 10780.730481738019, 11094.22340436178, 16380.754288685679, 16467.0, 16500.917495412446, 16511.504654860135, 16532.256048477848, 6715.496337774686, 6780.627065511444, 6804.455643548505, 6903.206131294965, 6923.826904327331, 785.9567723775133, 802.5104686141449, 819.2258315891545, 830.9709160179365, 838.7944953486435, 24444.633330500055, 25932.8703356482, 26471.0, 26503.0, 28652.283692907844, 851.3614788908319, 854.2866706300309, 876.1294635952161, 880.854658981261, 993.7267251505749, 12545.686357840945, 13142.211467311992, 13185.142965707199, 13328.800067998987, 13385.866141338656, 349359.0, 349813.0, 352006.0, 352049.0, 352309.0, 41063.1787364257, 41372.0, 41569.0, 41599.37600935988, 41827.58172418237, 1242.310517662706, 1252.092233130991, 1262.501311981762, 1270.4918032786775, 1280.3790161771533, 23264.76735232626, 23417.180398685963, 24269.757302427457, 24538.754612453646, 24743.62884556769, 36066.4590031155, 36380.0, 36704.0, 36770.26459470742, 36795.26409471742, 246332.0, 246606.0, 247114.0, 247191.0, 247814.0, 22605.43486412853, 23233.88383058074, 23697.644535331638, 23948.880255599306, 25074.37314067163, 33877.153071173416, 34213.0, 35991.64008359988, 36221.63778362182, 36695.449568255965, 30572.08283751491, 30959.69040309568, 31107.0, 31325.373492530478, 31577.684223157474, 30192.698073019867, 30279.848600757738, 30380.5442918352, 31421.214469638442, 31432.0, 29899.850500747358, 29903.252418689706, 30159.69840301569, 31832.204194895312, 32605.836970814995, 27051.1884643461, 27759.722402775715, 29471.26321841971, 29831.254218644706, 29842.55236171416, 22615.321540353816, 23494.53010939806, 23583.64624530599, 23625.52748945046, 23729.0], "value": 16653.176008423095, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.82248520710044, 375.768902125193, 384.74222271078366, 385.7087898636529, 400.1337105167313, 16720.2475888585, 17403.60346852589, 17531.47405577833, 17632.911835440806, 17664.293428262856, 10975.121990240781, 11052.336859788418, 11055.0603198728, 11056.502457389437, 11129.833052504218, 4760.547747963947, 4772.642051846108, 4822.87942801431, 4879.878003049935, 4880.829170978998, 4799.13615549201, 4877.9268310975185, 5232.633715639907, 5498.065328894098, 5524.4199359067325, 5570.6657600543895, 5573.777048918038, 5574.331080270353, 5575.0, 5576.386597474295, 5542.5565954723725, 5615.943840561583, 6043.637381757087, 6079.331273559905, 6097.969510152465, 5390.946090539083, 5390.946090539122, 5394.352677678665, 5397.217403476474, 5412.539934105605, 12252.938735306267, 18144.637107257913, 18321.26714931401, 21434.57130857374, 21620.243291484723, 2131.7548481924623, 2152.9892350538303, 2226.499037716501, 2242.2264318809985, 2242.8766417847014, 8432.957835210786, 8921.330900182447, 9154.450732956044, 9302.20931220847, 9496.430214187101, 1717.9828201718074, 1770.2211027148014, 1781.5189898727272, 1790.588164722108, 1801.7567628370264, 70756.64621676858, 71952.2804771956, 77088.22911770923, 78504.60747696225, 79985.0, 10360.756709194795, 10408.791824163474, 10542.314749541256, 10744.409057501756, 10867.29362591429, 14850.777238341434, 14872.182029988238, 14927.25363731809, 14983.625409364635, 15018.849811501963, 7219.133703955559, 7471.887921681179, 7491.775246742606, 7723.227677232232, 7725.150233474314, 7063.470239731938, 7065.116860392451, 7227.710891564384, 7274.599897005715, 7278.745243916437, 4373.606375426227, 4411.977940110279, 4422.115576884572, 4455.576720211575, 4485.798139083749, 1523.451557439321, 1574.1735588815734, 1777.70667839805, 1883.8681292309682, 1937.3897222374908, 929.3448119076036, 960.4237457525569, 972.3242346569208, 1004.7287232447344, 1011.4588695048114, 16972.74540881888, 17402.21690023952, 17571.648567028587, 17823.0, 17845.0, 967.2165545907837, 968.1867231525412, 974.7855471796194, 982.5824024789435, 991.0485933503772, 9544.475053872104, 9653.420794752337, 9717.902820971842, 9832.410055396698, 9841.803163936682, 500450.0, 500456.0, 504569.0, 527293.0, 528499.0, 89365.55317223372, 89921.0, 90351.54824225837, 91784.0, 92043.53978230066, 903.3270213690711, 906.5376657904516, 927.8561822917459, 929.2426672262085, 933.9346245762731, 14671.26643667791, 14952.401903923721, 14958.0, 16554.503364899072, 17058.402955896483, 39247.60752392554, 40366.39450408187, 41375.37936930888, 41970.160596788504, 43480.34779478247, 52173.0, 52194.47805522048, 52712.73643631911, 53214.201786974, 55369.0, 7351.228121047427, 7500.0, 7528.0, 7700.3454706350585, 7855.5286682799215, 9030.548472576213, 11823.645290641294, 12457.813132802834, 12568.183068100545, 12849.486020559072, 9640.807183856425, 10534.262601617813, 10787.892121078688, 11113.666590002313, 11340.319580825177, 10015.349002314826, 10249.538770755185, 10358.015988481384, 10696.465176741287, 10866.836997445203, 10896.782064358827, 10935.28920620189, 10983.286086404358, 11239.0, 11317.0, 6760.86478270422, 6839.418649414656, 7138.964305178441, 7213.71145154188, 7306.853862922818, 8995.415298005608, 9949.502524873582, 9968.0, 10152.898471015194, 10299.330543514647], "value": 8406.10982174343, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1090.2695194219873, 1111.827666711659, 1112.6050252160485, 1128.3286444565485, 1160.054555537237, 6497.545171837974, 6722.731090756364, 6906.965465172673, 7444.069491313586, 7446.441516886228, 6996.0, 7237.384822290099, 7243.492955493118, 7425.665845036973, 7479.925200747991, 2105.105330234652, 2147.4631342164457, 2151.2148065955894, 2151.247063527768, 2152.881591512466, 2116.7036614873855, 2127.2129312154525, 2171.913123475067, 2173.836962227839, 2190.3319487556287, 2023.8380929525604, 2042.3974927396453, 2044.2436298569476, 2045.1614837916457, 2047.1299697628522, 2031.7155598216261, 2035.867668601551, 2047.836173106148, 2068.5449201175793, 2076.9376918692387, 1974.5261137327082, 1996.5308152584132, 2022.6258142243732, 2022.9696554551547, 2086.9478263043393, 7476.0, 7505.399568034599, 7526.8118297042465, 7529.7364592239555, 7530.209328020534, 4340.826366945318, 4441.133978874121, 4444.6666500012625, 4444.911101777946, 4468.352088947117, 2664.7468490493566, 2774.153883065664, 2823.8023338366324, 2826.307554649124, 2827.067067867599, 1050.3592808386877, 1054.2620165883911, 1090.6946055104584, 1091.476091476096, 1105.077260487494, 9553.952230238805, 9563.90436095637, 9622.566984485715, 9641.855372169422, 9658.75853103678, 3665.9083522911606, 3829.1384438501673, 3842.212346468967, 3847.2690188864026, 3893.9610603894166, 7893.329067029367, 7893.565853877977, 7894.802629934297, 7896.881546776803, 7906.327962123169, 4401.867943961686, 4402.779861006937, 4405.889852753707, 4408.096340250241, 4408.735475871458, 3943.408488726714, 4026.91946161081, 4160.791960401968, 4166.145940082276, 4182.121754431542, 3120.5943227380294, 3139.5447660089158, 3192.4995252231415, 3208.197950512372, 3211.4861622140347, 848.4061157189992, 880.5949263338807, 894.1014280647908, 915.4919019943995, 946.4652471353801, 684.1482354468718, 701.5404909784099, 783.2793829676712, 814.242754238552, 834.0908409833311, 4838.790302424394, 4907.092187945242, 4914.975425122923, 4943.950560494421, 4986.90026199474, 871.2550769092461, 879.1252703559871, 890.6882591093195, 912.0788004115891, 915.4208989493071, 3181.7772755907326, 3229.564008858774, 3234.75739319552, 3249.6425393206728, 3304.7521435892404, 8569.614367353359, 8880.1563851434, 9015.0, 9024.8646270306, 9030.774230644154, 8936.374453788303, 8943.686970955985, 8944.37389382737, 8948.910510894937, 8952.8657070144, 7006.50954433195, 7107.36033756954, 7110.893336599956, 7115.466340024519, 7139.89290160648, 4758.952410475851, 4832.251001094836, 4938.950610493849, 4986.975065124796, 5082.263071854634, 7756.650950707119, 8051.114377418362, 8070.43506954531, 8147.144549822184, 8224.671013159406, 8045.839083218186, 8163.918360816316, 8201.30288925448, 8212.712555060783, 8224.136465671258, 6368.4586810121655, 6454.548181627429, 6494.383033611799, 6498.3826536478955, 6526.934730652632, 6753.527253092433, 6939.89590156138, 6973.267806880204, 7001.334873187243, 7095.219525852049, 5597.384287728428, 6069.635821850703, 6136.7852125175405, 6220.377962203925, 6293.087502312231, 6295.087212354275, 6434.871302573829, 6436.967815160894, 6440.0983862260255, 6447.774327898501, 5641.266635337544, 5657.43425657431, 5673.914891276717, 5677.8864422710485, 5694.772209111589, 4291.163223171577, 4310.741355518679, 4312.116016216605, 4357.67317451186, 4436.157130145262, 4128.731632443882, 4289.420928174656, 4315.244832154423, 4346.956530434655, 4427.911441771211], "value": 3852.746298255595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.06820441439646, 337.38764143080306, 348.0671799577132, 348.16614208969503, 350.74570936071353, 4789.467370441452, 4903.779329930153, 4983.252512123183, 5021.372328458938, 5032.974835125829, 4814.975925120379, 4909.779059942302, 4924.414682291798, 4933.481984391641, 4938.012397520492, 3962.841486340543, 3971.98014009931, 3973.040085136577, 3976.224636195943, 4007.939880901789, 3881.340172170738, 3991.900202494932, 3993.400989851531, 3995.6204160604843, 3997.8001099944886, 3924.9795053286066, 3941.9014524636827, 3954.567940716453, 3955.4857868477056, 3956.6834653227816, 3944.5660977292473, 3947.519680119955, 3953.9802300988313, 3958.7426817256787, 3975.7614543127506, 3563.127033876691, 3566.6076731559506, 3570.6786389225094, 3572.982135089308, 3588.9592018314656, 4598.149342371672, 4767.69010014348, 4791.9520804791855, 4829.372181616367, 4845.442774080955, 4541.43232095988, 4542.727436353829, 4543.591896294969, 4545.386372839657, 4553.54464553542, 5239.580833533309, 5240.371155461331, 5246.921296180561, 5247.239150323182, 5258.158694608883, 3466.116140384211, 3653.7077033837495, 3918.1380096378753, 3929.607039296076, 3937.803109844525, 5334.706591137486, 5379.354477462691, 5401.4868587484125, 5422.701751403672, 5432.587527242906, 3679.411294192916, 3687.391580389259, 3688.151725103188, 3695.0762309422644, 3697.7411581189594, 3726.807421625054, 3728.5525736911745, 3735.6824669902817, 3743.7005039596766, 3752.099496120911, 4207.326827707552, 4275.674540892333, 4279.170142722309, 4280.143971205771, 4288.24955632763, 5082.593392528589, 5137.922931155961, 5147.819826306061, 5155.97422012895, 5183.222516622462, 1250.7060840702427, 1265.1839563481687, 1275.948962041508, 1282.2114399644151, 1283.544341758681, 843.8987121806102, 858.8969323681198, 871.7210492642421, 878.8945326560854, 880.8986966498807, 4358.3244597087505, 4390.363397307373, 4391.670624703096, 4403.2734598791485, 4406.339049142654, 5106.238347770013, 5155.432902380735, 5184.766685499161, 5186.948130518722, 5222.869428264324, 4371.7103454481, 4437.29003359461, 4441.555844415597, 4445.955540444619, 4464.330350447459, 2562.820602557803, 2717.96152885336, 2731.0, 2744.533429317021, 2768.224897028835, 4775.5463230993, 4820.396985627722, 4827.686200396963, 4862.610991120702, 4882.8779280517565, 5023.522765337287, 5248.9737551312, 5280.973595132076, 5289.550388216968, 5320.255164277004, 4788.976055119702, 4821.46963833985, 4829.213191119238, 4843.685160464559, 4874.2444921037295, 5130.537342075899, 5144.639875208849, 5176.327077479904, 5182.66312689689, 5194.6234947284565, 4963.228887107467, 5014.36745708506, 5106.872328191676, 5107.361579802525, 5122.820701275437, 4794.856154315376, 4796.640251981185, 4826.613870890391, 4830.516948305141, 4838.346823178967, 3669.1930673034617, 3671.1372827386076, 3698.4452332150395, 3702.685821361649, 3712.5730540988134, 5014.949850501448, 5219.2953951216095, 5229.084910140787, 5230.443298557017, 5249.632525723163, 4913.631477639263, 4936.802527898843, 4962.875928101682, 4986.78088250725, 5017.37282839645, 4991.101601711582, 5031.320771695774, 5035.597152227886, 5063.189889617791, 5091.159958606937, 4674.966389620526, 4898.24077268024, 4945.975270123627, 4948.604111671129, 4958.181899986462, 4994.877177199748, 4996.800127994839, 5003.77483013258, 5009.924851127309, 5013.874653133701, 4924.458309585871, 4928.673145626759, 4932.358793356841, 4971.950280497149, 4975.616580725142], "value": 3865.821464695728, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.337365947223, 682.2699711308899, 724.6376811594203, 746.1568427676724, 747.9775606731798, 12856.485740570377, 13253.204807711543, 13340.39968201431, 13362.933185334059, 13409.865901340983, 13206.867931320683, 13417.262050587215, 13427.0, 13441.596752097428, 13484.393202305895, 652.3834975947708, 670.993290067098, 775.9689612415497, 790.8971833661616, 815.5392203405087, 790.0322105420871, 790.3835008693228, 790.746960972489, 791.4103992525577, 792.742358733414, 863.240348493325, 863.8920134983127, 863.896332440108, 868.5570359116864, 868.6916144768611, 860.2257967828941, 860.5224100624151, 867.6095756909353, 868.8392647360258, 868.9832895512266, 626.1171747835575, 627.1251604012377, 629.5876201088295, 630.7256343490596, 631.6052467207995, 13348.399322030435, 13426.664333391645, 13814.309284535833, 13927.442902283896, 13930.233837138954, 13134.73730525384, 13580.357587529299, 13651.795223071662, 13654.180749155083, 14087.0, 10570.947145264301, 10828.675139745741, 10851.77538604592, 10869.83695244572, 10965.451727413598, 3294.1929227339215, 3323.268880846234, 3353.446681297583, 3476.200473890994, 3480.8781692640637, 58039.70980145072, 60724.39275607232, 62034.68982655103, 63172.68413657948, 63394.68302658457, 10407.53166107527, 10445.68662940113, 10478.0, 10798.190135739695, 10834.620788272372, 20519.589608207752, 20663.58672826535, 20692.793072069086, 20892.0, 21042.47393815136, 6310.242770867525, 6323.620582765049, 6547.410733034049, 6595.373439523238, 6627.5029372797235, 3497.370473314777, 3546.8049257291095, 3576.1417259857967, 3577.3203091412547, 3645.0340659725193, 2642.5771876499666, 2670.9599356009285, 2691.515527205083, 2705.959410608803, 2711.864406779653, 473.8483685220765, 478.2085648252148, 478.69794159885055, 490.9091818013679, 495.982640607577, 551.9392866784731, 576.8298351986174, 586.1266712598198, 587.632729544035, 608.0909040983757, 8215.424920255644, 8261.339092872557, 8415.747527574182, 8755.781105472413, 8812.427192232613, 521.8747500599904, 544.4392275955772, 548.3173449055871, 576.8961586914396, 605.9363766804511, 4095.7542547447247, 4102.517976624099, 4105.692073094529, 4121.690873184523, 4247.299195632748, 68617.3138268611, 68651.65674171697, 69034.65482672655, 71348.64325678338, 71711.28288717046, 58490.0, 58673.70663146657, 58742.0, 58829.0, 61743.6912815433, 53282.46717532775, 53702.7314863431, 54046.0, 54563.45436545584, 54714.0, 7830.2952734254195, 8088.919110808816, 8250.298724608476, 8279.461834980708, 8313.916860831314, 36673.26653466969, 37286.813565931996, 37810.243795124494, 39054.6094539051, 39077.609223908534, 44743.55256447394, 46306.76846615745, 49078.619779428445, 50326.7483662594, 50897.491025090756, 11429.714257143638, 12223.44994475233, 12356.25862448256, 13049.739005220032, 13064.085514013928, 13143.408546615616, 13177.604671859859, 13335.733285334045, 13639.659008524866, 13766.724665506434, 11369.54521819118, 11497.367644779617, 11823.349715765715, 11886.34625095628, 12239.449224784728, 12579.874201258237, 12697.541976890774, 12827.807582886451, 13090.672733181747, 13127.844765631284, 11689.649310520697, 12033.0, 12076.335801531, 12560.183588067111, 12637.368131593568, 9583.329166958247, 9796.07205850301, 10059.39643621385, 10309.329893556895, 10326.0, 9095.818083638158, 10150.593976240867, 10285.640002599874, 10296.948515257376, 10324.845127323246], "value": 6416.713079591774, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1574.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 117.0, 118.0, 118.0, 120.0, 118.0, 118.0, 118.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 127.0, 175.0, 131.0, 133.0, 126.0, 127.0, 146.0, 131.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 172.0, 164.0, 162.0, 165.0, 165.0, 166.0, 166.0, 166.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 104.0, 77.0, 78.0, 78.0, 79.0, 97.0, 77.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 109.0, 84.0, 84.0, 85.0, 100.0, 86.0, 84.0, 109.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 120.0, 118.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 149.0, 151.0, 150.0, 150.0, 149.0, 150.0, 150.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 102.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 64.0, 67.0, 68.0, 65.0, 65.0, 66.0, 67.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 86.0, 95.0, 83.0, 86.0, 84.0, 86.0, 85.0, 84.0, 87.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 145.0, 137.0, 144.0, 139.0, 134.0, 133.0, 136.0, 212.0, 134.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 178.0, 181.0, 178.0, 180.0, 179.0, 187.0, 179.0, 178.0], "value": 181.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 69.0, 74.0, 68.0, 79.0, 69.0, 67.0, 68.0, 67.0, 67.0], "value": 70.1, "unit": "score"}]}]} 16:49:08 INFO - Return code: 0 16:49:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:49:08 ERROR - # TBPL SUCCESS # 16:49:08 INFO - Running post-action listener: _resource_record_post_action 16:49:08 INFO - [mozharness: 2017-02-03 00:49:08.493619Z] Finished run-tests step (success) 16:49:08 INFO - Running post-run listener: _resource_record_post_run 16:49:08 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8695808; Write bytes: 421888000; Read time: 2672; Write time: 345496 16:49:08 INFO - TinderboxPrint: CPU usage
13.5% 16:49:08 INFO - TinderboxPrint: I/O read bytes / time
8,695,808 / 2,672 16:49:08 INFO - TinderboxPrint: I/O write bytes / time
421,888,000 / 345,496 16:49:08 INFO - TinderboxPrint: CPU idle
8,304.3 (86.5%) 16:49:08 INFO - TinderboxPrint: CPU user
1,234.2 (12.9%) 16:49:08 INFO - TinderboxPrint: Swap in / out
0 / 0 16:49:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 4624384; Read time: 0; Write time: 484 16:49:08 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 6660096; Write bytes: 374779904; Read time: 2424; Write time: 331212 16:49:09 INFO - Running post-run listener: _upload_blobber_files 16:49:09 INFO - Blob upload gear active. 16:49:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:49:09 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 16:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:49:09 INFO - (blobuploader) - INFO - Open directory for files ... 16:49:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:49:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:49:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:10 INFO - (blobuploader) - INFO - Done attempting. 16:49:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:49:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:49:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:13 INFO - (blobuploader) - INFO - Done attempting. 16:49:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:49:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:49:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:14 INFO - (blobuploader) - INFO - Done attempting. 16:49:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:49:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:49:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:15 INFO - (blobuploader) - INFO - Done attempting. 16:49:15 INFO - (blobuploader) - INFO - Iteration through files over. 16:49:15 INFO - Return code: 0 16:49:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:49:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:49:15 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e4d3bed7c01cacc03e7e53f248acca30c112ef7780de6cd022a8ed6d32b94077bbdc6674fa5450a83ce34683b2792e57be3ffa198dae4b2a6dd654c9251756b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/714a938b7d77cf3f5227093b7d996e522ed722658bc5f5581f28d5a26e766de35d7a3676733d21646d6c23e347e15e0363f7d5c2515956e291d343d65952b65e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b754e49a6b5df321ac84b3e6db54ecdc4f86a5e29365ece45a650f3297f2c314d6c9b8d90afd644ab0173444f07af5f2a6f1f04440ede5327c10cc12571c434d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a18e4dba6220a7fb3bbbcbe64760c0c79c2f58acdb6946b4c8e47855d6e660fbfc0187c716690f9850e787b3c677ae5794c17d442e940b870fb656b905ef9e58"} 16:49:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:49:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:49:15 INFO - Contents: 16:49:15 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e4d3bed7c01cacc03e7e53f248acca30c112ef7780de6cd022a8ed6d32b94077bbdc6674fa5450a83ce34683b2792e57be3ffa198dae4b2a6dd654c9251756b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/714a938b7d77cf3f5227093b7d996e522ed722658bc5f5581f28d5a26e766de35d7a3676733d21646d6c23e347e15e0363f7d5c2515956e291d343d65952b65e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b754e49a6b5df321ac84b3e6db54ecdc4f86a5e29365ece45a650f3297f2c314d6c9b8d90afd644ab0173444f07af5f2a6f1f04440ede5327c10cc12571c434d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a18e4dba6220a7fb3bbbcbe64760c0c79c2f58acdb6946b4c8e47855d6e660fbfc0187c716690f9850e787b3c677ae5794c17d442e940b870fb656b905ef9e58"} 16:49:15 INFO - Running post-run listener: copy_logs_to_upload_dir 16:49:15 INFO - Copying logs to upload dir... 16:49:15 INFO - mkdir: /builds/slave/test/build/upload/logs 16:49:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.821306 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-02-02 16:49:15.807620) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 16:49:15.810951) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e4d3bed7c01cacc03e7e53f248acca30c112ef7780de6cd022a8ed6d32b94077bbdc6674fa5450a83ce34683b2792e57be3ffa198dae4b2a6dd654c9251756b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/714a938b7d77cf3f5227093b7d996e522ed722658bc5f5581f28d5a26e766de35d7a3676733d21646d6c23e347e15e0363f7d5c2515956e291d343d65952b65e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b754e49a6b5df321ac84b3e6db54ecdc4f86a5e29365ece45a650f3297f2c314d6c9b8d90afd644ab0173444f07af5f2a6f1f04440ede5327c10cc12571c434d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a18e4dba6220a7fb3bbbcbe64760c0c79c2f58acdb6946b4c8e47855d6e660fbfc0187c716690f9850e787b3c677ae5794c17d442e940b870fb656b905ef9e58"} build_url:https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/bO8mJI50R5G6lSjJATtzsA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e4d3bed7c01cacc03e7e53f248acca30c112ef7780de6cd022a8ed6d32b94077bbdc6674fa5450a83ce34683b2792e57be3ffa198dae4b2a6dd654c9251756b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/714a938b7d77cf3f5227093b7d996e522ed722658bc5f5581f28d5a26e766de35d7a3676733d21646d6c23e347e15e0363f7d5c2515956e291d343d65952b65e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b754e49a6b5df321ac84b3e6db54ecdc4f86a5e29365ece45a650f3297f2c314d6c9b8d90afd644ab0173444f07af5f2a6f1f04440ede5327c10cc12571c434d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a18e4dba6220a7fb3bbbcbe64760c0c79c2f58acdb6946b4c8e47855d6e660fbfc0187c716690f9850e787b3c677ae5794c17d442e940b870fb656b905ef9e58"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 16:49:15.835044) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 16:49:15.835347) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1486081695.930039-1637716002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 16:49:15.920121) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 16:49:15.920412) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 16:49:15.920683) ========= ========= Total master_lag: 0.17 =========