builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1483746281.73 results: success (0) revision: da4d2276cd297b3f74e59c5aa4a9ec81c0020d1e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 15:44:41.731000) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-06 15:44:41.731487) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 15:44:41.731801) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-06 15:44:41.746444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:44:41.746751) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-06 15:44:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2017-01-06 15:44:42 (43.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131939 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:44:41.895720) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:44:41.896128) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016922 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:44:41.947116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:44:41.950189) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev da4d2276cd297b3f74e59c5aa4a9ec81c0020d1e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/graphics --rev da4d2276cd297b3f74e59c5aa4a9ec81c0020d1e --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=78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-06 15:44:42,247 truncating revision to first 12 chars 2017-01-06 15:44:42,247 Setting DEBUG logging. 2017-01-06 15:44:42,247 attempt 1/10 2017-01-06 15:44:42,247 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/da4d2276cd29?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-06 15:44:42,570 unpacking tar archive at: graphics-da4d2276cd29/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638033 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 15:44:42.602737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 15:44:42.603124) ========= script_repo_revision: da4d2276cd297b3f74e59c5aa4a9ec81c0020d1e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-06 15:44:42.603636) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 15:44:42.603989) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-06 15:44:42.614957) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-01-06 15:44:42.615330) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:44:43 INFO - MultiFileLogger online at 20170106 15:44:43 in /builds/slave/test 15:44:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 15:44:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:44:43 INFO - {'append_to_log': False, 15:44:43 INFO - 'base_work_dir': '/builds/slave/test', 15:44:43 INFO - 'blob_upload_branch': 'Graphics', 15:44:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:44:43 INFO - 'branch': 'Graphics', 15:44:43 INFO - 'buildbot_json_path': 'buildprops.json', 15:44:43 INFO - 'config_files': ('talos/linux_config.py',), 15:44:43 INFO - 'default_actions': ('clobber', 15:44:43 INFO - 'read-buildbot-config', 15:44:43 INFO - 'download-and-extract', 15:44:43 INFO - 'populate-webroot', 15:44:43 INFO - 'create-virtualenv', 15:44:43 INFO - 'install', 15:44:43 INFO - 'run-tests'), 15:44:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:44:43 INFO - 'download_minidump_stackwalk': True, 15:44:43 INFO - 'download_symbols': 'ondemand', 15:44:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:44:43 INFO - 'tooltool.py': '/tools/tooltool.py', 15:44:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:44:43 INFO - '/tools/misc-python/virtualenv.py')}, 15:44:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:44:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:44:43 INFO - 'installer_path': 'installer.exe', 15:44:43 INFO - 'log_level': 'info', 15:44:43 INFO - 'log_name': 'talos', 15:44:43 INFO - 'log_to_console': True, 15:44:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:44:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:44:43 INFO - 'opt_config_files': (), 15:44:43 INFO - 'pip_index': False, 15:44:43 INFO - 'sps_profile': False, 15:44:43 INFO - 'sps_profile_interval': 0, 15:44:43 INFO - 'suite': 'dromaeojs-e10s', 15:44:43 INFO - 'system_bits': '32', 15:44:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:44:43 INFO - 'title': 'talos-linux64-ix-019', 15:44:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:44:43 INFO - 'use_talos_json': True, 15:44:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:44:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:44:43 INFO - 'work_dir': 'build'} 15:44:43 INFO - [mozharness: 2017-01-06 23:44:43.009125Z] Running clobber step. 15:44:43 INFO - Running pre-action listener: _resource_record_pre_action 15:44:43 INFO - Running main action method: clobber 15:44:43 INFO - rmtree: /builds/slave/test/build 15:44:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:44:43 INFO - Running post-action listener: _resource_record_post_action 15:44:43 INFO - [mozharness: 2017-01-06 23:44:43.476064Z] Finished clobber step (success) 15:44:43 INFO - [mozharness: 2017-01-06 23:44:43.476166Z] Running read-buildbot-config step. 15:44:43 INFO - Running pre-action listener: _resource_record_pre_action 15:44:43 INFO - Running main action method: read_buildbot_config 15:44:43 INFO - Using buildbot properties: 15:44:43 INFO - { 15:44:43 INFO - "project": "", 15:44:43 INFO - "product": "firefox", 15:44:43 INFO - "who": "kgupta@mozilla.com", 15:44:43 INFO - "installer_path": "public/build/target.tar.bz2", 15:44:43 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 15:44:43 INFO - "repository": "https://hg.mozilla.org/projects/graphics/", 15:44:43 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 15:44:43 INFO - "stage_platform": "linux64", 15:44:43 INFO - "basedir": "/builds/slave/test", 15:44:43 INFO - "buildnumber": 46, 15:44:43 INFO - "platform": "ubuntu64_hw", 15:44:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:44:43 INFO - "slavebuilddir": "test", 15:44:43 INFO - "taskId": "AmVkd0ReTuSzZdO76PYrKg", 15:44:43 INFO - "branch": "graphics", 15:44:43 INFO - "script_repo_revision": "default", 15:44:43 INFO - "revision": "da4d2276cd297b3f74e59c5aa4a9ec81c0020d1e", 15:44:43 INFO - "slavename": "talos-linux64-ix-019", 15:44:43 INFO - "repo_path": "projects/graphics" 15:44:43 INFO - } 15:44:43 INFO - Finding installer, test and symbols from parent task. 15:44:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AmVkd0ReTuSzZdO76PYrKg'}, attempt #1 15:44:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AmVkd0ReTuSzZdO76PYrKg'}, attempt #1 15:44:44 INFO - Task dependencies: aVOp32d_TR6wBhPhsR1clA 15:44:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA'}, attempt #1 15:44:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.tar.bz2 15:44:44 INFO - Set test_url: https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/test_packages.json 15:44:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.crashreporter-symbols.zip 15:44:44 INFO - Running post-action listener: _resource_record_post_action 15:44:44 INFO - [mozharness: 2017-01-06 23:44:44.911733Z] Finished read-buildbot-config step (success) 15:44:44 INFO - [mozharness: 2017-01-06 23:44:44.911950Z] Running download-and-extract step. 15:44:44 INFO - Running pre-action listener: _resource_record_pre_action 15:44:44 INFO - Running main action method: download_and_extract 15:44:44 INFO - mkdir: /builds/slave/test/build/tests 15:44:44 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')]} 15:44:44 INFO - trying https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.test_packages.json 15:44:44 INFO - Downloading https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:44:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:44:45 INFO - Downloaded 896 bytes. 15:44:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:44:45 INFO - Using the following test package requirements: 15:44:45 INFO - {u'common': [u'target.common.tests.zip'], 15:44:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:44:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:44:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:44:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:44:45 INFO - u'mozbase': [u'target.common.tests.zip'], 15:44:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:44:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:44:45 INFO - u'web-platform': [u'target.common.tests.zip', 15:44:45 INFO - u'target.web-platform.tests.zip'], 15:44:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:44:45 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:44:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.common.tests.zip 15:44:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:44:45 INFO - Fetch https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.common.tests.zip into memory 15:44:46 INFO - Expected file size: 20246889 15:44:46 INFO - Obtained file size: 20246889 15:44:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:44:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.common.tests.zip 15:44:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:44:50 INFO - Fetch https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.common.tests.zip into memory 15:44:51 INFO - Expected file size: 20246889 15:44:51 INFO - Obtained file size: 20246889 15:44:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.talos.tests.zip 15:44:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:44:55 INFO - Fetch https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.talos.tests.zip into memory 15:44:56 INFO - Expected file size: 14403730 15:44:56 INFO - Obtained file size: 14403730 15:44:56 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')]} 15:44:56 INFO - trying https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.tar.bz2 15:44:56 INFO - Downloading https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:44:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:44:57 INFO - Downloaded 55957477 bytes. 15:44:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.tar.bz2 15:44:57 INFO - mkdir: /builds/slave/test/properties 15:44:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:44:57 INFO - Writing to file /builds/slave/test/properties/build_url 15:44:57 INFO - Contents: 15:44:57 INFO - build_url:https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.tar.bz2 15:44:57 INFO - Running post-action listener: _resource_record_post_action 15:44:57 INFO - Running post-action listener: set_extra_try_arguments 15:44:57 INFO - [mozharness: 2017-01-06 23:44:57.562516Z] Finished download-and-extract step (success) 15:44:57 INFO - [mozharness: 2017-01-06 23:44:57.562613Z] Running populate-webroot step. 15:44:57 INFO - Running pre-action listener: _resource_record_pre_action 15:44:57 INFO - Running main action method: populate_webroot 15:44:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:44:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:44:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:44:57 INFO - '--tppagecycles', 15:44:57 INFO - '7'], 15:44:57 INFO - 'tests': ['tsvgm']}}, 15:44:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:44:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:44:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:44:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:44:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:44:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:44:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:44:57 INFO - 'talos_options': ['--disable-e10s'], 15:44:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:44:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:44:57 INFO - 'talos_options': ['--disable-e10s'], 15:44:57 INFO - 'tests': ['damp', 'tps']}, 15:44:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:44:57 INFO - 'tests': ['damp', 'tps']}, 15:44:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:44:57 INFO - 'tests': ['dromaeo_dom']}, 15:44:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:44:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:44:57 INFO - 'tests': ['basic_compositor_video']}, 15:44:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:44:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:44:57 INFO - 'tests': ['a11yr', 15:44:57 INFO - 'ts_paint', 15:44:57 INFO - 'tpaint', 15:44:57 INFO - 'sessionrestore', 15:44:57 INFO - 'sessionrestore_no_auto_restore', 15:44:57 INFO - 'tabpaint']}, 15:44:57 INFO - 'other-e10s': {'tests': ['a11yr', 15:44:57 INFO - 'ts_paint', 15:44:57 INFO - 'tpaint', 15:44:57 INFO - 'sessionrestore', 15:44:57 INFO - 'sessionrestore_no_auto_restore', 15:44:57 INFO - 'tabpaint']}, 15:44:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:44:57 INFO - 'ts_paint', 15:44:57 INFO - 'tpaint', 15:44:57 INFO - 'sessionrestore', 15:44:57 INFO - 'sessionrestore_no_auto_restore', 15:44:57 INFO - 'tabpaint']}, 15:44:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:44:57 INFO - 'ts_paint', 15:44:57 INFO - 'tpaint', 15:44:57 INFO - 'sessionrestore', 15:44:57 INFO - 'sessionrestore_no_auto_restore', 15:44:57 INFO - 'tabpaint']}, 15:44:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:44:57 INFO - 'tests': ['a11yr', 15:44:57 INFO - 'ts_paint', 15:44:57 INFO - 'tpaint', 15:44:57 INFO - 'sessionrestore', 15:44:57 INFO - 'sessionrestore_no_auto_restore', 15:44:57 INFO - 'tabpaint']}, 15:44:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:44:57 INFO - 'tests': ['a11yr', 15:44:57 INFO - 'ts_paint', 15:44:57 INFO - 'tpaint', 15:44:57 INFO - 'sessionrestore', 15:44:57 INFO - 'sessionrestore_no_auto_restore', 15:44:57 INFO - 'tabpaint']}, 15:44:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:44:57 INFO - 'tests': ['tsvgx', 15:44:57 INFO - 'tsvgr_opacity', 15:44:57 INFO - 'tart', 15:44:57 INFO - 'tscrollx', 15:44:57 INFO - 'cart', 15:44:57 INFO - 'tsvg_static']}, 15:44:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:44:57 INFO - 'tsvgr_opacity', 15:44:57 INFO - 'tart', 15:44:57 INFO - 'tscrollx', 15:44:57 INFO - 'cart', 15:44:57 INFO - 'tsvg_static']}, 15:44:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:44:57 INFO - 'talos_options': ['--disable-e10s'], 15:44:57 INFO - 'tests': ['tp5o']}, 15:44:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:44:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:44:57 INFO - 'talos_options': ['--disable-e10s', 15:44:57 INFO - '--xperf_path', 15:44:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:57 INFO - 'tests': ['tp5n']}, 15:44:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:44:57 INFO - 'talos_options': ['--xperf_path', 15:44:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:57 INFO - 'tests': ['tp5n']}}, 15:44:57 INFO - 'talos.zip': {'path': '', 15:44:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:44:57 INFO - Running post-action listener: _resource_record_post_action 15:44:57 INFO - [mozharness: 2017-01-06 23:44:57.575711Z] Finished populate-webroot step (success) 15:44:57 INFO - [mozharness: 2017-01-06 23:44:57.575805Z] Running create-virtualenv step. 15:44:57 INFO - Running pre-action listener: _resource_record_pre_action 15:44:57 INFO - Running main action method: create_virtualenv 15:44:57 INFO - Creating virtualenv /builds/slave/test/build/venv 15:44:57 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 15:44:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:44:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:44:57 INFO - Using real prefix '/usr' 15:44:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:44:58 INFO - Installing distribute.............................................................................................................................................................................................done. 15:45:00 INFO - Installing pip.................done. 15:45:00 INFO - Return code: 0 15:45:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:45:00 INFO - Reading from file tmpfile_stdout 15:45:00 INFO - Output received: 15:45:00 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) 15:45:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:45: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')]} 15:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45: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')]} 15:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:00 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 0x25001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2871c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f3f0>, '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 0x286fcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28701a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', '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 15:45:00 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 15:45:00 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 15:45:00 INFO - Using env: {'DISPLAY': ':0', 15:45:00 INFO - 'HOME': '/home/cltbld', 15:45:00 INFO - 'LANG': 'en_US.UTF-8', 15:45:00 INFO - 'LANGUAGE': 'en_US:en', 15:45:00 INFO - 'LOGNAME': 'cltbld', 15:45:00 INFO - 'MAIL': '/var/mail/cltbld', 15:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:00 INFO - 'MOZ_NO_REMOTE': '1', 15:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:00 INFO - 'NO_EM_RESTART': '1', 15:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:00 INFO - 'PWD': '/builds/slave/test', 15:45:00 INFO - 'SHELL': '/bin/bash', 15:45:00 INFO - 'SHLVL': '1', 15:45:00 INFO - 'TERM': 'linux', 15:45:00 INFO - 'TMOUT': '86400', 15:45:00 INFO - 'USER': 'cltbld', 15:45:00 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', 15:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:00 INFO - '_': '/tools/buildbot/bin/python'} 15:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:00 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 15:45:00 INFO - Cleaning up... 15:45:00 INFO - Return code: 0 15:45:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:45: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')]} 15:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45: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')]} 15:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:00 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 0x25001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2871c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f3f0>, '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 0x286fcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28701a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', '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 15:45:00 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 15:45:00 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 15:45:00 INFO - Using env: {'DISPLAY': ':0', 15:45:00 INFO - 'HOME': '/home/cltbld', 15:45:00 INFO - 'LANG': 'en_US.UTF-8', 15:45:00 INFO - 'LANGUAGE': 'en_US:en', 15:45:00 INFO - 'LOGNAME': 'cltbld', 15:45:00 INFO - 'MAIL': '/var/mail/cltbld', 15:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:00 INFO - 'MOZ_NO_REMOTE': '1', 15:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:00 INFO - 'NO_EM_RESTART': '1', 15:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:00 INFO - 'PWD': '/builds/slave/test', 15:45:00 INFO - 'SHELL': '/bin/bash', 15:45:00 INFO - 'SHLVL': '1', 15:45:00 INFO - 'TERM': 'linux', 15:45:00 INFO - 'TMOUT': '86400', 15:45:00 INFO - 'USER': 'cltbld', 15:45:00 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', 15:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:00 INFO - '_': '/tools/buildbot/bin/python'} 15:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:00 INFO - Downloading/unpacking psutil>=3.1.1 15:45:00 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 15:45:00 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 15:45:00 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 15:45:00 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 15:45:00 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 15:45:00 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 15:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:45:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:02 INFO - Installing collected packages: psutil 15:45:02 INFO - Running setup.py install for psutil 15:45:02 INFO - building 'psutil._psutil_linux' extension 15:45:02 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 15:45:03 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 15:45:03 INFO - building 'psutil._psutil_posix' extension 15:45:03 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 15:45:03 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 15:45:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:03 INFO - Successfully installed psutil 15:45:03 INFO - Cleaning up... 15:45:03 INFO - Return code: 0 15:45:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2871c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f3f0>, '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 0x286fcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28701a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', '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 15:45:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:45:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:45:03 INFO - Using env: {'DISPLAY': ':0', 15:45:03 INFO - 'HOME': '/home/cltbld', 15:45:03 INFO - 'LANG': 'en_US.UTF-8', 15:45:03 INFO - 'LANGUAGE': 'en_US:en', 15:45:03 INFO - 'LOGNAME': 'cltbld', 15:45:03 INFO - 'MAIL': '/var/mail/cltbld', 15:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:03 INFO - 'MOZ_NO_REMOTE': '1', 15:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:03 INFO - 'NO_EM_RESTART': '1', 15:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:03 INFO - 'PWD': '/builds/slave/test', 15:45:03 INFO - 'SHELL': '/bin/bash', 15:45:03 INFO - 'SHLVL': '1', 15:45:03 INFO - 'TERM': 'linux', 15:45:03 INFO - 'TMOUT': '86400', 15:45:03 INFO - 'USER': 'cltbld', 15:45:03 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', 15:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:03 INFO - '_': '/tools/buildbot/bin/python'} 15:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:45:03 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 15:45:03 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 15:45:03 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 15:45:03 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 15:45:03 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 15:45:03 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 15:45:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:45:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:45:05 INFO - Installing collected packages: mozsystemmonitor 15:45:05 INFO - Running setup.py install for mozsystemmonitor 15:45:05 INFO - Successfully installed mozsystemmonitor 15:45:05 INFO - Cleaning up... 15:45:05 INFO - Return code: 0 15:45:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:45:05 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')]} 15:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:05 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')]} 15:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:05 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 0x25001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2871c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f3f0>, '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 0x286fcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28701a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', '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 15:45:05 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 15:45:05 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 15:45:05 INFO - Using env: {'DISPLAY': ':0', 15:45:05 INFO - 'HOME': '/home/cltbld', 15:45:05 INFO - 'LANG': 'en_US.UTF-8', 15:45:05 INFO - 'LANGUAGE': 'en_US:en', 15:45:05 INFO - 'LOGNAME': 'cltbld', 15:45:05 INFO - 'MAIL': '/var/mail/cltbld', 15:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:05 INFO - 'MOZ_NO_REMOTE': '1', 15:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:05 INFO - 'NO_EM_RESTART': '1', 15:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:05 INFO - 'PWD': '/builds/slave/test', 15:45:05 INFO - 'SHELL': '/bin/bash', 15:45:05 INFO - 'SHLVL': '1', 15:45:05 INFO - 'TERM': 'linux', 15:45:05 INFO - 'TMOUT': '86400', 15:45:05 INFO - 'USER': 'cltbld', 15:45:05 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', 15:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:05 INFO - '_': '/tools/buildbot/bin/python'} 15:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:06 INFO - Downloading/unpacking jsonschema==2.5.1 15:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:45:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:45:08 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 15:45:08 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 15:45:08 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 15:45:08 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 15:45:08 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 15:45:08 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 15:45:08 INFO - Downloading functools32-3.2.3-2.tar.gz 15:45:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:45:08 INFO - warning: no files found matching '*.txt' 15:45:08 INFO - no previously-included directories found matching 'build' 15:45:08 INFO - no previously-included directories found matching 'dist' 15:45:08 INFO - no previously-included directories found matching '.git*' 15:45:08 INFO - Installing collected packages: jsonschema, functools32 15:45:08 INFO - Running setup.py install for functools32 15:45:08 INFO - warning: no files found matching '*.txt' 15:45:08 INFO - no previously-included directories found matching 'build' 15:45:08 INFO - no previously-included directories found matching 'dist' 15:45:08 INFO - no previously-included directories found matching '.git*' 15:45:08 INFO - Successfully installed jsonschema functools32 15:45:08 INFO - Cleaning up... 15:45:08 INFO - Return code: 0 15:45:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:08 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 0x25001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2871c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f3f0>, '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 0x286fcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28701a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', '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 15:45:08 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 15:45:08 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 15:45:08 INFO - Using env: {'DISPLAY': ':0', 15:45:08 INFO - 'HOME': '/home/cltbld', 15:45:08 INFO - 'LANG': 'en_US.UTF-8', 15:45:08 INFO - 'LANGUAGE': 'en_US:en', 15:45:08 INFO - 'LOGNAME': 'cltbld', 15:45:08 INFO - 'MAIL': '/var/mail/cltbld', 15:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:08 INFO - 'MOZ_NO_REMOTE': '1', 15:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:08 INFO - 'NO_EM_RESTART': '1', 15:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:08 INFO - 'PWD': '/builds/slave/test', 15:45:08 INFO - 'SHELL': '/bin/bash', 15:45:08 INFO - 'SHLVL': '1', 15:45:08 INFO - 'TERM': 'linux', 15:45:08 INFO - 'TMOUT': '86400', 15:45:08 INFO - 'USER': 'cltbld', 15:45:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', 15:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:08 INFO - '_': '/tools/buildbot/bin/python'} 15:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:45:08 INFO - Cleaning up... 15:45:08 INFO - Return code: 0 15:45:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:08 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 0x25001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2871c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f3f0>, '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 0x286fcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28701a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', '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 15:45:08 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 15:45:08 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 15:45:08 INFO - Using env: {'DISPLAY': ':0', 15:45:08 INFO - 'HOME': '/home/cltbld', 15:45:08 INFO - 'LANG': 'en_US.UTF-8', 15:45:08 INFO - 'LANGUAGE': 'en_US:en', 15:45:08 INFO - 'LOGNAME': 'cltbld', 15:45:08 INFO - 'MAIL': '/var/mail/cltbld', 15:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:08 INFO - 'MOZ_NO_REMOTE': '1', 15:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:08 INFO - 'NO_EM_RESTART': '1', 15:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:08 INFO - 'PWD': '/builds/slave/test', 15:45:08 INFO - 'SHELL': '/bin/bash', 15:45:08 INFO - 'SHLVL': '1', 15:45:08 INFO - 'TERM': 'linux', 15:45:08 INFO - 'TMOUT': '86400', 15:45:08 INFO - 'USER': 'cltbld', 15:45:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', 15:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:08 INFO - '_': '/tools/buildbot/bin/python'} 15:45:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:09 INFO - Downloading/unpacking blobuploader==1.2.4 15:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:11 INFO - Downloading blobuploader-1.2.4.tar.gz 15:45:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:45:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:45:11 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 15:45:11 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 15:45:11 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 15:45:11 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 15:45:11 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 15:45:11 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 15:45:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:45:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:45:11 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 15:45:11 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 15:45:11 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 15:45:11 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 15:45:11 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 15:45:11 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 15:45:11 INFO - Downloading docopt-0.6.1.tar.gz 15:45:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:45:11 INFO - Installing collected packages: blobuploader, requests, docopt 15:45:11 INFO - Running setup.py install for blobuploader 15:45:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:45:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:45:11 INFO - Running setup.py install for requests 15:45:12 INFO - Running setup.py install for docopt 15:45:12 INFO - Successfully installed blobuploader requests docopt 15:45:12 INFO - Cleaning up... 15:45:12 INFO - Return code: 0 15:45:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:12 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')]} 15:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:12 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')]} 15:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:12 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 0x25001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2871c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f3f0>, '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 0x286fcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28701a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', '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 15:45:12 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 15:45:12 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 15:45:12 INFO - Using env: {'DISPLAY': ':0', 15:45:12 INFO - 'HOME': '/home/cltbld', 15:45:12 INFO - 'LANG': 'en_US.UTF-8', 15:45:12 INFO - 'LANGUAGE': 'en_US:en', 15:45:12 INFO - 'LOGNAME': 'cltbld', 15:45:12 INFO - 'MAIL': '/var/mail/cltbld', 15:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:12 INFO - 'MOZ_NO_REMOTE': '1', 15:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:12 INFO - 'NO_EM_RESTART': '1', 15:45:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:12 INFO - 'PWD': '/builds/slave/test', 15:45:12 INFO - 'SHELL': '/bin/bash', 15:45:12 INFO - 'SHLVL': '1', 15:45:12 INFO - 'TERM': 'linux', 15:45:12 INFO - 'TMOUT': '86400', 15:45:12 INFO - 'USER': 'cltbld', 15:45:12 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', 15:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:12 INFO - '_': '/tools/buildbot/bin/python'} 15:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:45:12 INFO - Running setup.py (path:/tmp/pip-pPQBVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:45:12 INFO - Running setup.py (path:/tmp/pip-VnxOq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:45:12 INFO - Running setup.py (path:/tmp/pip-dwYw3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:45:12 INFO - Running setup.py (path:/tmp/pip-qp_HAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:45:12 INFO - Running setup.py (path:/tmp/pip-gtEXeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:45:13 INFO - Running setup.py (path:/tmp/pip-VHQZs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:45:13 INFO - Running setup.py (path:/tmp/pip-qXeyqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:45:13 INFO - Running setup.py (path:/tmp/pip-Q2epjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:45:13 INFO - Running setup.py (path:/tmp/pip-DY6t2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:45:13 INFO - Running setup.py (path:/tmp/pip-PlAbyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:45:13 INFO - Running setup.py (path:/tmp/pip-QtFitz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:45:13 INFO - Running setup.py (path:/tmp/pip-DzXwIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:45:13 INFO - Running setup.py (path:/tmp/pip-BK1hnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:45:13 INFO - Running setup.py (path:/tmp/pip-z_raqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:13 INFO - Running setup.py (path:/tmp/pip-951TfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:45:13 INFO - Running setup.py (path:/tmp/pip-HK3CBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:45:13 INFO - Running setup.py (path:/tmp/pip-6WymD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:45:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:45:13 INFO - Running setup.py install for manifestparser 15:45:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:45:13 INFO - Running setup.py install for mozcrash 15:45:14 INFO - Running setup.py install for mozdebug 15:45:14 INFO - Running setup.py install for mozdevice 15:45:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:45:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:45:14 INFO - Running setup.py install for mozfile 15:45:14 INFO - Running setup.py install for mozhttpd 15:45:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:45:14 INFO - Running setup.py install for mozinfo 15:45:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:45:14 INFO - Running setup.py install for mozInstall 15:45:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:45:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:45:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:45:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:45:14 INFO - Running setup.py install for mozleak 15:45:14 INFO - Running setup.py install for mozlog 15:45:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:45:14 INFO - Running setup.py install for moznetwork 15:45:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:45:15 INFO - Running setup.py install for mozprocess 15:45:15 INFO - Running setup.py install for mozprofile 15:45:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:45:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:45:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:45:15 INFO - Running setup.py install for mozrunner 15:45:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:45:15 INFO - Running setup.py install for mozscreenshot 15:45:15 INFO - Running setup.py install for moztest 15:45:15 INFO - Running setup.py install for mozversion 15:45:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:45:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:45:15 INFO - Cleaning up... 15:45:15 INFO - Return code: 0 15:45:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:15 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 0x25001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2871c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f3f0>, '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 0x286fcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28701a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', '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 15:45:15 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 15:45:15 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 15:45:15 INFO - Using env: {'DISPLAY': ':0', 15:45:15 INFO - 'HOME': '/home/cltbld', 15:45:15 INFO - 'LANG': 'en_US.UTF-8', 15:45:15 INFO - 'LANGUAGE': 'en_US:en', 15:45:15 INFO - 'LOGNAME': 'cltbld', 15:45:15 INFO - 'MAIL': '/var/mail/cltbld', 15:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:15 INFO - 'MOZ_NO_REMOTE': '1', 15:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:15 INFO - 'NO_EM_RESTART': '1', 15:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:15 INFO - 'PWD': '/builds/slave/test', 15:45:15 INFO - 'SHELL': '/bin/bash', 15:45:15 INFO - 'SHLVL': '1', 15:45:15 INFO - 'TERM': 'linux', 15:45:15 INFO - 'TMOUT': '86400', 15:45:15 INFO - 'USER': 'cltbld', 15:45:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', 15:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:15 INFO - '_': '/tools/buildbot/bin/python'} 15:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:45:15 INFO - Running setup.py (path:/tmp/pip-lYEL18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:45:15 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)) 15:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:45:15 INFO - Running setup.py (path:/tmp/pip-8oqdvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:45:16 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)) 15:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:45:16 INFO - Running setup.py (path:/tmp/pip-uoku3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:45:16 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)) 15:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:45:16 INFO - Running setup.py (path:/tmp/pip-FSLacJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:45:16 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)) 15:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:45:16 INFO - Running setup.py (path:/tmp/pip-eNcVcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:45:16 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)) 15:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:45:16 INFO - Running setup.py (path:/tmp/pip-NrvXgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:45:16 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)) 15:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:45:16 INFO - Running setup.py (path:/tmp/pip-dZSbeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:45:16 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)) 15:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:45:16 INFO - Running setup.py (path:/tmp/pip-KRrENw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:45:16 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)) 15:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:45:16 INFO - Running setup.py (path:/tmp/pip-NvpIUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:45:16 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)) 15:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:45:16 INFO - Running setup.py (path:/tmp/pip-fwOOf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:45:16 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)) 15:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:45:16 INFO - Running setup.py (path:/tmp/pip-cdgqKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:45:16 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)) 15:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:45:16 INFO - Running setup.py (path:/tmp/pip-RF6TLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:45:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 15:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:45:16 INFO - Running setup.py (path:/tmp/pip-QdCtpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:45:16 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)) 15:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:45:16 INFO - Running setup.py (path:/tmp/pip-Rx45Qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:45:16 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)) 15:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:16 INFO - Running setup.py (path:/tmp/pip-eQQCWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:17 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)) 15:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:45:17 INFO - Running setup.py (path:/tmp/pip-jyX1wO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:45:17 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)) 15:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:45:17 INFO - Running setup.py (path:/tmp/pip-e9x3e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:45:17 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)) 15:45:17 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)) 15:45:17 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)) 15:45:17 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)) 15:45:17 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)) 15:45:17 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)) 15:45:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:45:17 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 15:45:17 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 15:45:17 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 15:45:17 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 15:45:17 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 15:45:17 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 15:45:19 INFO - Downloading blessings-1.6.tar.gz 15:45:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:45:19 INFO - Installing collected packages: blessings 15:45:19 INFO - Running setup.py install for blessings 15:45:19 INFO - Successfully installed blessings 15:45:19 INFO - Cleaning up... 15:45:19 INFO - Return code: 0 15:45:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:45:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:45:19 INFO - Reading from file tmpfile_stdout 15:45:19 INFO - Current package versions: 15:45:19 INFO - argparse == 1.2.1 15:45:19 INFO - blessings == 1.6 15:45:19 INFO - blobuploader == 1.2.4 15:45:19 INFO - docopt == 0.6.1 15:45:19 INFO - functools32 == 3.2.3-2 15:45:19 INFO - jsonschema == 2.5.1 15:45:19 INFO - manifestparser == 1.1 15:45:19 INFO - mozInstall == 1.12 15:45:19 INFO - mozcrash == 1.0 15:45:19 INFO - mozdebug == 0.1 15:45:19 INFO - mozdevice == 0.49 15:45:19 INFO - mozfile == 1.2 15:45:19 INFO - mozhttpd == 0.7 15:45:19 INFO - mozinfo == 0.9 15:45:19 INFO - mozleak == 0.1 15:45:19 INFO - mozlog == 3.4 15:45:19 INFO - moznetwork == 0.27 15:45:19 INFO - mozprocess == 0.23 15:45:19 INFO - mozprofile == 0.28 15:45:19 INFO - mozrunner == 6.13 15:45:19 INFO - mozscreenshot == 0.1 15:45:19 INFO - mozsystemmonitor == 0.3 15:45:19 INFO - moztest == 0.8 15:45:19 INFO - mozversion == 1.4 15:45:19 INFO - psutil == 3.1.1 15:45:19 INFO - requests == 1.2.3 15:45:19 INFO - wsgiref == 0.1.2 15:45:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:19 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')]} 15:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:19 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')]} 15:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:19 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 0x25001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2871c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f3f0>, '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 0x286fcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28701a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', '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 15:45:19 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 15:45:19 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 15:45:19 INFO - Using env: {'DISPLAY': ':0', 15:45:19 INFO - 'HOME': '/home/cltbld', 15:45:19 INFO - 'LANG': 'en_US.UTF-8', 15:45:19 INFO - 'LANGUAGE': 'en_US:en', 15:45:19 INFO - 'LOGNAME': 'cltbld', 15:45:19 INFO - 'MAIL': '/var/mail/cltbld', 15:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:19 INFO - 'MOZ_NO_REMOTE': '1', 15:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:19 INFO - 'NO_EM_RESTART': '1', 15:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:19 INFO - 'PWD': '/builds/slave/test', 15:45:19 INFO - 'SHELL': '/bin/bash', 15:45:19 INFO - 'SHLVL': '1', 15:45:19 INFO - 'TERM': 'linux', 15:45:19 INFO - 'TMOUT': '86400', 15:45:19 INFO - 'USER': 'cltbld', 15:45:19 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', 15:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:19 INFO - '_': '/tools/buildbot/bin/python'} 15:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 INFO - Cleaning up... 15:45:19 INFO - Return code: 0 15:45:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:45:19 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')]} 15:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:19 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')]} 15:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:19 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 0x25001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2871c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f3f0>, '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 0x286fcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28701a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', '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 15:45:19 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 15:45:19 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 15:45:19 INFO - Using env: {'DISPLAY': ':0', 15:45:19 INFO - 'HOME': '/home/cltbld', 15:45:19 INFO - 'LANG': 'en_US.UTF-8', 15:45:19 INFO - 'LANGUAGE': 'en_US:en', 15:45:19 INFO - 'LOGNAME': 'cltbld', 15:45:19 INFO - 'MAIL': '/var/mail/cltbld', 15:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:19 INFO - 'MOZ_NO_REMOTE': '1', 15:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:19 INFO - 'NO_EM_RESTART': '1', 15:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:19 INFO - 'PWD': '/builds/slave/test', 15:45:19 INFO - 'SHELL': '/bin/bash', 15:45:19 INFO - 'SHLVL': '1', 15:45:19 INFO - 'TERM': 'linux', 15:45:19 INFO - 'TMOUT': '86400', 15:45:19 INFO - 'USER': 'cltbld', 15:45:19 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', 15:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:19 INFO - '_': '/tools/buildbot/bin/python'} 15:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:45:20 INFO - Cleaning up... 15:45:20 INFO - Return code: 0 15:45:20 INFO - Running post-action listener: _resource_record_post_action 15:45:20 INFO - Running post-action listener: _start_resource_monitoring 15:45:20 INFO - Starting resource monitoring. 15:45:20 INFO - [mozharness: 2017-01-06 23:45:20.155420Z] Finished create-virtualenv step (success) 15:45:20 INFO - [mozharness: 2017-01-06 23:45:20.155924Z] Running install step. 15:45:20 INFO - Running pre-action listener: _resource_record_pre_action 15:45:20 INFO - Running main action method: install 15:45:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:45:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:45:20 INFO - Reading from file tmpfile_stdout 15:45:20 INFO - Detecting whether we're running mozinstall >=1.0... 15:45:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:45:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:45:20 INFO - Reading from file tmpfile_stdout 15:45:20 INFO - Output received: 15:45:20 INFO - Usage: mozinstall [options] installer 15:45:20 INFO - Options: 15:45:20 INFO - -h, --help show this help message and exit 15:45:20 INFO - -d DEST, --destination=DEST 15:45:20 INFO - Directory to install application into. [default: 15:45:20 INFO - "/builds/slave/test"] 15:45:20 INFO - --app=APP Application being installed. [default: firefox] 15:45:20 INFO - mkdir: /builds/slave/test/build/application 15:45:20 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'] 15:45:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:45:36 INFO - Reading from file tmpfile_stdout 15:45:36 INFO - Output received: 15:45:36 INFO - /builds/slave/test/build/application/firefox/firefox 15:45:36 INFO - Running post-action listener: _resource_record_post_action 15:45:36 INFO - [mozharness: 2017-01-06 23:45:36.550495Z] Finished install step (success) 15:45:36 INFO - [mozharness: 2017-01-06 23:45:36.550768Z] Running run-tests step. 15:45:36 INFO - Running pre-action listener: _resource_record_pre_action 15:45:36 INFO - Running main action method: run_tests 15:45:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:45:36 INFO - Python 2.7.3 15:45:36 INFO - Return code: 0 15:45:36 INFO - grabbing minidump binary from tooltool 15:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:36 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 0x286f3f0>, '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 0x286fcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28701a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:45:36 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 15:45:36 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 15:45:36 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 15:45:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:45:36 INFO - Return code: 0 15:45:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:45:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:45:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:45:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:45:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:45:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 15:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 15:45:36 INFO - Using env: {'DISPLAY': ':0', 15:45:36 INFO - 'HOME': '/home/cltbld', 15:45:36 INFO - 'LANG': 'en_US.UTF-8', 15:45:36 INFO - 'LANGUAGE': 'en_US:en', 15:45:36 INFO - 'LOGNAME': 'cltbld', 15:45:36 INFO - 'MAIL': '/var/mail/cltbld', 15:45:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:45:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:36 INFO - 'MOZ_NO_REMOTE': '1', 15:45:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:36 INFO - 'NO_EM_RESTART': '1', 15:45:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:36 INFO - 'PWD': '/builds/slave/test', 15:45:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:45:36 INFO - 'SHELL': '/bin/bash', 15:45:36 INFO - 'SHLVL': '1', 15:45:36 INFO - 'TERM': 'linux', 15:45:36 INFO - 'TMOUT': '86400', 15:45:36 INFO - 'USER': 'cltbld', 15:45:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870', 15:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:36 INFO - '_': '/tools/buildbot/bin/python'} 15:45:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 15:45:36 INFO - mozversion application_buildid: 20170106172842 15:45:36 INFO - mozversion application_changeset: da4d2276cd297b3f74e59c5aa4a9ec81c0020d1e 15:45:36 INFO - mozversion application_display_name: Nightly 15:45:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:45:36 INFO - mozversion application_name: Firefox 15:45:36 INFO - mozversion application_remotingname: firefox 15:45:36 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 15:45:36 INFO - mozversion application_vendor: Mozilla 15:45:36 INFO - mozversion application_version: 53.0a1 15:45:36 INFO - mozversion platform_buildid: 20170106172842 15:45:36 INFO - mozversion platform_changeset: da4d2276cd297b3f74e59c5aa4a9ec81c0020d1e 15:45:36 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 15:45:36 INFO - mozversion platform_version: 53.0a1 15:45:36 INFO - using testdate: 1483746336 15:45:36 INFO - actual date: 1483746336 15:45:36 INFO - starting webserver on 'localhost:53184' 15:45:36 INFO - SUITE-START | Running 2 tests 15:45:36 INFO - TEST-START | dromaeo_css 15:45:36 INFO - operating with platform_type : linux_ 15:45:36 INFO - Initialising browser for dromaeo_css test... 15:45:36 INFO - TEST-INFO | started process 17624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmCtiiE/profile http://localhost:53184/getInfo.html) 15:45:37 INFO - PROCESS | 17624 | 1483746337359 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 15:45:41 INFO - PROCESS | 17624 | __metrics Screen width/height:1600/1200 15:45:41 INFO - PROCESS | 17624 | colorDepth:24 15:45:41 INFO - PROCESS | 17624 | Browser inner width/height: 1024/697 15:45:41 INFO - PROCESS | 17624 | __metrics 15:45:42 ERROR - PROCESS | 17624 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 15:45:43 INFO - TEST-INFO | 17624: exit 0 15:45:43 INFO - Browser initialized. 15:45:43 INFO - Running cycle 1/1 for dromaeo_css test... 15:45:43 INFO - TEST-INFO | started process 17744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmCtiiE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:45:55 INFO - PROCESS | 17744 | RSS: Main: 158420992 15:45:55 INFO - PROCESS | 17744 | 15:48:58 INFO - PROCESS | 17744 | Cycle 1(1): loaded http://localhost:53184/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53184/tests/dromaeo/cssquery-ext.html) 15:49:00 INFO - PROCESS | 17744 | RSS: Main: 166383616 15:49:00 INFO - PROCESS | 17744 | 15:50:43 INFO - PROCESS | 17744 | ************************* 15:50:43 INFO - PROCESS | 17744 | A coding exception was thrown and uncaught in a Task. 15:50:43 INFO - PROCESS | 17744 | 15:50:43 INFO - PROCESS | 17744 | Full message: ReferenceError: fetch is not defined 15:50:43 INFO - PROCESS | 17744 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 15:50:43 INFO - PROCESS | 17744 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 15:50:43 INFO - PROCESS | 17744 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 15:50:43 INFO - PROCESS | 17744 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 15:50:43 INFO - PROCESS | 17744 | TaskImpl@resource://gre/modules/Task.jsm:277:3 15:50:43 INFO - PROCESS | 17744 | asyncFunction@resource://gre/modules/Task.jsm:252:14 15:50:43 INFO - PROCESS | 17744 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 15:50:43 INFO - PROCESS | 17744 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 15:50:43 INFO - PROCESS | 17744 | TaskImpl@resource://gre/modules/Task.jsm:277:3 15:50:43 INFO - PROCESS | 17744 | asyncFunction@resource://gre/modules/Task.jsm:252:14 15:50:43 INFO - PROCESS | 17744 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 15:50:43 INFO - PROCESS | 17744 | 15:50:43 INFO - PROCESS | 17744 | ************************* 15:52:02 INFO - PROCESS | 17744 | Cycle 1(1): loaded http://localhost:53184/tests/dromaeo/cssquery-ext.html (next: http://localhost:53184/tests/dromaeo/cssquery-jquery.html) 15:52:03 INFO - PROCESS | 17744 | RSS: Main: 162869248 15:52:03 INFO - PROCESS | 17744 | 15:55:05 INFO - PROCESS | 17744 | Cycle 1(1): loaded http://localhost:53184/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53184/tests/dromaeo/cssquery-mootools.html) 15:55:06 INFO - PROCESS | 17744 | RSS: Main: 168812544 15:55:06 INFO - PROCESS | 17744 | 15:58:08 INFO - PROCESS | 17744 | Cycle 1(1): loaded http://localhost:53184/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53184/tests/dromaeo/cssquery-prototype.html) 15:58:08 INFO - PROCESS | 17744 | RSS: Main: 163225600 15:58:08 INFO - PROCESS | 17744 | 16:01:11 INFO - PROCESS | 17744 | Cycle 1(1): loaded http://localhost:53184/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53184/tests/dromaeo/cssquery-yui.html) 16:01:12 INFO - PROCESS | 17744 | RSS: Main: 166502400 16:01:12 INFO - PROCESS | 17744 | 16:04:15 INFO - PROCESS | 17744 | Cycle 1(1): loaded http://localhost:53184/tests/dromaeo/cssquery-yui.html (next: http://localhost:53184/tests/dromaeo/cssquery-dojo.html) 16:04:15 INFO - PROCESS | 17744 | RSS: Main: 167485440 16:04:15 INFO - PROCESS | 17744 | 16:04:15 INFO - PROCESS | 17744 | __start_tp_report 16:04:15 INFO - PROCESS | 17744 | _x_x_mozilla_page_load 16:04:15 INFO - PROCESS | 17744 | _x_x_mozilla_page_load_details 16:04:15 INFO - PROCESS | 17744 | |i|pagename|runs| 16:04:15 INFO - PROCESS | 17744 | |0;dojo.html;2575.433404650976;2581.9483610327793;2589.844609323442;2600.0379859452;2605.7654811067;4621.283701026337;4687.320338550908;4699.130660827749;4721.26820342847;4790.568848803607;4649.418822647169;4698.130845793522;4742.739149346785;4759.595434388072;4839.56443920048;4343.565643435655;4367.694261401703;4387.034852332482;4483.14820184164;4510.864674059783;4042.6361627453525;4482.305242687388;4484.23767959446;4507.188706032913;4514.706544074625;4289.828406863721;4410.448693913261;4425.468943726742;4442.822287108512;4518.209313370147;4314.892127696801;4331.891702707426;4342.261815491374;4380.868573942755;4459.576340247671;4370;4370.388145659578;4377.430933978562;4388.078503514266;4403.581659742352;4694.389729335165;4749.192637251641;4750.168720473903;4799.064182484417;4810.302506136625;4966;5003.249512573107;5016.799328026875;5036.722980236085;5051.722155281494;5111.923321150186;5118.436971933084;5120.718360490171;5123.359580052494;5149.0731668299695;4754.904901902012;4757.904841903142;4759.762011899391;4810.39870016248;4854.708717476963;5035.773390197377;5035.84892453227;5064.392272927273;5141.100307446182;5274.841754747364;4886.926696099561;4902.044101400193;4933;4938.185199442052;4947.505249475023;4963.677360971597;5011.198208286657;5011.248312753116;5014.623903207274;5037.370328708911;4917.188663870493;4960.751962401865;4962.727050012284;4975;4987.102321582078;5008;5008.073506401327;5013.323201367842;5019.52314530119;5028.120078986163;4333.523312435629;4334.913301733947;4344.326629372453;4365;4371.12577484498;3731.8880433587037;3739.9252014959548;3743.4384842273876;3745.1198968242443;3765.359888818907;4410.316400957857;4410.536893626123;4459.397981272552;4469.597736203757;4474.597286244189;5118.564921981673;5168.715720635401;5177.922331165036;5181.481851814789;5182.093133701587;4282.336237883133;4311.633511151587;4371.060222052274;4428.623566996777;4447.355133505624;4618.168729628632;4619.422572178478;4648.5119062498625;4656.045510670305;4683.976580117078;4774.427068751772;4783.784729687103;4783.808647654194;4784.617230621472;4829.420469543607;4946.703197808143;5146.69119852795;5151.922721159261;5153.5361817436615;5214.2960700304975;4647.3726046984575;4718.693284936468;4726.503717109654;4754.405699287589;4839.758012099452;5017.4731653175895;5021.573166280907;5034.0686972910125;5037.924431133462;5106.412762532356;5016.799328026838;5058.848234552969;5071.77177027042;5094.2867998479505;5120.871978200575;4829.082474329866;4991.351124353956;4995.8001679932395;4996.400431948189;4999.900002000012;4910.116179087799;4939.135651261086;4969.378827646544;4990.026944745885;5081.7713202905215;4945.23348880924;4945.653804233669;4973.104841128632;4978.228374601942;4981.37732783402;5057.570106540985;5073.92389114171;5076.416212135504;5083.38999320084;5086.516552074208;4792.233242681294;4817.445993710769;4822.662413631012;4872.220444728827;4882.267659850909 16:04:15 INFO - PROCESS | 17744 | |1;ext.html;514.7143335448826;519.1589624807809;522.3444577055797;528.1206790693495;529.1507131054658;39246.41130383043;40146.197076058495;40147.19705605886;40227.19545609086;44335.113297734024;41698.7915060425;42266.57733422665;42278.78860605693;42323.57676423235;42381.36427953575;7685.846283074349;7847.607619619025;7853.2539408756365;7923.524588524707;9404.952975235114;9490.66782662607;9734.172595329406;9769.364991275579;9777.853332200022;9779.706608801747;9762.463064531448;9808.16630586401;9814;9823.263255255848;9833.065858743445;9719.514024298756;9780.657676981342;9795.804083918352;9801.656942006995;9804.264680149017;9686.176674982635;9724.222062235074;9734.318597698164;9743.415395076318;9759.756006099833;32615.184620384443;32733.508997365057;32902.177445564055;32948.83525582357;33046.83476582626;3627.2564124354444;3672.100335417813;3684.4104943209227;3726;3726.8322925468146;26241.868790656117;26827.195184144508;26862.19413417581;27021.189364319103;27148.864255678793;3449.586049674055;3465.6361082086523;3691.907702307437;3692.7599706019023;3695.0947017980766;241587;241589;241610;242414;242739.78630106914;47018.712099624616;47109.52890471051;47461;47522;47631;49188.26217606739;49339.753301233985;49465;49481.752591236815;49521.25718114231;13231.933840330737;13298.534551290852;13321.40053697586;13327.866721332857;13348.599542013755;8789.384743068053;8937.597808098652;9539.904600953902;9868.605255789831;10669.679909602724;15782.605434864221;15796.21018949071;15882.047077175175;16040.197990100449;16090.75863862043;6388.520860935449;6399.520035997319;6464.903026454607;6574.6055236685;6744.5616034957575;774.5894675821824;780.7072347869549;781.4022272961189;788.7830846517254;800.7317548621161;26417.075402360824;28112;28117.71882281192;28336.149915502567;28614.713852861205;987.3088837813559;1006.5118417567473;1020.8366661334151;1029.6602121299952;1084.902358787697;14242.359093840802;14662.926685366505;14764.557063288119;14801.185934773475;14826.777598336033;130244.3487782555;131833;132463.33768331097;132629.33685331512;132632;51385;52136;52144.21783673248;52194;52398;1247.5134697467995;1270.4410059573759;1280.7950727883494;1287.2212311551564;1293.0173068468032;25631;26336.8683156583;26862.328441789112;27711;28005;42164.36753448762;42665.57334426616;43199;43228;43264.13471730485;322067;325703;326793;327366;327558;21192;21533.46166345854;23631.109511238716;23955.401114972265;23959;37724.245515088995;37797.811010944766;37858.62141378551;40867.386989194594;42145;32507;32773;32872.178195545304;33051.66948330486;33117.33765324728;32327.676723232467;33081.66918330882;33161;33329;33666.31668416618;31960;32107.83946080255;32210;32922.5061624071;33045;27650.308742281602;28802.135935921116;29839.701602983692;30290.545641815832;30338.54492182575;22929.77070229343;23069.88465057664;23143.305700829;23454.76545234526;23551.41121471977 16:04:15 INFO - PROCESS | 17744 | |2;jquery.html;365.5686290177591;374.68339253330925;383.2909118131456;383.5474140514193;404.8239016028028;17713.999999999985;18291.817081829176;18454.16956236971;18565.257389704428;18589.163487643054;18360.44918652439;18487.260509579635;18754.624907501842;18800;18894.433167004976;5115.897682046366;5302.867428314285;5325.627206095575;5326.3075800145925;5329.920051199235;5280.313559237294;5529.917051244214;5556.833295001156;5662.6602403855695;5665.603407761459;5644.520215781664;5658.858528536778;5663.037283661787;5671.517920976722;5717.285339332583;6279.340669229734;6315.905261421082;6335.619862808223;6346.460550853183;6367.61794292344;5460.645058071213;5542.002439560877;5579.637323573955;5649.378568357477;5670.68811215383;12475.625731228078;12563.057770667236;17015.319387224496;21499.355019349445;21877.781222187892;2284.371797755614;2310.1336998625516;2311.28350211435;2459.7909177719916;2497.625356196567;9369.48467834269;9373.203277721403;9447.763805904839;9814.607415703364;9859.359141655841;1729.6281299520538;1763.8147994460653;1792.5339411752907;1797.4967009237434;1798.2716999615177;66784;79029.60485197595;80367;80637.19362806356;81154.59422702908;9737.610495580238;9771.9022809771;9839.508024598885;10044.698659040241;10435.94782026085;12939.676508087374;12959.287239201745;12994.090413671142;13087.803682944763;13112.344382780822;7364.668589913466;7414.740484083031;7527.736529221451;7544.0192774938905;7712.074551053797;7044.718211271595;7172.533785303938;7357.484976051732;7371.9262807372315;7401;4064.349704047338;4119.0937993641355;4231.2440337260305;4274.316109422478;4298.63461605767;1753.5440785395888;1777.626698393352;1810.2939853457162;1818.2726909236412;1834.8440382567364;853.2193043365376;857.4255248983071;861.3195575495289;870.6430363551041;886.3308202307217;17837.821621783874;18035.098245087956;18082.3671171511;18809.153588088568;18871.52821179454;861.2335021830576;879.1867522541623;890.2655309369795;894.5706061090713;895.1987970766259;9908.25688073383;10218.744531386626;10395.58417663285;10410.95890410968;10466.110380617733;522440;539168;544123;555207;567517;69448.65275673589;93572.53213733887;96270.51864740631;96958.51520742351;98239.50880245553;968.2399316536485;976.0873583199731;1009.9242556808268;1012.4380968562372;1017.3590637898077;16336.67326653484;16574.419895303607;16578.419755308507;16599.3360265588;17099.00767365681;34297.314053718284;37071.443928341636;39221.6077839218;39682;40126.1974760509;52757.7362113187;54062.189067164814;54460;58318.83362332645;59176;6931.965340173267;7291.671874765754;7536.171021187555;7580.431467639839;8117.066537348281;10452.425116618355;12933.61199163989;12952;12978.870211297766;13036.47854085826;10434.947825260826;10582.259241852997;10718.35689858611;10926.50830712604;10937.234393592373;10615.31000484966;10846.240763146505;11033.282836615594;11055.954648390074;11256.380899050631;9757.512124393894;10976.341419514854;11209;11220.2145849793;11222.66332010041;7197.956296337106;7520.398368130646;7575.46971711997;7647.476332810271;7667.3099421052375;10158;11008.504617292401;11049.779004419706;11278.661640150809;11582.189246752647 16:04:15 INFO - PROCESS | 17744 | |3;mootools.html;1278.207511342967;1282.7049778550934;1283.8074288856676;1289.2715615677148;1299.1036185032324;6062.302835173957;6295.244570651528;6525.477961763059;6893.414059804916;6916.273791251915;6444.162258906347;6644.501662375329;6701.195856497227;6865.931340686591;6919.135108111486;2061.9793802061977;2105.0737675422765;2106.715593394895;2109.841761867858;2111.9894400527974;2067.472794437424;2081;2116;2132.2430537159316;2153.655415133579;2085.551606404623;2104.1478201328487;2105.2526353144644;2108.20942146695;2109.504266497372;2118.54451292972;2120.4380839077658;2121.140937920145;2128.1061953979365;2128.8935553222277;2078.324544523021;2092.79072092791;2102.842286828494;2119.1311562259552;2143.9356819295444;6879.58722476648;6896.7586134485555;6898.413634840995;6938.826529336757;6944.72221111155;4185.518665353493;4281.850135245251;4288.399624052635;4290.849820256276;4321.567843215685;2639.736026397364;2806.733360330765;2839.2050225936564;2867.813592116506;2890.624218851557;1063.6649455421518;1094.1574987259764;1116.2298014370058;1175.5356634129557;1179.168686076314;8693.5218562979;8747.475151490931;8806;8823.073577274357;8865.379423440361;3571.321448924696;3741.9335489385394;3767.4913886624954;3810.1046254130256;3824.8852534424013;7039.753608623673;7167.677454514559;7208.855822883618;7216.9278307216255;7237.384822290164;4237.851675191415;4263.8487608346195;4268.487781466182;4286.2284788738325;4294.806733696991;3758.0792705787258;3871.090293780959;3920.255151521259;3923.7841918694744;3927.5483319418063;3068.2942923127807;3102.100390886618;3176.682331766851;3180.6501284858646;3183.6657150999276;907.2651152566442;909.9499527525917;927.434265098303;929.9349045566745;938.5776400619749;813.158381075584;819.2422009641177;837.9335588927864;852.7464626998426;853.9231469167805;4637.211674015425;4655.23188673865;4677.8773094457765;4683.344331793552;4769.809207631656;871.7297637732323;884.6196135661727;889.3330002498126;894.789724414762;912.3750231091591;3142.8899988500293;3218.726408255278;3227.8547465363645;3292.8518216679827;3358.7816791908936;7890.368770498347;8201.22088401601;8232.382571307176;8291.543965081857;8306.501609903304;8208.179182081743;8230.62962166704;8239.95880020596;8240.928679271776;8279.213474719892;6268.153799237045;6386.9361306386345;6404.775832845828;6453.870922581522;6464.612123272619;4545.863624091283;4630.72215667061;4643.814247430065;4645.094206629675;4704.553067458586;7418.072740907387;7540.509866858637;7543.245675432413;7550.5469671819865;7611.505252158592;7234.240404757636;7400.740974065882;7460.962695186489;7580.54516728998;7706.922930770845;5869.413058694096;5950.494207992369;5974.581779275409;5980.8803823924145;5983.850403739942;6319.778807741707;6349.111124442489;6367.936320636734;6385.680715964276;6390.776322828865;5786.623869448641;5856.970715146567;5944.554158438048;5952.970235148797;6040.607360521552;5747.166660834239;5749.482546570829;5780.566457515787;5798.275215598051;5838.970805146117;5106.4893510648635;5222.086134926297;5225.1378522543355;5225.372955245395;5236.764345604381;4031.8992025199605;4100.835966561423;4187.225363307798;4197;4233.111046680232;4055.209234199303;4124.835006599822;4130.050088479727;4175.874723758292;4263.403123562765 16:04:15 INFO - PROCESS | 17744 | |4;prototype.html;348.47728407388934;350.2329897524421;350.6475991628413;352.36925902634283;360.70782666040503;5018.874528136794;5049.24261360796;5072.619553533481;5072.8478145655645;5105.540501354877;5001.974990125053;5007.921712489313;5017.974910125445;5035.395752509695;5038;3553.236054248336;3780.60303668115;3875.9031024224337;3880.1463677990937;4083.6937229707814;3873.748206366577;3886.9028274293087;3888.3389823730035;3888.572257051722;3899.78551179685;3850.9807450962844;3868;3870.4581358609817;3875.2755024014323;3885.261800257956;3849.2109117630816;3862.6523612874835;3866.284737323604;3878.8836334909715;3884.553276373211;3221.3074189049466;3362.6132994705677;3374.0889959710985;3378.915527111842;3393.745469089828;4843.2735089736825;4854.320395144682;4887.511248875119;4914.164592019365;4915.631327650441;4399.538048504893;4409.559044095597;4447.888802779924;4456.3538286948215;4468.977655111737;5039.521245481674;5046.595838999043;5170.896582068338;5188.533032027098;5232;3682.410814269731;3704.481372607837;3713.3130370881204;3719.5536535615897;3722.1439069014277;5160.709822544364;5443.292371991616;5454.836354909319;5486.753096110685;5492.912693176608;3638.872639457606;3643.5263415756312;3708.369577171887;3713.442983552489;3733.2160246348026;3773.415120656303;3775.7734535927934;3790.3556395412847;3793.981030094832;3796.734228603971;4339.609435150852;4343.763895897513;4410.514843367227;4414.448193975753;4416.4258646375765;5131.897362052738;5140.691558506502;5141;5182.170852663556;5285.762140703678;1256.5288016993627;1272.351100938528;1272.8981681465461;1275.7065874848836;1278.4566559212299;824.1058451579983;855.2046596665036;867.2324992381788;870.8214815962839;872.9742552500786;4469.329600559877;4469.553044695569;4481.663875209372;4499.302608095751;4501.392312037899;5154.3919256520585;5183.403908550489;5221.869453263623;5222.582193424517;5228.424873263938;4280.785960701953;4409.581089796464;4412.580804823537;4423.845165419195;4429.844955426544;2737.7809775217934;2742.6434563507014;2763.903263385772;2774.8196367236064;2792.6509186351705;4834.20235661119;4865.245886887538;4866.586340161126;4897.730624815598;4912.287718280829;5040.31955685985;5315.441878602768;5352.33365144877;5368.651037682538;5395.838124856261;4800.999375390381;4841.305543059972;4852.296417019513;4857.465678775332;4861.416630004422;5203.739813009259;5221.762507245532;5223.712695801767;5225.895482090413;5247.895042099213;5018.774155162953;5038.571721403721;5100.69395836251;5152.119476391165;5156.4327923927585;4818.445878723992;4828.782704778223;4830.7826147824135;4843.854684359475;4864.440589332272;3735.1782607826235;3776.2258736958306;3777.54669439669;3791.914447054054;3793.412021136728;5347.50278411716;5352.5450336721815;5356.946430535645;5368.919466208088;5377.704226267437;4934.876628084183;5189.506996835295;5212.426633070435;5221.407470721467;5241.895162096813;5178.6374953752875;5181.948180518147;5182.300389447376;5193.636445448782;5203.635745497779;5152.793888244429;5160.896782064413;5177.8187763429605;5190.351206099238;5204.557612602971;5002.624803139852;5226.151747297656;5234.0633965433035;5245.606579506629;5253.212018197301;5141.28022076917;5152.398038990435;5162.793488260578;5165.896682066413;5173.28402588644 16:04:15 INFO - PROCESS | 17744 | |5;yui.html;574.9540036797057;587.1486344800036;708.0794966543492;761.4137114421895;785.6150486261731;12519.436625351858;13582.660433489144;13752.312384380792;13842.446302147915;13869.306534673276;13131.737365252713;13135.605931822061;13199.538016169412;13240.933795331033;13245.93377033116;799.9520028798262;819.3772732723114;822.5147163173726;823.2426167925523;824.0646865807322;790.498033748571;821.979450513736;825.3438516379492;826.2357319479457;831.7130589946489;862.5945805471418;864.3646919514152;864.8313578852126;865.5455885660048;866.1165611076698;860.0324634785866;862.3058437957442;862.3920136303891;863.218786997768;863.9265662418702;628.0704557255287;629.1003864473801;632.7374139732005;632.936706329368;633.3887798274641;13285.800712989312;13309.800352994713;13313.201207927556;13344.666383340396;14469.421223151061;11689.88946050124;12867.034972377109;12958.87041129586;13052.869471305356;13294.734105317937;9189.770255743593;9603.4718090505;9746.46394448305;9806.754831129207;9893.30746847721;3247.4804031355106;3253.6258330292085;3281.737461003114;3410;3410.9829450852835;61760.69119654373;62233;62646.37353626451;63945.84352017104;64140;10121.493925303705;10159.030858965933;10334.346504559235;10398.740031499121;10585.9470702646;18173.818261817214;18186.45440636783;18304.63390732178;18447.53881152982;18473.353432629792;6034.487068599218;6212.782552610637;6309.526785491106;6459.09572659828;6557.082008518812;3231.7091461768555;3316.336732653479;3371;3389.796612203276;3403.047146798851;2777.8333300002064;2848.957265641017;2872.482953068426;2878.2372671242138;2894.0449651614917;484.73339663185106;486.07160323782114;497.0878438066189;498.8229178641603;504.4778654092996;536.3992328592002;545.184948501992;548.7530611224885;607.2288193993692;641.8491654461197;8354.498730076215;8405.957970210233;8572.142785721378;8691.435056721293;9036.774080648036;514.6088972381017;520.4327283261188;528.2683483375553;594.6283572767021;653.5098675993005;4122.855700050483;4380.934285985712;4394.978025109918;4437.8224871004795;4439.66702497314;62437.69279611193;62634.373656262855;65253.67373163104;65313.02030469547;65875.67062164754;43246.56753432488;45834.54165458369;47560;48435.51564484381;56473.7176314124;49091.509084909405;49332.75333623309;49711.25433118506;49880.75059624751;50629.999999999265;8428.789280268042;8945.23965462917;9018.413803102778;9096.499692516974;9116.268911567264;34613.82693086519;35793.82103089572;35876;36054;36394.81802591076;43083.35374969315;43273.56726432696;44979.32531011972;46925.76537117293;46976.29535556901;9746.366486178376;9977.45124018157;9992.850107248543;10101.747456313356;10271.024252695983;11580.478878450322;11803.291802491534;11926.642200733992;11983.64049078529;12132.332721700039;11170.441477925908;11242.044426223863;11461.083113350745;11730.70673233176;11873.346965916957;11362.829557556477;11397.544098235978;11457.541698331974;12071.155019148926;12102.818457723317;11136.33182009082;11144.387058711849;11148.331100134017;11336.319820810777;11633.185677002866;8572.957135214285;9052.366334356531;9512.239020878174;9652.131308182297;9745.171660408661;9176.58705358247;9960.344182566405;9977.50112494358;10095.697129086138;10367.94816025915 16:04:15 INFO - PROCESS | 17744 | __end_tp_report 16:04:15 INFO - PROCESS | 17744 | __start_cc_report 16:04:15 INFO - PROCESS | 17744 | _x_x_mozilla_cycle_collect,331 16:04:15 INFO - PROCESS | 17744 | __end_cc_report 16:04:15 INFO - PROCESS | 17744 | __startTimestamp1483747455510__endTimestamp 16:04:15 INFO - PROCESS | 17744 | 16:04:15 INFO - PROCESS | 17744 | ------- Summary: start ------- 16:04:15 INFO - PROCESS | 17744 | Number of tests: 6 16:04:15 INFO - PROCESS | 17744 | 16:04:15 INFO - PROCESS | 17744 | [#0] dojo.html Cycles:165 Average:4697.88 Median:4817.45 stddev:494.74 (10.3%) stddev-sans-first:467.40 16:04:15 INFO - PROCESS | 17744 | Values: 2575.4 2581.9 2589.8 2600.0 2605.8 4621.3 4687.3 4699.1 4721.3 4790.6 4649.4 4698.1 4742.7 4759.6 4839.6 4343.6 4367.7 4387.0 4483.1 4510.9 4042.6 4482.3 4484.2 4507.2 4514.7 4289.8 4410.4 4425.5 4442.8 4518.2 4314.9 4331.9 4342.3 4380.9 4459.6 4370.0 4370.4 4377.4 4388.1 4403.6 4694.4 4749.2 4750.2 4799.1 4810.3 4966.0 5003.2 5016.8 5036.7 5051.7 5111.9 5118.4 5120.7 5123.4 5149.1 4754.9 4757.9 4759.8 4810.4 4854.7 5035.8 5035.8 5064.4 5141.1 5274.8 4886.9 4902.0 4933.0 4938.2 4947.5 4963.7 5011.2 5011.2 5014.6 5037.4 4917.2 4960.8 4962.7 4975.0 4987.1 5008.0 5008.1 5013.3 5019.5 5028.1 4333.5 4334.9 4344.3 4365.0 4371.1 3731.9 3739.9 3743.4 3745.1 3765.4 4410.3 4410.5 4459.4 4469.6 4474.6 5118.6 5168.7 5177.9 5181.5 5182.1 4282.3 4311.6 4371.1 4428.6 4447.4 4618.2 4619.4 4648.5 4656.0 4684.0 4774.4 4783.8 4783.8 4784.6 4829.4 4946.7 5146.7 5151.9 5153.5 5214.3 4647.4 4718.7 4726.5 4754.4 4839.8 5017.5 5021.6 5034.1 5037.9 5106.4 5016.8 5058.8 5071.8 5094.3 5120.9 4829.1 4991.4 4995.8 4996.4 4999.9 4910.1 4939.1 4969.4 4990.0 5081.8 4945.2 4945.7 4973.1 4978.2 4981.4 5057.6 5073.9 5076.4 5083.4 5086.5 4792.2 4817.4 4822.7 4872.2 4882.3 16:04:15 INFO - PROCESS | 17744 | 16:04:15 INFO - PROCESS | 17744 | [#1] ext.html Cycles:180 Average:39451.60 Median:3457.61 stddev:64751.76 (1872.7%) stddev-sans-first:64867.40 16:04:15 INFO - PROCESS | 17744 | Values: 514.7 519.2 522.3 528.1 529.2 39246.4 40146.2 40147.2 40227.2 44335.1 41698.8 42266.6 42278.8 42323.6 42381.4 7685.8 7847.6 7853.3 7923.5 9405.0 9490.7 9734.2 9769.4 9777.9 9779.7 9762.5 9808.2 9814.0 9823.3 9833.1 9719.5 9780.7 9795.8 9801.7 9804.3 9686.2 9724.2 9734.3 9743.4 9759.8 32615.2 32733.5 32902.2 32948.8 33046.8 3627.3 3672.1 3684.4 3726.0 3726.8 26241.9 26827.2 26862.2 27021.2 27148.9 3449.6 3465.6 3691.9 3692.8 3695.1 241587.0 241589.0 241610.0 242414.0 242739.8 47018.7 47109.5 47461.0 47522.0 47631.0 49188.3 49339.8 49465.0 49481.8 49521.3 13231.9 13298.5 13321.4 13327.9 13348.6 8789.4 8937.6 9539.9 9868.6 10669.7 15782.6 15796.2 15882.0 16040.2 16090.8 6388.5 6399.5 6464.9 6574.6 6744.6 774.6 780.7 781.4 788.8 800.7 26417.1 28112.0 28117.7 28336.1 28614.7 987.3 1006.5 1020.8 1029.7 1084.9 14242.4 14662.9 14764.6 14801.2 14826.8 130244.3 131833.0 132463.3 132629.3 132632.0 51385.0 52136.0 52144.2 52194.0 52398.0 1247.5 1270.4 1280.8 1287.2 1293.0 25631.0 26336.9 26862.3 27711.0 28005.0 42164.4 42665.6 43199.0 43228.0 43264.1 322067.0 325703.0 326793.0 327366.0 327558.0 21192.0 21533.5 23631.1 23955.4 23959.0 37724.2 37797.8 37858.6 40867.4 42145.0 32507.0 32773.0 32872.2 33051.7 33117.3 32327.7 33081.7 33161.0 33329.0 33666.3 31960.0 32107.8 32210.0 32922.5 33045.0 27650.3 28802.1 29839.7 30290.5 30338.5 22929.8 23069.9 23143.3 23454.8 23551.4 16:04:15 INFO - PROCESS | 17744 | 16:04:15 INFO - PROCESS | 17744 | [#2] jquery.html Cycles:180 Average:29650.08 Median:4252.78 stddev:89767.10 (2110.8%) stddev-sans-first:89991.98 16:04:15 INFO - PROCESS | 17744 | Values: 365.6 374.7 383.3 383.5 404.8 17714.0 18291.8 18454.2 18565.3 18589.2 18360.4 18487.3 18754.6 18800.0 18894.4 5115.9 5302.9 5325.6 5326.3 5329.9 5280.3 5529.9 5556.8 5662.7 5665.6 5644.5 5658.9 5663.0 5671.5 5717.3 6279.3 6315.9 6335.6 6346.5 6367.6 5460.6 5542.0 5579.6 5649.4 5670.7 12475.6 12563.1 17015.3 21499.4 21877.8 2284.4 2310.1 2311.3 2459.8 2497.6 9369.5 9373.2 9447.8 9814.6 9859.4 1729.6 1763.8 1792.5 1797.5 1798.3 66784.0 79029.6 80367.0 80637.2 81154.6 9737.6 9771.9 9839.5 10044.7 10435.9 12939.7 12959.3 12994.1 13087.8 13112.3 7364.7 7414.7 7527.7 7544.0 7712.1 7044.7 7172.5 7357.5 7371.9 7401.0 4064.3 4119.1 4231.2 4274.3 4298.6 1753.5 1777.6 1810.3 1818.3 1834.8 853.2 857.4 861.3 870.6 886.3 17837.8 18035.1 18082.4 18809.2 18871.5 861.2 879.2 890.3 894.6 895.2 9908.3 10218.7 10395.6 10411.0 10466.1 522440.0 539168.0 544123.0 555207.0 567517.0 69448.7 93572.5 96270.5 96958.5 98239.5 968.2 976.1 1009.9 1012.4 1017.4 16336.7 16574.4 16578.4 16599.3 17099.0 34297.3 37071.4 39221.6 39682.0 40126.2 52757.7 54062.2 54460.0 58318.8 59176.0 6932.0 7291.7 7536.2 7580.4 8117.1 10452.4 12933.6 12952.0 12978.9 13036.5 10434.9 10582.3 10718.4 10926.5 10937.2 10615.3 10846.2 11033.3 11056.0 11256.4 9757.5 10976.3 11209.0 11220.2 11222.7 7198.0 7520.4 7575.5 7647.5 7667.3 10158.0 11008.5 11049.8 11278.7 11582.2 16:04:15 INFO - PROCESS | 17744 | 16:04:15 INFO - PROCESS | 17744 | [#3] mootools.html Cycles:180 Average:4493.37 Median:5164.29 stddev:2344.64 (45.4%) stddev-sans-first:2338.77 16:04:15 INFO - PROCESS | 17744 | Values: 1278.2 1282.7 1283.8 1289.3 1299.1 6062.3 6295.2 6525.5 6893.4 6916.3 6444.2 6644.5 6701.2 6865.9 6919.1 2062.0 2105.1 2106.7 2109.8 2112.0 2067.5 2081.0 2116.0 2132.2 2153.7 2085.6 2104.1 2105.3 2108.2 2109.5 2118.5 2120.4 2121.1 2128.1 2128.9 2078.3 2092.8 2102.8 2119.1 2143.9 6879.6 6896.8 6898.4 6938.8 6944.7 4185.5 4281.9 4288.4 4290.8 4321.6 2639.7 2806.7 2839.2 2867.8 2890.6 1063.7 1094.2 1116.2 1175.5 1179.2 8693.5 8747.5 8806.0 8823.1 8865.4 3571.3 3741.9 3767.5 3810.1 3824.9 7039.8 7167.7 7208.9 7216.9 7237.4 4237.9 4263.8 4268.5 4286.2 4294.8 3758.1 3871.1 3920.3 3923.8 3927.5 3068.3 3102.1 3176.7 3180.7 3183.7 907.3 909.9 927.4 929.9 938.6 813.2 819.2 837.9 852.7 853.9 4637.2 4655.2 4677.9 4683.3 4769.8 871.7 884.6 889.3 894.8 912.4 3142.9 3218.7 3227.9 3292.9 3358.8 7890.4 8201.2 8232.4 8291.5 8306.5 8208.2 8230.6 8240.0 8240.9 8279.2 6268.2 6386.9 6404.8 6453.9 6464.6 4545.9 4630.7 4643.8 4645.1 4704.6 7418.1 7540.5 7543.2 7550.5 7611.5 7234.2 7400.7 7461.0 7580.5 7706.9 5869.4 5950.5 5974.6 5980.9 5983.9 6319.8 6349.1 6367.9 6385.7 6390.8 5786.6 5857.0 5944.6 5953.0 6040.6 5747.2 5749.5 5780.6 5798.3 5839.0 5106.5 5222.1 5225.1 5225.4 5236.8 4031.9 4100.8 4187.2 4197.0 4233.1 4055.2 4124.8 4130.1 4175.9 4263.4 16:04:15 INFO - PROCESS | 17744 | 16:04:15 INFO - PROCESS | 17744 | [#4] prototype.html Cycles:180 Average:4277.73 Median:4859.44 stddev:1243.52 (25.6%) stddev-sans-first:1211.53 16:04:15 INFO - PROCESS | 17744 | Values: 348.5 350.2 350.6 352.4 360.7 5018.9 5049.2 5072.6 5072.8 5105.5 5002.0 5007.9 5018.0 5035.4 5038.0 3553.2 3780.6 3875.9 3880.1 4083.7 3873.7 3886.9 3888.3 3888.6 3899.8 3851.0 3868.0 3870.5 3875.3 3885.3 3849.2 3862.7 3866.3 3878.9 3884.6 3221.3 3362.6 3374.1 3378.9 3393.7 4843.3 4854.3 4887.5 4914.2 4915.6 4399.5 4409.6 4447.9 4456.4 4469.0 5039.5 5046.6 5170.9 5188.5 5232.0 3682.4 3704.5 3713.3 3719.6 3722.1 5160.7 5443.3 5454.8 5486.8 5492.9 3638.9 3643.5 3708.4 3713.4 3733.2 3773.4 3775.8 3790.4 3794.0 3796.7 4339.6 4343.8 4410.5 4414.4 4416.4 5131.9 5140.7 5141.0 5182.2 5285.8 1256.5 1272.4 1272.9 1275.7 1278.5 824.1 855.2 867.2 870.8 873.0 4469.3 4469.6 4481.7 4499.3 4501.4 5154.4 5183.4 5221.9 5222.6 5228.4 4280.8 4409.6 4412.6 4423.8 4429.8 2737.8 2742.6 2763.9 2774.8 2792.7 4834.2 4865.2 4866.6 4897.7 4912.3 5040.3 5315.4 5352.3 5368.7 5395.8 4801.0 4841.3 4852.3 4857.5 4861.4 5203.7 5221.8 5223.7 5225.9 5247.9 5018.8 5038.6 5100.7 5152.1 5156.4 4818.4 4828.8 4830.8 4843.9 4864.4 3735.2 3776.2 3777.5 3791.9 3793.4 5347.5 5352.5 5356.9 5368.9 5377.7 4934.9 5189.5 5212.4 5221.4 5241.9 5178.6 5181.9 5182.3 5193.6 5203.6 5152.8 5160.9 5177.8 5190.4 5204.6 5002.6 5226.2 5234.1 5245.6 5253.2 5141.3 5152.4 5162.8 5165.9 5173.3 16:04:15 INFO - PROCESS | 17744 | 16:04:15 INFO - PROCESS | 17744 | [#5] yui.html Cycles:180 Average:14361.08 Median:49212.13 stddev:17626.20 (35.8%) stddev-sans-first:17645.24 16:04:15 INFO - PROCESS | 17744 | Values: 575.0 587.1 708.1 761.4 785.6 12519.4 13582.7 13752.3 13842.4 13869.3 13131.7 13135.6 13199.5 13240.9 13245.9 800.0 819.4 822.5 823.2 824.1 790.5 822.0 825.3 826.2 831.7 862.6 864.4 864.8 865.5 866.1 860.0 862.3 862.4 863.2 863.9 628.1 629.1 632.7 632.9 633.4 13285.8 13309.8 13313.2 13344.7 14469.4 11689.9 12867.0 12958.9 13052.9 13294.7 9189.8 9603.5 9746.5 9806.8 9893.3 3247.5 3253.6 3281.7 3410.0 3411.0 61760.7 62233.0 62646.4 63945.8 64140.0 10121.5 10159.0 10334.3 10398.7 10585.9 18173.8 18186.5 18304.6 18447.5 18473.4 6034.5 6212.8 6309.5 6459.1 6557.1 3231.7 3316.3 3371.0 3389.8 3403.0 2777.8 2849.0 2872.5 2878.2 2894.0 484.7 486.1 497.1 498.8 504.5 536.4 545.2 548.8 607.2 641.8 8354.5 8406.0 8572.1 8691.4 9036.8 514.6 520.4 528.3 594.6 653.5 4122.9 4380.9 4395.0 4437.8 4439.7 62437.7 62634.4 65253.7 65313.0 65875.7 43246.6 45834.5 47560.0 48435.5 56473.7 49091.5 49332.8 49711.3 49880.8 50630.0 8428.8 8945.2 9018.4 9096.5 9116.3 34613.8 35793.8 35876.0 36054.0 36394.8 43083.4 43273.6 44979.3 46925.8 46976.3 9746.4 9977.5 9992.9 10101.7 10271.0 11580.5 11803.3 11926.6 11983.6 12132.3 11170.4 11242.0 11461.1 11730.7 11873.3 11362.8 11397.5 11457.5 12071.2 12102.8 11136.3 11144.4 11148.3 11336.3 11633.2 8573.0 9052.4 9512.2 9652.1 9745.2 9176.6 9960.3 9977.5 10095.7 10367.9 16:04:15 INFO - PROCESS | 17744 | -------- Summary: end -------- 16:04:15 INFO - PROCESS | 17744 | 16:04:16 INFO - TEST-INFO | 17744: exit 0 16:04:16 INFO - TEST-OK | dromaeo_css | took 1119486ms 16:04:16 INFO - TEST-START | kraken 16:04:16 INFO - operating with platform_type : linux_ 16:04:16 INFO - Initialising browser for kraken test... 16:04:16 INFO - TEST-INFO | started process 18090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEdpUMM/profile http://localhost:53184/getInfo.html) 16:04:16 INFO - PROCESS | 18090 | 1483747456845 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 16:04:20 INFO - PROCESS | 18090 | __metrics Screen width/height:1600/1200 16:04:20 INFO - PROCESS | 18090 | colorDepth:24 16:04:20 INFO - PROCESS | 18090 | Browser inner width/height: 1024/697 16:04:20 INFO - PROCESS | 18090 | __metrics 16:04:21 ERROR - PROCESS | 18090 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 16:04:22 INFO - TEST-INFO | 18090: exit 0 16:04:22 INFO - Browser initialized. 16:04:22 INFO - Running cycle 1/1 for kraken test... 16:04:22 INFO - TEST-INFO | started process 18212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEdpUMM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:04:34 INFO - PROCESS | 18212 | RSS: Main: 158875648 16:04:34 INFO - PROCESS | 18212 | 16:04:37 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:53184/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53184/tests/kraken/driver.html?testName=audio-beat-detection) 16:04:38 INFO - PROCESS | 18212 | RSS: Main: 164634624 16:04:38 INFO - PROCESS | 18212 | 16:04:41 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:53184/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53184/tests/kraken/driver.html?testName=audio-dft) 16:04:41 INFO - PROCESS | 18212 | RSS: Main: 163880960 16:04:41 INFO - PROCESS | 18212 | 16:04:44 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:53184/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53184/tests/kraken/driver.html?testName=audio-fft) 16:04:45 INFO - PROCESS | 18212 | RSS: Main: 160210944 16:04:45 INFO - PROCESS | 18212 | 16:04:47 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:53184/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53184/tests/kraken/driver.html?testName=audio-oscillator) 16:04:48 INFO - PROCESS | 18212 | RSS: Main: 160997376 16:04:48 INFO - PROCESS | 18212 | 16:04:50 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:53184/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53184/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:04:50 INFO - PROCESS | 18212 | RSS: Main: 161034240 16:04:50 INFO - PROCESS | 18212 | 16:04:54 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:53184/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53184/tests/kraken/driver.html?testName=imaging-darkroom) 16:04:54 INFO - PROCESS | 18212 | RSS: Main: 166133760 16:04:54 INFO - PROCESS | 18212 | 16:04:58 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:53184/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53184/tests/kraken/driver.html?testName=imaging-desaturate) 16:04:58 INFO - PROCESS | 18212 | RSS: Main: 162119680 16:04:58 INFO - PROCESS | 18212 | 16:05:01 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:53184/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53184/tests/kraken/driver.html?testName=json-parse-financial) 16:05:02 INFO - PROCESS | 18212 | RSS: Main: 163405824 16:05:02 INFO - PROCESS | 18212 | 16:05:04 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:53184/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53184/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:05:04 INFO - PROCESS | 18212 | RSS: Main: 163688448 16:05:04 INFO - PROCESS | 18212 | 16:05:06 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:53184/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53184/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:05:07 INFO - PROCESS | 18212 | RSS: Main: 163614720 16:05:07 INFO - PROCESS | 18212 | 16:05:09 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:53184/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53184/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:05:10 INFO - PROCESS | 18212 | RSS: Main: 163946496 16:05:10 INFO - PROCESS | 18212 | 16:05:12 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:53184/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53184/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:05:13 INFO - PROCESS | 18212 | RSS: Main: 164155392 16:05:13 INFO - PROCESS | 18212 | 16:05:16 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:53184/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53184/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:05:17 INFO - PROCESS | 18212 | RSS: Main: 163790848 16:05:17 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | Cycle 1(1): loaded http://localhost:53184/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53184/tests/kraken/driver.html?testName=ai-astar) 16:05:19 INFO - PROCESS | 18212 | RSS: Main: 166158336 16:05:19 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | __start_tp_report 16:05:19 INFO - PROCESS | 18212 | _x_x_mozilla_page_load 16:05:19 INFO - PROCESS | 18212 | _x_x_mozilla_page_load_details 16:05:19 INFO - PROCESS | 18212 | |i|pagename|runs| 16:05:19 INFO - PROCESS | 18212 | |0;ai-astar;108;117;115;116;115;115;116;116;116;120 16:05:19 INFO - PROCESS | 18212 | |1;audio-beat-detection;153;124;132;169;127;128;127;125;153;130 16:05:19 INFO - PROCESS | 18212 | |2;audio-dft;165;166;169;168;164;165;164;166;163;165 16:05:19 INFO - PROCESS | 18212 | |3;audio-fft;76;78;76;119;76;77;77;77;95;77 16:05:19 INFO - PROCESS | 18212 | |4;audio-oscillator;84;85;115;85;86;96;103;89;87;110 16:05:19 INFO - PROCESS | 18212 | |5;imaging-gaussian-blur;119;118;117;118;118;122;118;119;119;119 16:05:19 INFO - PROCESS | 18212 | |6;imaging-darkroom;152;149;153;150;153;152;150;152;150;153 16:05:19 INFO - PROCESS | 18212 | |7;imaging-desaturate;96;96;96;97;97;97;96;95;95;95 16:05:19 INFO - PROCESS | 18212 | |8;json-parse-financial;65;65;65;64;65;65;65;64;66;66 16:05:19 INFO - PROCESS | 18212 | |9;json-stringify-tinderbox;67;69;67;67;67;67;68;70;68;67 16:05:19 INFO - PROCESS | 18212 | |10;stanford-crypto-aes;84;85;86;87;85;85;87;89;90;87 16:05:19 INFO - PROCESS | 18212 | |11;stanford-crypto-ccm;149;136;138;142;134;135;134;147;182;142 16:05:19 INFO - PROCESS | 18212 | |12;stanford-crypto-pbkdf2;180;180;179;182;188;176;175;178;181;185 16:05:19 INFO - PROCESS | 18212 | |13;stanford-crypto-sha256-iterative;70;72;68;71;70;69;68;68;68;68 16:05:19 INFO - PROCESS | 18212 | __end_tp_report 16:05:19 INFO - PROCESS | 18212 | __start_cc_report 16:05:19 INFO - PROCESS | 18212 | _x_x_mozilla_cycle_collect,797 16:05:19 INFO - PROCESS | 18212 | __end_cc_report 16:05:19 INFO - PROCESS | 18212 | __startTimestamp1483747519395__endTimestamp 16:05:19 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | ------- Summary: start ------- 16:05:19 INFO - PROCESS | 18212 | Number of tests: 14 16:05:19 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.00 stddev:2.99 (2.6%) stddev-sans-first:1.56 16:05:19 INFO - PROCESS | 18212 | Values: 108.0 117.0 115.0 116.0 115.0 115.0 116.0 116.0 116.0 120.0 16:05:19 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:131.00 stddev:15.65 (11.9%) stddev-sans-first:15.46 16:05:19 INFO - PROCESS | 18212 | Values: 153.0 124.0 132.0 169.0 127.0 128.0 127.0 125.0 153.0 130.0 16:05:19 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.50 stddev:1.84 (1.1%) stddev-sans-first:1.94 16:05:19 INFO - PROCESS | 18212 | Values: 165.0 166.0 169.0 168.0 164.0 165.0 164.0 166.0 163.0 165.0 16:05:19 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | [#3] audio-fft Cycles:10 Average:82.80 Median:77.00 stddev:13.97 (18.1%) stddev-sans-first:14.60 16:05:19 INFO - PROCESS | 18212 | Values: 76.0 78.0 76.0 119.0 76.0 77.0 77.0 77.0 95.0 77.0 16:05:19 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:85.50 stddev:11.46 (13.4%) stddev-sans-first:11.57 16:05:19 INFO - PROCESS | 18212 | Values: 84.0 85.0 115.0 85.0 86.0 96.0 103.0 89.0 87.0 110.0 16:05:19 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:119.00 stddev:1.34 (1.1%) stddev-sans-first:1.41 16:05:19 INFO - PROCESS | 18212 | Values: 119.0 118.0 117.0 118.0 118.0 122.0 118.0 119.0 119.0 119.0 16:05:19 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:152.00 stddev:1.51 (1.0%) stddev-sans-first:1.58 16:05:19 INFO - PROCESS | 18212 | Values: 152.0 149.0 153.0 150.0 153.0 152.0 150.0 152.0 150.0 153.0 16:05:19 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 16:05:19 INFO - PROCESS | 18212 | Values: 96.0 96.0 96.0 97.0 97.0 97.0 96.0 95.0 95.0 95.0 16:05:19 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 16:05:19 INFO - PROCESS | 18212 | Values: 65.0 65.0 65.0 64.0 65.0 65.0 65.0 64.0 66.0 66.0 16:05:19 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.50 stddev:1.06 (1.6%) stddev-sans-first:1.09 16:05:19 INFO - PROCESS | 18212 | Values: 67.0 69.0 67.0 67.0 67.0 67.0 68.0 70.0 68.0 67.0 16:05:19 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:87.00 stddev:1.90 (2.2%) stddev-sans-first:1.79 16:05:19 INFO - PROCESS | 18212 | Values: 84.0 85.0 86.0 87.0 85.0 85.0 87.0 89.0 90.0 87.0 16:05:19 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:142.00 stddev:14.40 (10.1%) stddev-sans-first:15.16 16:05:19 INFO - PROCESS | 18212 | Values: 149.0 136.0 138.0 142.0 134.0 135.0 134.0 147.0 182.0 142.0 16:05:19 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:180.50 stddev:3.92 (2.2%) stddev-sans-first:4.16 16:05:19 INFO - PROCESS | 18212 | Values: 180.0 180.0 179.0 182.0 188.0 176.0 175.0 178.0 181.0 185.0 16:05:19 INFO - PROCESS | 18212 | 16:05:19 INFO - PROCESS | 18212 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.48 (2.1%) stddev-sans-first:1.54 16:05:19 INFO - PROCESS | 18212 | Values: 70.0 72.0 68.0 71.0 70.0 69.0 68.0 68.0 68.0 68.0 16:05:19 INFO - PROCESS | 18212 | -------- Summary: end -------- 16:05:19 INFO - PROCESS | 18212 | 16:05:20 INFO - TEST-INFO | 18212: exit 0 16:05:20 INFO - TEST-OK | kraken | took 64234ms 16:05:20 INFO - SUITE-END | took 1183s 16:05:20 INFO - Completed test suite (00:19:43) 16:05:20 INFO - javascript benchmark 16:05:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6276.656549516016, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2575.433404650976, 2581.9483610327793, 2589.844609323442, 2600.0379859452, 2605.7654811067, 4621.283701026337, 4687.320338550908, 4699.130660827749, 4721.26820342847, 4790.568848803607, 4649.418822647169, 4698.130845793522, 4742.739149346785, 4759.595434388072, 4839.56443920048, 4343.565643435655, 4367.694261401703, 4387.034852332482, 4483.14820184164, 4510.864674059783, 4042.6361627453525, 4482.305242687388, 4484.23767959446, 4507.188706032913, 4514.706544074625, 4289.828406863721, 4410.448693913261, 4425.468943726742, 4442.822287108512, 4518.209313370147, 4314.892127696801, 4331.891702707426, 4342.261815491374, 4380.868573942755, 4459.576340247671, 4370.0, 4370.388145659578, 4377.430933978562, 4388.078503514266, 4403.581659742352, 4694.389729335165, 4749.192637251641, 4750.168720473903, 4799.064182484417, 4810.302506136625, 4966.0, 5003.249512573107, 5016.799328026875, 5036.722980236085, 5051.722155281494, 5111.923321150186, 5118.436971933084, 5120.718360490171, 5123.359580052494, 5149.0731668299695, 4754.904901902012, 4757.904841903142, 4759.762011899391, 4810.39870016248, 4854.708717476963, 5035.773390197377, 5035.84892453227, 5064.392272927273, 5141.100307446182, 5274.841754747364, 4886.926696099561, 4902.044101400193, 4933.0, 4938.185199442052, 4947.505249475023, 4963.677360971597, 5011.198208286657, 5011.248312753116, 5014.623903207274, 5037.370328708911, 4917.188663870493, 4960.751962401865, 4962.727050012284, 4975.0, 4987.102321582078, 5008.0, 5008.073506401327, 5013.323201367842, 5019.52314530119, 5028.120078986163, 4333.523312435629, 4334.913301733947, 4344.326629372453, 4365.0, 4371.12577484498, 3731.8880433587037, 3739.9252014959548, 3743.4384842273876, 3745.1198968242443, 3765.359888818907, 4410.316400957857, 4410.536893626123, 4459.397981272552, 4469.597736203757, 4474.597286244189, 5118.564921981673, 5168.715720635401, 5177.922331165036, 5181.481851814789, 5182.093133701587, 4282.336237883133, 4311.633511151587, 4371.060222052274, 4428.623566996777, 4447.355133505624, 4618.168729628632, 4619.422572178478, 4648.5119062498625, 4656.045510670305, 4683.976580117078, 4774.427068751772, 4783.784729687103, 4783.808647654194, 4784.617230621472, 4829.420469543607, 4946.703197808143, 5146.69119852795, 5151.922721159261, 5153.5361817436615, 5214.2960700304975, 4647.3726046984575, 4718.693284936468, 4726.503717109654, 4754.405699287589, 4839.758012099452, 5017.4731653175895, 5021.573166280907, 5034.0686972910125, 5037.924431133462, 5106.412762532356, 5016.799328026838, 5058.848234552969, 5071.77177027042, 5094.2867998479505, 5120.871978200575, 4829.082474329866, 4991.351124353956, 4995.8001679932395, 4996.400431948189, 4999.900002000012, 4910.116179087799, 4939.135651261086, 4969.378827646544, 4990.026944745885, 5081.7713202905215, 4945.23348880924, 4945.653804233669, 4973.104841128632, 4978.228374601942, 4981.37732783402, 5057.570106540985, 5073.92389114171, 5076.416212135504, 5083.38999320084, 5086.516552074208, 4792.233242681294, 4817.445993710769, 4822.662413631012, 4872.220444728827, 4882.267659850909], "value": 4665.570594045385, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.7143335448826, 519.1589624807809, 522.3444577055797, 528.1206790693495, 529.1507131054658, 39246.41130383043, 40146.197076058495, 40147.19705605886, 40227.19545609086, 44335.113297734024, 41698.7915060425, 42266.57733422665, 42278.78860605693, 42323.57676423235, 42381.36427953575, 7685.846283074349, 7847.607619619025, 7853.2539408756365, 7923.524588524707, 9404.952975235114, 9490.66782662607, 9734.172595329406, 9769.364991275579, 9777.853332200022, 9779.706608801747, 9762.463064531448, 9808.16630586401, 9814.0, 9823.263255255848, 9833.065858743445, 9719.514024298756, 9780.657676981342, 9795.804083918352, 9801.656942006995, 9804.264680149017, 9686.176674982635, 9724.222062235074, 9734.318597698164, 9743.415395076318, 9759.756006099833, 32615.184620384443, 32733.508997365057, 32902.177445564055, 32948.83525582357, 33046.83476582626, 3627.2564124354444, 3672.100335417813, 3684.4104943209227, 3726.0, 3726.8322925468146, 26241.868790656117, 26827.195184144508, 26862.19413417581, 27021.189364319103, 27148.864255678793, 3449.586049674055, 3465.6361082086523, 3691.907702307437, 3692.7599706019023, 3695.0947017980766, 241587.0, 241589.0, 241610.0, 242414.0, 242739.78630106914, 47018.712099624616, 47109.52890471051, 47461.0, 47522.0, 47631.0, 49188.26217606739, 49339.753301233985, 49465.0, 49481.752591236815, 49521.25718114231, 13231.933840330737, 13298.534551290852, 13321.40053697586, 13327.866721332857, 13348.599542013755, 8789.384743068053, 8937.597808098652, 9539.904600953902, 9868.605255789831, 10669.679909602724, 15782.605434864221, 15796.21018949071, 15882.047077175175, 16040.197990100449, 16090.75863862043, 6388.520860935449, 6399.520035997319, 6464.903026454607, 6574.6055236685, 6744.5616034957575, 774.5894675821824, 780.7072347869549, 781.4022272961189, 788.7830846517254, 800.7317548621161, 26417.075402360824, 28112.0, 28117.71882281192, 28336.149915502567, 28614.713852861205, 987.3088837813559, 1006.5118417567473, 1020.8366661334151, 1029.6602121299952, 1084.902358787697, 14242.359093840802, 14662.926685366505, 14764.557063288119, 14801.185934773475, 14826.777598336033, 130244.3487782555, 131833.0, 132463.33768331097, 132629.33685331512, 132632.0, 51385.0, 52136.0, 52144.21783673248, 52194.0, 52398.0, 1247.5134697467995, 1270.4410059573759, 1280.7950727883494, 1287.2212311551564, 1293.0173068468032, 25631.0, 26336.8683156583, 26862.328441789112, 27711.0, 28005.0, 42164.36753448762, 42665.57334426616, 43199.0, 43228.0, 43264.13471730485, 322067.0, 325703.0, 326793.0, 327366.0, 327558.0, 21192.0, 21533.46166345854, 23631.109511238716, 23955.401114972265, 23959.0, 37724.245515088995, 37797.811010944766, 37858.62141378551, 40867.386989194594, 42145.0, 32507.0, 32773.0, 32872.178195545304, 33051.66948330486, 33117.33765324728, 32327.676723232467, 33081.66918330882, 33161.0, 33329.0, 33666.31668416618, 31960.0, 32107.83946080255, 32210.0, 32922.5061624071, 33045.0, 27650.308742281602, 28802.135935921116, 29839.701602983692, 30290.545641815832, 30338.54492182575, 22929.77070229343, 23069.88465057664, 23143.305700829, 23454.76545234526, 23551.41121471977], "value": 16827.809401089362, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.5686290177591, 374.68339253330925, 383.2909118131456, 383.5474140514193, 404.8239016028028, 17713.999999999985, 18291.817081829176, 18454.16956236971, 18565.257389704428, 18589.163487643054, 18360.44918652439, 18487.260509579635, 18754.624907501842, 18800.0, 18894.433167004976, 5115.897682046366, 5302.867428314285, 5325.627206095575, 5326.3075800145925, 5329.920051199235, 5280.313559237294, 5529.917051244214, 5556.833295001156, 5662.6602403855695, 5665.603407761459, 5644.520215781664, 5658.858528536778, 5663.037283661787, 5671.517920976722, 5717.285339332583, 6279.340669229734, 6315.905261421082, 6335.619862808223, 6346.460550853183, 6367.61794292344, 5460.645058071213, 5542.002439560877, 5579.637323573955, 5649.378568357477, 5670.68811215383, 12475.625731228078, 12563.057770667236, 17015.319387224496, 21499.355019349445, 21877.781222187892, 2284.371797755614, 2310.1336998625516, 2311.28350211435, 2459.7909177719916, 2497.625356196567, 9369.48467834269, 9373.203277721403, 9447.763805904839, 9814.607415703364, 9859.359141655841, 1729.6281299520538, 1763.8147994460653, 1792.5339411752907, 1797.4967009237434, 1798.2716999615177, 66784.0, 79029.60485197595, 80367.0, 80637.19362806356, 81154.59422702908, 9737.610495580238, 9771.9022809771, 9839.508024598885, 10044.698659040241, 10435.94782026085, 12939.676508087374, 12959.287239201745, 12994.090413671142, 13087.803682944763, 13112.344382780822, 7364.668589913466, 7414.740484083031, 7527.736529221451, 7544.0192774938905, 7712.074551053797, 7044.718211271595, 7172.533785303938, 7357.484976051732, 7371.9262807372315, 7401.0, 4064.349704047338, 4119.0937993641355, 4231.2440337260305, 4274.316109422478, 4298.63461605767, 1753.5440785395888, 1777.626698393352, 1810.2939853457162, 1818.2726909236412, 1834.8440382567364, 853.2193043365376, 857.4255248983071, 861.3195575495289, 870.6430363551041, 886.3308202307217, 17837.821621783874, 18035.098245087956, 18082.3671171511, 18809.153588088568, 18871.52821179454, 861.2335021830576, 879.1867522541623, 890.2655309369795, 894.5706061090713, 895.1987970766259, 9908.25688073383, 10218.744531386626, 10395.58417663285, 10410.95890410968, 10466.110380617733, 522440.0, 539168.0, 544123.0, 555207.0, 567517.0, 69448.65275673589, 93572.53213733887, 96270.51864740631, 96958.51520742351, 98239.50880245553, 968.2399316536485, 976.0873583199731, 1009.9242556808268, 1012.4380968562372, 1017.3590637898077, 16336.67326653484, 16574.419895303607, 16578.419755308507, 16599.3360265588, 17099.00767365681, 34297.314053718284, 37071.443928341636, 39221.6077839218, 39682.0, 40126.1974760509, 52757.7362113187, 54062.189067164814, 54460.0, 58318.83362332645, 59176.0, 6931.965340173267, 7291.671874765754, 7536.171021187555, 7580.431467639839, 8117.066537348281, 10452.425116618355, 12933.61199163989, 12952.0, 12978.870211297766, 13036.47854085826, 10434.947825260826, 10582.259241852997, 10718.35689858611, 10926.50830712604, 10937.234393592373, 10615.31000484966, 10846.240763146505, 11033.282836615594, 11055.954648390074, 11256.380899050631, 9757.512124393894, 10976.341419514854, 11209.0, 11220.2145849793, 11222.66332010041, 7197.956296337106, 7520.398368130646, 7575.46971711997, 7647.476332810271, 7667.3099421052375, 10158.0, 11008.504617292401, 11049.779004419706, 11278.661640150809, 11582.189246752647], "value": 8654.096709318737, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.207511342967, 1282.7049778550934, 1283.8074288856676, 1289.2715615677148, 1299.1036185032324, 6062.302835173957, 6295.244570651528, 6525.477961763059, 6893.414059804916, 6916.273791251915, 6444.162258906347, 6644.501662375329, 6701.195856497227, 6865.931340686591, 6919.135108111486, 2061.9793802061977, 2105.0737675422765, 2106.715593394895, 2109.841761867858, 2111.9894400527974, 2067.472794437424, 2081.0, 2116.0, 2132.2430537159316, 2153.655415133579, 2085.551606404623, 2104.1478201328487, 2105.2526353144644, 2108.20942146695, 2109.504266497372, 2118.54451292972, 2120.4380839077658, 2121.140937920145, 2128.1061953979365, 2128.8935553222277, 2078.324544523021, 2092.79072092791, 2102.842286828494, 2119.1311562259552, 2143.9356819295444, 6879.58722476648, 6896.7586134485555, 6898.413634840995, 6938.826529336757, 6944.72221111155, 4185.518665353493, 4281.850135245251, 4288.399624052635, 4290.849820256276, 4321.567843215685, 2639.736026397364, 2806.733360330765, 2839.2050225936564, 2867.813592116506, 2890.624218851557, 1063.6649455421518, 1094.1574987259764, 1116.2298014370058, 1175.5356634129557, 1179.168686076314, 8693.5218562979, 8747.475151490931, 8806.0, 8823.073577274357, 8865.379423440361, 3571.321448924696, 3741.9335489385394, 3767.4913886624954, 3810.1046254130256, 3824.8852534424013, 7039.753608623673, 7167.677454514559, 7208.855822883618, 7216.9278307216255, 7237.384822290164, 4237.851675191415, 4263.8487608346195, 4268.487781466182, 4286.2284788738325, 4294.806733696991, 3758.0792705787258, 3871.090293780959, 3920.255151521259, 3923.7841918694744, 3927.5483319418063, 3068.2942923127807, 3102.100390886618, 3176.682331766851, 3180.6501284858646, 3183.6657150999276, 907.2651152566442, 909.9499527525917, 927.434265098303, 929.9349045566745, 938.5776400619749, 813.158381075584, 819.2422009641177, 837.9335588927864, 852.7464626998426, 853.9231469167805, 4637.211674015425, 4655.23188673865, 4677.8773094457765, 4683.344331793552, 4769.809207631656, 871.7297637732323, 884.6196135661727, 889.3330002498126, 894.789724414762, 912.3750231091591, 3142.8899988500293, 3218.726408255278, 3227.8547465363645, 3292.8518216679827, 3358.7816791908936, 7890.368770498347, 8201.22088401601, 8232.382571307176, 8291.543965081857, 8306.501609903304, 8208.179182081743, 8230.62962166704, 8239.95880020596, 8240.928679271776, 8279.213474719892, 6268.153799237045, 6386.9361306386345, 6404.775832845828, 6453.870922581522, 6464.612123272619, 4545.863624091283, 4630.72215667061, 4643.814247430065, 4645.094206629675, 4704.553067458586, 7418.072740907387, 7540.509866858637, 7543.245675432413, 7550.5469671819865, 7611.505252158592, 7234.240404757636, 7400.740974065882, 7460.962695186489, 7580.54516728998, 7706.922930770845, 5869.413058694096, 5950.494207992369, 5974.581779275409, 5980.8803823924145, 5983.850403739942, 6319.778807741707, 6349.111124442489, 6367.936320636734, 6385.680715964276, 6390.776322828865, 5786.623869448641, 5856.970715146567, 5944.554158438048, 5952.970235148797, 6040.607360521552, 5747.166660834239, 5749.482546570829, 5780.566457515787, 5798.275215598051, 5838.970805146117, 5106.4893510648635, 5222.086134926297, 5225.1378522543355, 5225.372955245395, 5236.764345604381, 4031.8992025199605, 4100.835966561423, 4187.225363307798, 4197.0, 4233.111046680232, 4055.209234199303, 4124.835006599822, 4130.050088479727, 4175.874723758292, 4263.403123562765], "value": 3726.777949526623, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.47728407388934, 350.2329897524421, 350.6475991628413, 352.36925902634283, 360.70782666040503, 5018.874528136794, 5049.24261360796, 5072.619553533481, 5072.8478145655645, 5105.540501354877, 5001.974990125053, 5007.921712489313, 5017.974910125445, 5035.395752509695, 5038.0, 3553.236054248336, 3780.60303668115, 3875.9031024224337, 3880.1463677990937, 4083.6937229707814, 3873.748206366577, 3886.9028274293087, 3888.3389823730035, 3888.572257051722, 3899.78551179685, 3850.9807450962844, 3868.0, 3870.4581358609817, 3875.2755024014323, 3885.261800257956, 3849.2109117630816, 3862.6523612874835, 3866.284737323604, 3878.8836334909715, 3884.553276373211, 3221.3074189049466, 3362.6132994705677, 3374.0889959710985, 3378.915527111842, 3393.745469089828, 4843.2735089736825, 4854.320395144682, 4887.511248875119, 4914.164592019365, 4915.631327650441, 4399.538048504893, 4409.559044095597, 4447.888802779924, 4456.3538286948215, 4468.977655111737, 5039.521245481674, 5046.595838999043, 5170.896582068338, 5188.533032027098, 5232.0, 3682.410814269731, 3704.481372607837, 3713.3130370881204, 3719.5536535615897, 3722.1439069014277, 5160.709822544364, 5443.292371991616, 5454.836354909319, 5486.753096110685, 5492.912693176608, 3638.872639457606, 3643.5263415756312, 3708.369577171887, 3713.442983552489, 3733.2160246348026, 3773.415120656303, 3775.7734535927934, 3790.3556395412847, 3793.981030094832, 3796.734228603971, 4339.609435150852, 4343.763895897513, 4410.514843367227, 4414.448193975753, 4416.4258646375765, 5131.897362052738, 5140.691558506502, 5141.0, 5182.170852663556, 5285.762140703678, 1256.5288016993627, 1272.351100938528, 1272.8981681465461, 1275.7065874848836, 1278.4566559212299, 824.1058451579983, 855.2046596665036, 867.2324992381788, 870.8214815962839, 872.9742552500786, 4469.329600559877, 4469.553044695569, 4481.663875209372, 4499.302608095751, 4501.392312037899, 5154.3919256520585, 5183.403908550489, 5221.869453263623, 5222.582193424517, 5228.424873263938, 4280.785960701953, 4409.581089796464, 4412.580804823537, 4423.845165419195, 4429.844955426544, 2737.7809775217934, 2742.6434563507014, 2763.903263385772, 2774.8196367236064, 2792.6509186351705, 4834.20235661119, 4865.245886887538, 4866.586340161126, 4897.730624815598, 4912.287718280829, 5040.31955685985, 5315.441878602768, 5352.33365144877, 5368.651037682538, 5395.838124856261, 4800.999375390381, 4841.305543059972, 4852.296417019513, 4857.465678775332, 4861.416630004422, 5203.739813009259, 5221.762507245532, 5223.712695801767, 5225.895482090413, 5247.895042099213, 5018.774155162953, 5038.571721403721, 5100.69395836251, 5152.119476391165, 5156.4327923927585, 4818.445878723992, 4828.782704778223, 4830.7826147824135, 4843.854684359475, 4864.440589332272, 3735.1782607826235, 3776.2258736958306, 3777.54669439669, 3791.914447054054, 3793.412021136728, 5347.50278411716, 5352.5450336721815, 5356.946430535645, 5368.919466208088, 5377.704226267437, 4934.876628084183, 5189.506996835295, 5212.426633070435, 5221.407470721467, 5241.895162096813, 5178.6374953752875, 5181.948180518147, 5182.300389447376, 5193.636445448782, 5203.635745497779, 5152.793888244429, 5160.896782064413, 5177.8187763429605, 5190.351206099238, 5204.557612602971, 5002.624803139852, 5226.151747297656, 5234.0633965433035, 5245.606579506629, 5253.212018197301, 5141.28022076917, 5152.398038990435, 5162.793488260578, 5165.896682066413, 5173.28402588644], "value": 3892.455985093397, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.9540036797057, 587.1486344800036, 708.0794966543492, 761.4137114421895, 785.6150486261731, 12519.436625351858, 13582.660433489144, 13752.312384380792, 13842.446302147915, 13869.306534673276, 13131.737365252713, 13135.605931822061, 13199.538016169412, 13240.933795331033, 13245.93377033116, 799.9520028798262, 819.3772732723114, 822.5147163173726, 823.2426167925523, 824.0646865807322, 790.498033748571, 821.979450513736, 825.3438516379492, 826.2357319479457, 831.7130589946489, 862.5945805471418, 864.3646919514152, 864.8313578852126, 865.5455885660048, 866.1165611076698, 860.0324634785866, 862.3058437957442, 862.3920136303891, 863.218786997768, 863.9265662418702, 628.0704557255287, 629.1003864473801, 632.7374139732005, 632.936706329368, 633.3887798274641, 13285.800712989312, 13309.800352994713, 13313.201207927556, 13344.666383340396, 14469.421223151061, 11689.88946050124, 12867.034972377109, 12958.87041129586, 13052.869471305356, 13294.734105317937, 9189.770255743593, 9603.4718090505, 9746.46394448305, 9806.754831129207, 9893.30746847721, 3247.4804031355106, 3253.6258330292085, 3281.737461003114, 3410.0, 3410.9829450852835, 61760.69119654373, 62233.0, 62646.37353626451, 63945.84352017104, 64140.0, 10121.493925303705, 10159.030858965933, 10334.346504559235, 10398.740031499121, 10585.9470702646, 18173.818261817214, 18186.45440636783, 18304.63390732178, 18447.53881152982, 18473.353432629792, 6034.487068599218, 6212.782552610637, 6309.526785491106, 6459.09572659828, 6557.082008518812, 3231.7091461768555, 3316.336732653479, 3371.0, 3389.796612203276, 3403.047146798851, 2777.8333300002064, 2848.957265641017, 2872.482953068426, 2878.2372671242138, 2894.0449651614917, 484.73339663185106, 486.07160323782114, 497.0878438066189, 498.8229178641603, 504.4778654092996, 536.3992328592002, 545.184948501992, 548.7530611224885, 607.2288193993692, 641.8491654461197, 8354.498730076215, 8405.957970210233, 8572.142785721378, 8691.435056721293, 9036.774080648036, 514.6088972381017, 520.4327283261188, 528.2683483375553, 594.6283572767021, 653.5098675993005, 4122.855700050483, 4380.934285985712, 4394.978025109918, 4437.8224871004795, 4439.66702497314, 62437.69279611193, 62634.373656262855, 65253.67373163104, 65313.02030469547, 65875.67062164754, 43246.56753432488, 45834.54165458369, 47560.0, 48435.51564484381, 56473.7176314124, 49091.509084909405, 49332.75333623309, 49711.25433118506, 49880.75059624751, 50629.999999999265, 8428.789280268042, 8945.23965462917, 9018.413803102778, 9096.499692516974, 9116.268911567264, 34613.82693086519, 35793.82103089572, 35876.0, 36054.0, 36394.81802591076, 43083.35374969315, 43273.56726432696, 44979.32531011972, 46925.76537117293, 46976.29535556901, 9746.366486178376, 9977.45124018157, 9992.850107248543, 10101.747456313356, 10271.024252695983, 11580.478878450322, 11803.291802491534, 11926.642200733992, 11983.64049078529, 12132.332721700039, 11170.441477925908, 11242.044426223863, 11461.083113350745, 11730.70673233176, 11873.346965916957, 11362.829557556477, 11397.544098235978, 11457.541698331974, 12071.155019148926, 12102.818457723317, 11136.33182009082, 11144.387058711849, 11148.331100134017, 11336.319820810777, 11633.185677002866, 8572.957135214285, 9052.366334356531, 9512.239020878174, 9652.131308182297, 9745.171660408661, 9176.58705358247, 9960.344182566405, 9977.50112494358, 10095.697129086138, 10367.94816025915], "value": 6203.072287633035, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 115.0, 116.0, 115.0, 115.0, 116.0, 116.0, 116.0, 120.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 132.0, 169.0, 127.0, 128.0, 127.0, 125.0, 153.0, 130.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 169.0, 168.0, 164.0, 165.0, 164.0, 166.0, 163.0, 165.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 119.0, 76.0, 77.0, 77.0, 77.0, 95.0, 77.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 115.0, 85.0, 86.0, 96.0, 103.0, 89.0, 87.0, 110.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 118.0, 118.0, 122.0, 118.0, 119.0, 119.0, 119.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 153.0, 150.0, 153.0, 152.0, 150.0, 152.0, 150.0, 153.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0, 95.0, 95.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 66.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 67.0, 67.0, 67.0, 68.0, 70.0, 68.0, 67.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 87.0, 85.0, 85.0, 87.0, 89.0, 90.0, 87.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 136.0, 138.0, 142.0, 134.0, 135.0, 134.0, 147.0, 182.0, 142.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 180.0, 179.0, 182.0, 188.0, 176.0, 175.0, 178.0, 181.0, 185.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 68.0, 71.0, 70.0, 69.0, 68.0, 68.0, 68.0, 68.0], "value": 69.2, "unit": "score"}]}]} 16:05:20 INFO - Return code: 0 16:05:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:05:20 ERROR - # TBPL SUCCESS # 16:05:20 INFO - Running post-action listener: _resource_record_post_action 16:05:20 INFO - [mozharness: 2017-01-07 00:05:20.688777Z] Finished run-tests step (success) 16:05:20 INFO - Running post-run listener: _resource_record_post_run 16:05:20 INFO - Total resource usage - Wall time: 1200s; CPU: 14.0%; Read bytes: 4096; Write bytes: 382836736; Read time: 4; Write time: 332036 16:05:20 INFO - TinderboxPrint: CPU usage
13.5% 16:05:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 16:05:20 INFO - TinderboxPrint: I/O write bytes / time
382,836,736 / 332,036 16:05:20 INFO - TinderboxPrint: CPU idle
8,279.7 (86.5%) 16:05:20 INFO - TinderboxPrint: CPU user
1,234.8 (12.9%) 16:05:20 INFO - TinderboxPrint: Swap in / out
0 / 0 16:05:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99254272; Read time: 0; Write time: 96172 16:05:20 INFO - run-tests - Wall time: 1184s; CPU: 14.0%; Read bytes: 0; Write bytes: 282509312; Read time: 0; Write time: 235836 16:05:21 INFO - Running post-run listener: _upload_blobber_files 16:05:21 INFO - Blob upload gear active. 16:05:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:05:21 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:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:05:21 INFO - (blobuploader) - INFO - Open directory for files ... 16:05:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:05:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:05:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:22 INFO - (blobuploader) - INFO - Done attempting. 16:05:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:05:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:05:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:23 INFO - (blobuploader) - INFO - Done attempting. 16:05:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:05:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:05:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:24 INFO - (blobuploader) - INFO - Done attempting. 16:05:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:05:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:05:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:27 INFO - (blobuploader) - INFO - Done attempting. 16:05:27 INFO - (blobuploader) - INFO - Iteration through files over. 16:05:27 INFO - Return code: 0 16:05:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:05:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:05:27 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4288f80424daea8ca0e6146d1bdb6f96d7b0348f6bbc407bc3166c194b36c8e2b0eb87dce083207e9e8d9037a77e7e5405f06d074be8ed3f36785fee809f5fa6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7eea33ea1f07fc575abc2e1de7a884de2dd149e2989819dd41ec3da2863e9ec95bb87436e57d04179fe9331f2dbad0dd903de4a401ebc0fda878bdd692485156", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f1f7f3f17aba2b0d40bcbeac89c70b450d469cd398aac5deee0697ad8f1abb3886f5bf1a550b06bfa7e3fd520d19ea665744c9a44513b63818c868934a95359b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6ddba847d8660b64993a2c1e2a4f4b1fe9ef0bf65c99f7bcff212bb5d54f6010bfcc9ef94f10be8bb2e526244a581646bb3da7848477e8b9acfdb258441fa5db"} 16:05:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:05:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:05:27 INFO - Contents: 16:05:27 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4288f80424daea8ca0e6146d1bdb6f96d7b0348f6bbc407bc3166c194b36c8e2b0eb87dce083207e9e8d9037a77e7e5405f06d074be8ed3f36785fee809f5fa6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7eea33ea1f07fc575abc2e1de7a884de2dd149e2989819dd41ec3da2863e9ec95bb87436e57d04179fe9331f2dbad0dd903de4a401ebc0fda878bdd692485156", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f1f7f3f17aba2b0d40bcbeac89c70b450d469cd398aac5deee0697ad8f1abb3886f5bf1a550b06bfa7e3fd520d19ea665744c9a44513b63818c868934a95359b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6ddba847d8660b64993a2c1e2a4f4b1fe9ef0bf65c99f7bcff212bb5d54f6010bfcc9ef94f10be8bb2e526244a581646bb3da7848477e8b9acfdb258441fa5db"} 16:05:27 INFO - Running post-run listener: copy_logs_to_upload_dir 16:05:27 INFO - Copying logs to upload dir... 16:05:27 INFO - mkdir: /builds/slave/test/build/upload/logs 16:05:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.672279 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-01-06 16:05:27.309217) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 16:05:27.312663) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4288f80424daea8ca0e6146d1bdb6f96d7b0348f6bbc407bc3166c194b36c8e2b0eb87dce083207e9e8d9037a77e7e5405f06d074be8ed3f36785fee809f5fa6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7eea33ea1f07fc575abc2e1de7a884de2dd149e2989819dd41ec3da2863e9ec95bb87436e57d04179fe9331f2dbad0dd903de4a401ebc0fda878bdd692485156", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f1f7f3f17aba2b0d40bcbeac89c70b450d469cd398aac5deee0697ad8f1abb3886f5bf1a550b06bfa7e3fd520d19ea665744c9a44513b63818c868934a95359b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6ddba847d8660b64993a2c1e2a4f4b1fe9ef0bf65c99f7bcff212bb5d54f6010bfcc9ef94f10be8bb2e526244a581646bb3da7848477e8b9acfdb258441fa5db"} build_url:https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011659 build_url: 'https://queue.taskcluster.net/v1/task/aVOp32d_TR6wBhPhsR1clA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4288f80424daea8ca0e6146d1bdb6f96d7b0348f6bbc407bc3166c194b36c8e2b0eb87dce083207e9e8d9037a77e7e5405f06d074be8ed3f36785fee809f5fa6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7eea33ea1f07fc575abc2e1de7a884de2dd149e2989819dd41ec3da2863e9ec95bb87436e57d04179fe9331f2dbad0dd903de4a401ebc0fda878bdd692485156", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f1f7f3f17aba2b0d40bcbeac89c70b450d469cd398aac5deee0697ad8f1abb3886f5bf1a550b06bfa7e3fd520d19ea665744c9a44513b63818c868934a95359b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6ddba847d8660b64993a2c1e2a4f4b1fe9ef0bf65c99f7bcff212bb5d54f6010bfcc9ef94f10be8bb2e526244a581646bb3da7848477e8b9acfdb258441fa5db"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-06 16:05:27.342548) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 16:05:27.342890) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1483746280.198051-1498464870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-06 16:05:27.426823) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 16:05:27.427651) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-06 16:05:27.428383) ========= ========= Total master_lag: 0.18 =========