builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1486583858.46 results: success (0) revision: c51d7c9daa243554dcee9fd28d487ae76c512bf2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 11:57:38.459411) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 11:57:38.460030) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 11:57:38.460413) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 11:57:38.476993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 11:57:38.477326) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-08 11:57:38-- 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% 223M=0s 2017-02-08 11:57:38 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090704 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 11:57:38.581998) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 11:57:38.582355) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018013 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 11:57:38.632866) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-08 11:57:38.633242) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c51d7c9daa243554dcee9fd28d487ae76c512bf2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c51d7c9daa243554dcee9fd28d487ae76c512bf2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-08 11:57:38,987 truncating revision to first 12 chars 2017-02-08 11:57:38,987 Setting DEBUG logging. 2017-02-08 11:57:38,987 attempt 1/10 2017-02-08 11:57:38,987 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c51d7c9daa24?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-08 11:57:39,928 unpacking tar archive at: mozilla-aurora-c51d7c9daa24/testing/mozharness/ program finished with exit code 0 elapsedTime=1.265765 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-08 11:57:39.912560) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 11:57:39.912940) ========= script_repo_revision: c51d7c9daa243554dcee9fd28d487ae76c512bf2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 11:57:39.913378) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 11:57:39.913703) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 11:57:39.922811) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-08 11:57:39.923225) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:57:40 INFO - MultiFileLogger online at 20170208 11:57:40 in /builds/slave/test 11:57:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:57:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:57:40 INFO - {'append_to_log': False, 11:57:40 INFO - 'base_work_dir': '/builds/slave/test', 11:57:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:57:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:57:40 INFO - 'branch': 'Mozilla-Aurora', 11:57:40 INFO - 'buildbot_json_path': 'buildprops.json', 11:57:40 INFO - 'config_files': ('talos/linux_config.py',), 11:57:40 INFO - 'default_actions': ('clobber', 11:57:40 INFO - 'read-buildbot-config', 11:57:40 INFO - 'download-and-extract', 11:57:40 INFO - 'populate-webroot', 11:57:40 INFO - 'create-virtualenv', 11:57:40 INFO - 'install', 11:57:40 INFO - 'run-tests'), 11:57:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:57:40 INFO - 'download_minidump_stackwalk': True, 11:57:40 INFO - 'download_symbols': 'ondemand', 11:57:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:57:40 INFO - 'tooltool.py': '/tools/tooltool.py', 11:57:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:57:40 INFO - '/tools/misc-python/virtualenv.py')}, 11:57:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:57:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:57:40 INFO - 'installer_path': 'installer.exe', 11:57:40 INFO - 'log_level': 'info', 11:57:40 INFO - 'log_name': 'talos', 11:57:40 INFO - 'log_to_console': True, 11:57:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:57:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:57:40 INFO - 'opt_config_files': (), 11:57:40 INFO - 'pip_index': False, 11:57:40 INFO - 'sps_profile': False, 11:57:40 INFO - 'sps_profile_interval': 0, 11:57:40 INFO - 'suite': 'dromaeojs-e10s', 11:57:40 INFO - 'system_bits': '32', 11:57:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:57:40 INFO - 'title': 'talos-linux64-ix-029', 11:57:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:57:40 INFO - 'use_talos_json': True, 11:57:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:57:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:57:40 INFO - 'work_dir': 'build'} 11:57:40 INFO - [mozharness: 2017-02-08 19:57:40.379344Z] Running clobber step. 11:57:40 INFO - Running pre-action listener: _resource_record_pre_action 11:57:40 INFO - Running main action method: clobber 11:57:40 INFO - rmtree: /builds/slave/test/build 11:57:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:57:40 INFO - Running post-action listener: _resource_record_post_action 11:57:40 INFO - [mozharness: 2017-02-08 19:57:40.847968Z] Finished clobber step (success) 11:57:40 INFO - [mozharness: 2017-02-08 19:57:40.848068Z] Running read-buildbot-config step. 11:57:40 INFO - Running pre-action listener: _resource_record_pre_action 11:57:40 INFO - Running main action method: read_buildbot_config 11:57:40 INFO - Using buildbot properties: 11:57:40 INFO - { 11:57:40 INFO - "project": "", 11:57:40 INFO - "product": "firefox", 11:57:40 INFO - "who": "ryanvm@gmail.com", 11:57:40 INFO - "installer_path": "public/build/target.tar.bz2", 11:57:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:57:40 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 11:57:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:57:40 INFO - "stage_platform": "linux64-pgo", 11:57:40 INFO - "basedir": "/builds/slave/test", 11:57:40 INFO - "buildnumber": 854, 11:57:40 INFO - "platform": "ubuntu64_hw", 11:57:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:57:40 INFO - "slavebuilddir": "test", 11:57:40 INFO - "taskId": "JoMgvGHwS6-kIj7vdfeE6w", 11:57:40 INFO - "branch": "mozilla-aurora", 11:57:40 INFO - "script_repo_revision": "production", 11:57:40 INFO - "revision": "c51d7c9daa243554dcee9fd28d487ae76c512bf2", 11:57:40 INFO - "slavename": "talos-linux64-ix-029", 11:57:40 INFO - "repo_path": "releases/mozilla-aurora" 11:57:40 INFO - } 11:57:40 INFO - Finding installer, test and symbols from parent task. 11:57:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JoMgvGHwS6-kIj7vdfeE6w'}, attempt #1 11:57:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JoMgvGHwS6-kIj7vdfeE6w'}, attempt #1 11:57:41 INFO - Task dependencies: PMsUT1-3S_e9od4rV3nGAg 11:57:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg'}, attempt #1 11:57:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.tar.bz2 11:57:42 INFO - Set test_url: https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/test_packages.json 11:57:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.crashreporter-symbols.zip 11:57:42 INFO - Running post-action listener: _resource_record_post_action 11:57:42 INFO - [mozharness: 2017-02-08 19:57:42.419417Z] Finished read-buildbot-config step (success) 11:57:42 INFO - [mozharness: 2017-02-08 19:57:42.419633Z] Running download-and-extract step. 11:57:42 INFO - Running pre-action listener: _resource_record_pre_action 11:57:42 INFO - Running main action method: download_and_extract 11:57:42 INFO - mkdir: /builds/slave/test/build/tests 11:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:42 INFO - trying https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.test_packages.json 11:57:42 INFO - Downloading https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:57:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:57:42 INFO - Downloaded 896 bytes. 11:57:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:57:42 INFO - Using the following test package requirements: 11:57:42 INFO - {u'common': [u'target.common.tests.zip'], 11:57:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:57:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:57:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:57:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:57:42 INFO - u'mozbase': [u'target.common.tests.zip'], 11:57:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:57:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:57:42 INFO - u'web-platform': [u'target.common.tests.zip', 11:57:42 INFO - u'target.web-platform.tests.zip'], 11:57:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:57:42 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:57:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.common.tests.zip 11:57:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:57:42 INFO - Fetch https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.common.tests.zip into memory 11:57:43 INFO - Expected file size: 21858947 11:57:43 INFO - Obtained file size: 21858947 11:57:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:57:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.common.tests.zip 11:57:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:57:47 INFO - Fetch https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.common.tests.zip into memory 11:57:48 INFO - Expected file size: 21858947 11:57:48 INFO - Obtained file size: 21858947 11:57:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.talos.tests.zip 11:57:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:57:53 INFO - Fetch https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.talos.tests.zip into memory 11:57:53 INFO - Expected file size: 14403485 11:57:53 INFO - Obtained file size: 14403485 11:57:54 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')]} 11:57:54 INFO - trying https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.tar.bz2 11:57:54 INFO - Downloading https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:57:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:57:55 INFO - Downloaded 66132608 bytes. 11:57:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.tar.bz2 11:57:55 INFO - mkdir: /builds/slave/test/properties 11:57:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:57:55 INFO - Writing to file /builds/slave/test/properties/build_url 11:57:55 INFO - Contents: 11:57:55 INFO - build_url:https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.tar.bz2 11:57:55 INFO - Running post-action listener: _resource_record_post_action 11:57:55 INFO - Running post-action listener: set_extra_try_arguments 11:57:55 INFO - [mozharness: 2017-02-08 19:57:55.382477Z] Finished download-and-extract step (success) 11:57:55 INFO - [mozharness: 2017-02-08 19:57:55.382593Z] Running populate-webroot step. 11:57:55 INFO - Running pre-action listener: _resource_record_pre_action 11:57:55 INFO - Running main action method: populate_webroot 11:57:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:57:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:57:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:57:55 INFO - '--tppagecycles', 11:57:55 INFO - '7'], 11:57:55 INFO - 'tests': ['tsvgm']}}, 11:57:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:57:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:57:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:57:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:57:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:57:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:57:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:57:55 INFO - 'talos_options': ['--disable-e10s'], 11:57:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:57:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:57:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:57:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:57:55 INFO - 'talos_options': ['--disable-e10s'], 11:57:55 INFO - 'tests': ['damp', 'tps']}, 11:57:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:57:55 INFO - 'tests': ['damp', 'tps']}, 11:57:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:57:55 INFO - 'tests': ['dromaeo_dom']}, 11:57:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:57:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:57:55 INFO - 'tests': ['basic_compositor_video']}, 11:57:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:57:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:57:55 INFO - 'tests': ['a11yr', 11:57:55 INFO - 'ts_paint', 11:57:55 INFO - 'tpaint', 11:57:55 INFO - 'sessionrestore', 11:57:55 INFO - 'sessionrestore_no_auto_restore', 11:57:55 INFO - 'tabpaint']}, 11:57:55 INFO - 'other-e10s': {'tests': ['a11yr', 11:57:55 INFO - 'ts_paint', 11:57:55 INFO - 'tpaint', 11:57:55 INFO - 'sessionrestore', 11:57:55 INFO - 'sessionrestore_no_auto_restore', 11:57:55 INFO - 'tabpaint']}, 11:57:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:57:55 INFO - 'ts_paint', 11:57:55 INFO - 'tpaint', 11:57:55 INFO - 'sessionrestore', 11:57:55 INFO - 'sessionrestore_no_auto_restore', 11:57:55 INFO - 'tabpaint']}, 11:57:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:57:55 INFO - 'ts_paint', 11:57:55 INFO - 'tpaint', 11:57:55 INFO - 'sessionrestore', 11:57:55 INFO - 'sessionrestore_no_auto_restore', 11:57:55 INFO - 'tabpaint']}, 11:57:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:57:55 INFO - 'tests': ['a11yr', 11:57:55 INFO - 'ts_paint', 11:57:55 INFO - 'tpaint', 11:57:55 INFO - 'sessionrestore', 11:57:55 INFO - 'sessionrestore_no_auto_restore', 11:57:55 INFO - 'tabpaint']}, 11:57:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:57:55 INFO - 'tests': ['a11yr', 11:57:55 INFO - 'ts_paint', 11:57:55 INFO - 'tpaint', 11:57:55 INFO - 'sessionrestore', 11:57:55 INFO - 'sessionrestore_no_auto_restore', 11:57:55 INFO - 'tabpaint']}, 11:57:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:57:55 INFO - 'tests': ['tsvgx', 11:57:55 INFO - 'tsvgr_opacity', 11:57:55 INFO - 'tart', 11:57:55 INFO - 'tscrollx', 11:57:55 INFO - 'cart', 11:57:55 INFO - 'tsvg_static']}, 11:57:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:57:55 INFO - 'tsvgr_opacity', 11:57:55 INFO - 'tart', 11:57:55 INFO - 'tscrollx', 11:57:55 INFO - 'cart', 11:57:55 INFO - 'tsvg_static']}, 11:57:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:57:55 INFO - 'talos_options': ['--disable-e10s'], 11:57:55 INFO - 'tests': ['tp5o']}, 11:57:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:57:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:57:55 INFO - 'talos_options': ['--disable-e10s', 11:57:55 INFO - '--xperf_path', 11:57:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:57:55 INFO - 'tests': ['tp5n']}, 11:57:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:57:55 INFO - 'talos_options': ['--xperf_path', 11:57:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:57:55 INFO - 'tests': ['tp5n']}}, 11:57:55 INFO - 'talos.zip': {'path': '', 11:57:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:57:55 INFO - Running post-action listener: _resource_record_post_action 11:57:55 INFO - [mozharness: 2017-02-08 19:57:55.398984Z] Finished populate-webroot step (success) 11:57:55 INFO - [mozharness: 2017-02-08 19:57:55.399093Z] Running create-virtualenv step. 11:57:55 INFO - Running pre-action listener: _resource_record_pre_action 11:57:55 INFO - Running main action method: create_virtualenv 11:57:55 INFO - Creating virtualenv /builds/slave/test/build/venv 11:57:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:57:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:57:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:57:55 INFO - Using real prefix '/usr' 11:57:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:57:55 INFO - Installing distribute.............................................................................................................................................................................................done. 11:57:58 INFO - Installing pip.................done. 11:57:58 INFO - Return code: 0 11:57:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:57:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:57:58 INFO - Reading from file tmpfile_stdout 11:57:58 INFO - Output received: 11:57:58 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:57:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ef480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec820>, '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 0x29ed520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ed9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', '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 11:57:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:57:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:57:58 INFO - Using env: {'DISPLAY': ':0', 11:57:58 INFO - 'HOME': '/home/cltbld', 11:57:58 INFO - 'LANG': 'en_US.UTF-8', 11:57:58 INFO - 'LANGUAGE': 'en_US:en', 11:57:58 INFO - 'LOGNAME': 'cltbld', 11:57:58 INFO - 'MAIL': '/var/mail/cltbld', 11:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:58 INFO - 'MOZ_NO_REMOTE': '1', 11:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:58 INFO - 'NO_EM_RESTART': '1', 11:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:58 INFO - 'PWD': '/builds/slave/test', 11:57:58 INFO - 'SHELL': '/bin/bash', 11:57:58 INFO - 'SHLVL': '1', 11:57:58 INFO - 'TERM': 'linux', 11:57:58 INFO - 'TMOUT': '86400', 11:57:58 INFO - 'USER': 'cltbld', 11:57:58 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', 11:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:58 INFO - '_': '/tools/buildbot/bin/python'} 11:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:57:58 INFO - Cleaning up... 11:57:58 INFO - Return code: 0 11:57:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ef480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec820>, '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 0x29ed520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ed9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', '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 11:57:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:57:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:57:58 INFO - Using env: {'DISPLAY': ':0', 11:57:58 INFO - 'HOME': '/home/cltbld', 11:57:58 INFO - 'LANG': 'en_US.UTF-8', 11:57:58 INFO - 'LANGUAGE': 'en_US:en', 11:57:58 INFO - 'LOGNAME': 'cltbld', 11:57:58 INFO - 'MAIL': '/var/mail/cltbld', 11:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:58 INFO - 'MOZ_NO_REMOTE': '1', 11:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:58 INFO - 'NO_EM_RESTART': '1', 11:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:58 INFO - 'PWD': '/builds/slave/test', 11:57:58 INFO - 'SHELL': '/bin/bash', 11:57:58 INFO - 'SHLVL': '1', 11:57:58 INFO - 'TERM': 'linux', 11:57:58 INFO - 'TMOUT': '86400', 11:57:58 INFO - 'USER': 'cltbld', 11:57:58 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', 11:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:58 INFO - '_': '/tools/buildbot/bin/python'} 11:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:58 INFO - Downloading/unpacking psutil>=3.1.1 11:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:58:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:58:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:58:00 INFO - Installing collected packages: psutil 11:58:00 INFO - Running setup.py install for psutil 11:58:00 INFO - building 'psutil._psutil_linux' extension 11:58:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:58:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:58:01 INFO - building 'psutil._psutil_posix' extension 11:58:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:58:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:58:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:58:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:58:01 INFO - Successfully installed psutil 11:58:01 INFO - Cleaning up... 11:58:01 INFO - Return code: 0 11:58:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ef480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec820>, '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 0x29ed520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ed9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', '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 11:58:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:58:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:58:01 INFO - Using env: {'DISPLAY': ':0', 11:58:01 INFO - 'HOME': '/home/cltbld', 11:58:01 INFO - 'LANG': 'en_US.UTF-8', 11:58:01 INFO - 'LANGUAGE': 'en_US:en', 11:58:01 INFO - 'LOGNAME': 'cltbld', 11:58:01 INFO - 'MAIL': '/var/mail/cltbld', 11:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:01 INFO - 'MOZ_NO_REMOTE': '1', 11:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:01 INFO - 'NO_EM_RESTART': '1', 11:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:01 INFO - 'PWD': '/builds/slave/test', 11:58:01 INFO - 'SHELL': '/bin/bash', 11:58:01 INFO - 'SHLVL': '1', 11:58:01 INFO - 'TERM': 'linux', 11:58:01 INFO - 'TMOUT': '86400', 11:58:01 INFO - 'USER': 'cltbld', 11:58:01 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', 11:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:01 INFO - '_': '/tools/buildbot/bin/python'} 11:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:58:03 INFO - Installing collected packages: mozsystemmonitor 11:58:03 INFO - Running setup.py install for mozsystemmonitor 11:58:03 INFO - Successfully installed mozsystemmonitor 11:58:03 INFO - Cleaning up... 11:58:03 INFO - Return code: 0 11:58:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:58: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')]} 11:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58: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')]} 11:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ef480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec820>, '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 0x29ed520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ed9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', '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 11:58:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:58:03 INFO - Using env: {'DISPLAY': ':0', 11:58:03 INFO - 'HOME': '/home/cltbld', 11:58:03 INFO - 'LANG': 'en_US.UTF-8', 11:58:03 INFO - 'LANGUAGE': 'en_US:en', 11:58:03 INFO - 'LOGNAME': 'cltbld', 11:58:03 INFO - 'MAIL': '/var/mail/cltbld', 11:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:03 INFO - 'MOZ_NO_REMOTE': '1', 11:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:03 INFO - 'NO_EM_RESTART': '1', 11:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:03 INFO - 'PWD': '/builds/slave/test', 11:58:03 INFO - 'SHELL': '/bin/bash', 11:58:03 INFO - 'SHLVL': '1', 11:58:03 INFO - 'TERM': 'linux', 11:58:03 INFO - 'TMOUT': '86400', 11:58:03 INFO - 'USER': 'cltbld', 11:58:03 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', 11:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:03 INFO - '_': '/tools/buildbot/bin/python'} 11:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:04 INFO - Downloading/unpacking jsonschema==2.5.1 11:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:58:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:58: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 11:58: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 11:58: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 11:58: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 11:58: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 11:58: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 11:58:06 INFO - Downloading functools32-3.2.3-2.tar.gz 11:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:58:06 INFO - warning: no files found matching '*.txt' 11:58:06 INFO - no previously-included directories found matching 'build' 11:58:06 INFO - no previously-included directories found matching 'dist' 11:58:06 INFO - no previously-included directories found matching '.git*' 11:58:06 INFO - Installing collected packages: jsonschema, functools32 11:58:06 INFO - Running setup.py install for functools32 11:58:06 INFO - warning: no files found matching '*.txt' 11:58:06 INFO - no previously-included directories found matching 'build' 11:58:06 INFO - no previously-included directories found matching 'dist' 11:58:06 INFO - no previously-included directories found matching '.git*' 11:58:06 INFO - Successfully installed jsonschema functools32 11:58:06 INFO - Cleaning up... 11:58:06 INFO - Return code: 0 11:58:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ef480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec820>, '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 0x29ed520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ed9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', '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 11:58:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:58:06 INFO - Using env: {'DISPLAY': ':0', 11:58:06 INFO - 'HOME': '/home/cltbld', 11:58:06 INFO - 'LANG': 'en_US.UTF-8', 11:58:06 INFO - 'LANGUAGE': 'en_US:en', 11:58:06 INFO - 'LOGNAME': 'cltbld', 11:58:06 INFO - 'MAIL': '/var/mail/cltbld', 11:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:06 INFO - 'MOZ_NO_REMOTE': '1', 11:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:06 INFO - 'NO_EM_RESTART': '1', 11:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:06 INFO - 'PWD': '/builds/slave/test', 11:58:06 INFO - 'SHELL': '/bin/bash', 11:58:06 INFO - 'SHLVL': '1', 11:58:06 INFO - 'TERM': 'linux', 11:58:06 INFO - 'TMOUT': '86400', 11:58:06 INFO - 'USER': 'cltbld', 11:58:06 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', 11:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:06 INFO - '_': '/tools/buildbot/bin/python'} 11:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:58:06 INFO - Cleaning up... 11:58:06 INFO - Return code: 0 11:58:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ef480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec820>, '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 0x29ed520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ed9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', '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 11:58:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:58:06 INFO - Using env: {'DISPLAY': ':0', 11:58:06 INFO - 'HOME': '/home/cltbld', 11:58:06 INFO - 'LANG': 'en_US.UTF-8', 11:58:06 INFO - 'LANGUAGE': 'en_US:en', 11:58:06 INFO - 'LOGNAME': 'cltbld', 11:58:06 INFO - 'MAIL': '/var/mail/cltbld', 11:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:06 INFO - 'MOZ_NO_REMOTE': '1', 11:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:06 INFO - 'NO_EM_RESTART': '1', 11:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:06 INFO - 'PWD': '/builds/slave/test', 11:58:06 INFO - 'SHELL': '/bin/bash', 11:58:06 INFO - 'SHLVL': '1', 11:58:06 INFO - 'TERM': 'linux', 11:58:06 INFO - 'TMOUT': '86400', 11:58:06 INFO - 'USER': 'cltbld', 11:58:06 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', 11:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:06 INFO - '_': '/tools/buildbot/bin/python'} 11:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:06 INFO - Downloading/unpacking blobuploader==1.2.4 11:58: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 11:58: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 11:58: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 11:58: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 11:58: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 11:58: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 11:58:08 INFO - Downloading blobuploader-1.2.4.tar.gz 11:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:58:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:58: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 11:58: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 11:58: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 11:58: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 11:58: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 11:58: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 11:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:58:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:58: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 11:58: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 11:58: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 11:58: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 11:58: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 11:58: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 11:58:09 INFO - Downloading docopt-0.6.1.tar.gz 11:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:58:09 INFO - Installing collected packages: blobuploader, requests, docopt 11:58:09 INFO - Running setup.py install for blobuploader 11:58:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:58:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:58:09 INFO - Running setup.py install for requests 11:58:10 INFO - Running setup.py install for docopt 11:58:10 INFO - Successfully installed blobuploader requests docopt 11:58:10 INFO - Cleaning up... 11:58:10 INFO - Return code: 0 11:58:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ef480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec820>, '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 0x29ed520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ed9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', '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 11:58:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:58:10 INFO - Using env: {'DISPLAY': ':0', 11:58:10 INFO - 'HOME': '/home/cltbld', 11:58:10 INFO - 'LANG': 'en_US.UTF-8', 11:58:10 INFO - 'LANGUAGE': 'en_US:en', 11:58:10 INFO - 'LOGNAME': 'cltbld', 11:58:10 INFO - 'MAIL': '/var/mail/cltbld', 11:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:10 INFO - 'MOZ_NO_REMOTE': '1', 11:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:10 INFO - 'NO_EM_RESTART': '1', 11:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:10 INFO - 'PWD': '/builds/slave/test', 11:58:10 INFO - 'SHELL': '/bin/bash', 11:58:10 INFO - 'SHLVL': '1', 11:58:10 INFO - 'TERM': 'linux', 11:58:10 INFO - 'TMOUT': '86400', 11:58:10 INFO - 'USER': 'cltbld', 11:58:10 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', 11:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:10 INFO - '_': '/tools/buildbot/bin/python'} 11:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:10 INFO - Running setup.py (path:/tmp/pip-fDxtlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:10 INFO - Running setup.py (path:/tmp/pip-LVF05L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:10 INFO - Running setup.py (path:/tmp/pip-YfqoMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:10 INFO - Running setup.py (path:/tmp/pip-wBwkCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:10 INFO - Running setup.py (path:/tmp/pip-zYRgvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:10 INFO - Running setup.py (path:/tmp/pip-y1HdoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:11 INFO - Running setup.py (path:/tmp/pip-s5zKu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:11 INFO - Running setup.py (path:/tmp/pip-HzICsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:11 INFO - Running setup.py (path:/tmp/pip-rrBd3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:11 INFO - Running setup.py (path:/tmp/pip-vnpkmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:11 INFO - Running setup.py (path:/tmp/pip-6Jp9AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:11 INFO - Running setup.py (path:/tmp/pip-9bLHba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:11 INFO - Running setup.py (path:/tmp/pip-K6qlOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:11 INFO - Running setup.py (path:/tmp/pip-GKdmyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:11 INFO - Running setup.py (path:/tmp/pip-QNpuL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:11 INFO - Running setup.py (path:/tmp/pip-DB3q8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:11 INFO - Running setup.py (path:/tmp/pip-NhRd__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:58:11 INFO - Running setup.py install for manifestparser 11:58:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:58:11 INFO - Running setup.py install for mozcrash 11:58:12 INFO - Running setup.py install for mozdebug 11:58:12 INFO - Running setup.py install for mozdevice 11:58:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:58:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:58:12 INFO - Running setup.py install for mozfile 11:58:12 INFO - Running setup.py install for mozhttpd 11:58:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:58:12 INFO - Running setup.py install for mozinfo 11:58:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:58:12 INFO - Running setup.py install for mozInstall 11:58:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:58:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:58:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:58:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:58:12 INFO - Running setup.py install for mozleak 11:58:12 INFO - Running setup.py install for mozlog 11:58:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:58:12 INFO - Running setup.py install for moznetwork 11:58:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:58:12 INFO - Running setup.py install for mozprocess 11:58:13 INFO - Running setup.py install for mozprofile 11:58:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:58:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:58:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:58:13 INFO - Running setup.py install for mozrunner 11:58:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:58:13 INFO - Running setup.py install for mozscreenshot 11:58:13 INFO - Running setup.py install for moztest 11:58:13 INFO - Running setup.py install for mozversion 11:58:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:58:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:58:13 INFO - Cleaning up... 11:58:13 INFO - Return code: 0 11:58:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ef480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec820>, '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 0x29ed520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ed9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', '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 11:58:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:58:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:58:13 INFO - Using env: {'DISPLAY': ':0', 11:58:13 INFO - 'HOME': '/home/cltbld', 11:58:13 INFO - 'LANG': 'en_US.UTF-8', 11:58:13 INFO - 'LANGUAGE': 'en_US:en', 11:58:13 INFO - 'LOGNAME': 'cltbld', 11:58:13 INFO - 'MAIL': '/var/mail/cltbld', 11:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:13 INFO - 'MOZ_NO_REMOTE': '1', 11:58:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:13 INFO - 'NO_EM_RESTART': '1', 11:58:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:13 INFO - 'PWD': '/builds/slave/test', 11:58:13 INFO - 'SHELL': '/bin/bash', 11:58:13 INFO - 'SHLVL': '1', 11:58:13 INFO - 'TERM': 'linux', 11:58:13 INFO - 'TMOUT': '86400', 11:58:13 INFO - 'USER': 'cltbld', 11:58:13 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', 11:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:13 INFO - '_': '/tools/buildbot/bin/python'} 11:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:13 INFO - Running setup.py (path:/tmp/pip-qASFmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:13 INFO - Running setup.py (path:/tmp/pip-DMTUlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:13 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)) 11:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:13 INFO - Running setup.py (path:/tmp/pip-bhJikJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:14 INFO - Running setup.py (path:/tmp/pip-QKdblq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:14 INFO - Running setup.py (path:/tmp/pip-p8KQCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:14 INFO - Running setup.py (path:/tmp/pip-jsdbe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:14 INFO - Running setup.py (path:/tmp/pip-EQl7dR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:14 INFO - Running setup.py (path:/tmp/pip-At05Hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:14 INFO - Running setup.py (path:/tmp/pip-Y0B5TX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:14 INFO - Running setup.py (path:/tmp/pip-oIxMP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:14 INFO - Running setup.py (path:/tmp/pip-LNq_R7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:14 INFO - Running setup.py (path:/tmp/pip-ds_CJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:14 INFO - Running setup.py (path:/tmp/pip-xxHxpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:14 INFO - Running setup.py (path:/tmp/pip-EXLkOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:14 INFO - Running setup.py (path:/tmp/pip-c9OF0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:14 INFO - Running setup.py (path:/tmp/pip-68tx74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:15 INFO - Running setup.py (path:/tmp/pip-0g73ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:58:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:17 INFO - Downloading blessings-1.6.tar.gz 11:58:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:58:17 INFO - Installing collected packages: blessings 11:58:17 INFO - Running setup.py install for blessings 11:58:17 INFO - Successfully installed blessings 11:58:17 INFO - Cleaning up... 11:58:17 INFO - Return code: 0 11:58:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:58:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:17 INFO - Reading from file tmpfile_stdout 11:58:17 INFO - Current package versions: 11:58:17 INFO - argparse == 1.2.1 11:58:17 INFO - blessings == 1.6 11:58:17 INFO - blobuploader == 1.2.4 11:58:17 INFO - docopt == 0.6.1 11:58:17 INFO - functools32 == 3.2.3-2 11:58:17 INFO - jsonschema == 2.5.1 11:58:17 INFO - manifestparser == 1.1 11:58:17 INFO - mozInstall == 1.12 11:58:17 INFO - mozcrash == 1.0 11:58:17 INFO - mozdebug == 0.1 11:58:17 INFO - mozdevice == 0.49 11:58:17 INFO - mozfile == 1.2 11:58:17 INFO - mozhttpd == 0.7 11:58:17 INFO - mozinfo == 0.9 11:58:17 INFO - mozleak == 0.1 11:58:17 INFO - mozlog == 3.4 11:58:17 INFO - moznetwork == 0.27 11:58:17 INFO - mozprocess == 0.24 11:58:17 INFO - mozprofile == 0.28 11:58:17 INFO - mozrunner == 6.13 11:58:17 INFO - mozscreenshot == 0.1 11:58:17 INFO - mozsystemmonitor == 0.3 11:58:17 INFO - moztest == 0.8 11:58:17 INFO - mozversion == 1.4 11:58:17 INFO - psutil == 3.1.1 11:58:17 INFO - requests == 1.2.3 11:58:17 INFO - wsgiref == 0.1.2 11:58:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ef480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec820>, '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 0x29ed520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ed9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', '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 11:58:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:58:17 INFO - Using env: {'DISPLAY': ':0', 11:58:17 INFO - 'HOME': '/home/cltbld', 11:58:17 INFO - 'LANG': 'en_US.UTF-8', 11:58:17 INFO - 'LANGUAGE': 'en_US:en', 11:58:17 INFO - 'LOGNAME': 'cltbld', 11:58:17 INFO - 'MAIL': '/var/mail/cltbld', 11:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:17 INFO - 'MOZ_NO_REMOTE': '1', 11:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:17 INFO - 'NO_EM_RESTART': '1', 11:58:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:17 INFO - 'PWD': '/builds/slave/test', 11:58:17 INFO - 'SHELL': '/bin/bash', 11:58:17 INFO - 'SHLVL': '1', 11:58:17 INFO - 'TERM': 'linux', 11:58:17 INFO - 'TMOUT': '86400', 11:58:17 INFO - 'USER': 'cltbld', 11:58:17 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', 11:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:17 INFO - '_': '/tools/buildbot/bin/python'} 11:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:58:17 INFO - Cleaning up... 11:58:17 INFO - Return code: 0 11:58:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ef480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec820>, '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 0x29ed520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ed9b0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', '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 11:58:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:58:17 INFO - Using env: {'DISPLAY': ':0', 11:58:17 INFO - 'HOME': '/home/cltbld', 11:58:17 INFO - 'LANG': 'en_US.UTF-8', 11:58:17 INFO - 'LANGUAGE': 'en_US:en', 11:58:17 INFO - 'LOGNAME': 'cltbld', 11:58:17 INFO - 'MAIL': '/var/mail/cltbld', 11:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:17 INFO - 'MOZ_NO_REMOTE': '1', 11:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:17 INFO - 'NO_EM_RESTART': '1', 11:58:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:17 INFO - 'PWD': '/builds/slave/test', 11:58:17 INFO - 'SHELL': '/bin/bash', 11:58:17 INFO - 'SHLVL': '1', 11:58:17 INFO - 'TERM': 'linux', 11:58:17 INFO - 'TMOUT': '86400', 11:58:17 INFO - 'USER': 'cltbld', 11:58:17 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', 11:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:17 INFO - '_': '/tools/buildbot/bin/python'} 11:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:58:18 INFO - Cleaning up... 11:58:18 INFO - Return code: 0 11:58:18 INFO - Running post-action listener: _resource_record_post_action 11:58:18 INFO - Running post-action listener: _start_resource_monitoring 11:58:18 INFO - Starting resource monitoring. 11:58:18 INFO - [mozharness: 2017-02-08 19:58:18.050320Z] Finished create-virtualenv step (success) 11:58:18 INFO - [mozharness: 2017-02-08 19:58:18.050763Z] Running install step. 11:58:18 INFO - Running pre-action listener: _resource_record_pre_action 11:58:18 INFO - Running main action method: install 11:58:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:18 INFO - Reading from file tmpfile_stdout 11:58:18 INFO - Detecting whether we're running mozinstall >=1.0... 11:58:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:58:18 INFO - Reading from file tmpfile_stdout 11:58:18 INFO - Output received: 11:58:18 INFO - Usage: mozinstall [options] installer 11:58:18 INFO - Options: 11:58:18 INFO - -h, --help show this help message and exit 11:58:18 INFO - -d DEST, --destination=DEST 11:58:18 INFO - Directory to install application into. [default: 11:58:18 INFO - "/builds/slave/test"] 11:58:18 INFO - --app=APP Application being installed. [default: firefox] 11:58:18 INFO - mkdir: /builds/slave/test/build/application 11:58:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:58:34 INFO - Reading from file tmpfile_stdout 11:58:34 INFO - Output received: 11:58:34 INFO - /builds/slave/test/build/application/firefox/firefox 11:58:34 INFO - Running post-action listener: _resource_record_post_action 11:58:34 INFO - [mozharness: 2017-02-08 19:58:34.770616Z] Finished install step (success) 11:58:34 INFO - [mozharness: 2017-02-08 19:58:34.770896Z] Running run-tests step. 11:58:34 INFO - Running pre-action listener: _resource_record_pre_action 11:58:34 INFO - Running main action method: run_tests 11:58:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:58:34 INFO - Python 2.7.3 11:58:34 INFO - Return code: 0 11:58:34 INFO - grabbing minidump binary from tooltool 11:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec820>, '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 0x29ed520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ed9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:58:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:58:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:58:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:58:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:58:34 INFO - Return code: 0 11:58:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:58:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:58:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:58:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:58:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:58:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:58:34 INFO - Using env: {'DISPLAY': ':0', 11:58:34 INFO - 'HOME': '/home/cltbld', 11:58:34 INFO - 'LANG': 'en_US.UTF-8', 11:58:34 INFO - 'LANGUAGE': 'en_US:en', 11:58:34 INFO - 'LOGNAME': 'cltbld', 11:58:34 INFO - 'MAIL': '/var/mail/cltbld', 11:58:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:58:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:34 INFO - 'MOZ_NO_REMOTE': '1', 11:58:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:34 INFO - 'NO_EM_RESTART': '1', 11:58:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:34 INFO - 'PWD': '/builds/slave/test', 11:58:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:58:34 INFO - 'SHELL': '/bin/bash', 11:58:34 INFO - 'SHLVL': '1', 11:58:34 INFO - 'TERM': 'linux', 11:58:34 INFO - 'TMOUT': '86400', 11:58:34 INFO - 'USER': 'cltbld', 11:58:34 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941', 11:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:34 INFO - '_': '/tools/buildbot/bin/python'} 11:58:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:58:35 INFO - mozversion application_buildid: 20170208185101 11:58:35 INFO - mozversion application_changeset: c51d7c9daa243554dcee9fd28d487ae76c512bf2 11:58:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:58:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:58:35 INFO - mozversion application_name: Firefox 11:58:35 INFO - mozversion application_remotingname: firefox-dev 11:58:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:58:35 INFO - mozversion application_vendor: Mozilla 11:58:35 INFO - mozversion application_version: 53.0a2 11:58:35 INFO - mozversion platform_buildid: 20170208185101 11:58:35 INFO - mozversion platform_changeset: c51d7c9daa243554dcee9fd28d487ae76c512bf2 11:58:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:58:35 INFO - mozversion platform_version: 53.0a2 11:58:35 INFO - using testdate: 1486583915 11:58:35 INFO - actual date: 1486583915 11:58:35 INFO - starting webserver on 'localhost:40409' 11:58:35 INFO - SUITE-START | Running 2 tests 11:58:35 INFO - TEST-START | dromaeo_css 11:58:35 INFO - operating with platform_type : linux_ 11:58:35 INFO - Initialising browser for dromaeo_css test... 11:58:35 INFO - TEST-INFO | started process 26494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNkMKni/profile http://localhost:40409/getInfo.html) 11:58:39 INFO - PROCESS | 26494 | __metrics Screen width/height:1600/1200 11:58:39 INFO - PROCESS | 26494 | colorDepth:24 11:58:39 INFO - PROCESS | 26494 | Browser inner width/height: 1024/697 11:58:39 INFO - PROCESS | 26494 | __metrics 11:58:40 INFO - PROCESS | 26494 | 1486583920634 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpNkMKni/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpNkMKni/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpNkMKni/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpNkMKni/profile/extensions/talos-powers@TalosPowersService.js:55:9 11:58:40 ERROR - PROCESS | 26494 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 11:58:41 INFO - TEST-INFO | 26494: exit 0 11:58:41 INFO - Browser initialized. 11:58:41 INFO - Running cycle 1/1 for dromaeo_css test... 11:58:41 INFO - TEST-INFO | started process 26626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNkMKni/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:58:53 INFO - PROCESS | 26626 | RSS: Main: 144609280 11:58:53 INFO - PROCESS | 26626 | 12:01:52 INFO - PROCESS | 26626 | Cycle 1(1): loaded http://localhost:40409/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40409/tests/dromaeo/cssquery-ext.html) 12:01:53 INFO - PROCESS | 26626 | RSS: Main: 154464256 12:01:53 INFO - PROCESS | 26626 | 12:03:41 INFO - PROCESS | 26626 | ************************* 12:03:41 INFO - PROCESS | 26626 | A coding exception was thrown and uncaught in a Task. 12:03:41 INFO - PROCESS | 26626 | 12:03:41 ERROR - PROCESS | 26626 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:03:41 INFO - PROCESS | 26626 | Full stack: 12:03:41 INFO - PROCESS | 26626 | ************************* 12:04:55 INFO - PROCESS | 26626 | Cycle 1(1): loaded http://localhost:40409/tests/dromaeo/cssquery-ext.html (next: http://localhost:40409/tests/dromaeo/cssquery-jquery.html) 12:04:56 INFO - PROCESS | 26626 | RSS: Main: 149483520 12:04:56 INFO - PROCESS | 26626 | 12:07:58 INFO - PROCESS | 26626 | Cycle 1(1): loaded http://localhost:40409/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40409/tests/dromaeo/cssquery-mootools.html) 12:07:58 INFO - PROCESS | 26626 | RSS: Main: 153075712 12:07:58 INFO - PROCESS | 26626 | 12:11:00 INFO - PROCESS | 26626 | Cycle 1(1): loaded http://localhost:40409/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40409/tests/dromaeo/cssquery-prototype.html) 12:11:01 INFO - PROCESS | 26626 | RSS: Main: 149463040 12:11:01 INFO - PROCESS | 26626 | 12:14:03 INFO - PROCESS | 26626 | Cycle 1(1): loaded http://localhost:40409/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40409/tests/dromaeo/cssquery-yui.html) 12:14:04 INFO - PROCESS | 26626 | RSS: Main: 152764416 12:14:04 INFO - PROCESS | 26626 | 12:17:06 INFO - PROCESS | 26626 | Cycle 1(1): loaded http://localhost:40409/tests/dromaeo/cssquery-yui.html (next: http://localhost:40409/tests/dromaeo/cssquery-dojo.html) 12:17:07 INFO - PROCESS | 26626 | RSS: Main: 153546752 12:17:07 INFO - PROCESS | 26626 | 12:17:07 INFO - PROCESS | 26626 | __start_tp_report 12:17:07 INFO - PROCESS | 26626 | _x_x_mozilla_page_load 12:17:07 INFO - PROCESS | 26626 | _x_x_mozilla_page_load_details 12:17:07 INFO - PROCESS | 26626 | |i|pagename|runs| 12:17:07 INFO - PROCESS | 26626 | |0;dojo.html;3266.2487627845594;3290.144562413772;3300.141963089596;3303.6365999740024;3308.1398836302556;5463.098588732859;5491.478309560595;5505.6696598204135;5520.282363292771;5538.169274608811;5582.106862901936;5598;5611.849570837979;5627.099664053752;5634.746436410361;5039.6976181429045;5080.720560369178;5117.8464646060675;5138.897222055575;5177.378714554259;5104.464031276718;5154.948450515484;5155.793768249266;5159.251908473269;5178.559822415099;4912.680675756064;4950.257461380804;5138.768755405997;5142.871428214287;5147.4080480744815;4985.651004429691;5054.191329387317;5092.6180536459915;5117.078925793356;5174.922376164361;5028.145215313405;5093.694378337274;5097.3118628984985;5099.617528685363;5123;5364;5558.249636299089;5583;5674.829755107354;5694.715264236813;5774.595778295521;5777.046787280094;5809.796657116981;5845.766169353221;5915.733791979371;5925.992581261196;5929.14027466015;5935.228420305376;5946.07835785454;5946.583739138262;5546.112621980504;5547.583931205136;5551.528120109796;5551.750171242304;5563.944360556424;5806.65160090396;5807.390224026501;5992.161097446361;5994.550408719363;6060.878782424415;5905.438983296666;5952.375000624958;5962.850928726816;5969.343372229051;5993.101034844721;5976.6115202512565;6017.1275165100815;6023.849403764941;6028.156058151862;6032.939670603326;5706.28671416073;5738.569607279471;5800.071988481907;6006.879862402815;6026.728797204137;5899.7050147492455;5972.790952316648;5981.0729336952845;6012.398760123952;6026.487748541335;4628.190066738307;4636.188666983332;4643.95356046442;4644.790984405709;4671.299305104261;4027.134166154291;4029.5970402960056;4096.528899176573;4104;4131.462909821704;5675.290588676416;5725.141228815711;5757.8560535986935;5808.419158084243;5853.882922341614;6009.849753756191;6030.366811484819;6054.636721796706;6063.363346848606;6065.211522502046;5625.46558076982;5648.039833228278;5700.344460387026;5758.193852860602;5762.164486149485;5073.543381095719;5078.619103567247;5091.516305950929;5126.79492820283;5127.128388174019;6144.078388241799;6180.227471566054;6197.628142311476;6200.255969283625;6221.5333849960525;5807.361190269152;5841.50347220491;5854.063349864172;5998.310194327533;6005.399460054135;6109.358517355614;6171.352008039091;6185.41238582334;6210.937890621217;6218;5844.240248767633;5866.823995280149;5887.558433117619;5890.852728681646;5910.940890591039;5805.680687562224;5998.190244316961;6000.459958603747;6002.309734380602;6020;5730.570207234391;5742.741576628978;5816.1857339973285;5816.563757718272;5911.379305172895;5877.441643043904;5887.322957859729;5889.676067816311;5892.204552385373;5896.056630939029;5874.295084589877;5874.970625146847;5876.6180198286975;5880.617759845596;5888.205092312654;5510.1459273812625;5717.22817419643;5756.884862302647;5768;5771.480566749013;5680;5688.175214593778;5702.657840529581;5707.1153971134545;5711.828645140652 12:17:07 INFO - PROCESS | 26626 | |1;ext.html;539.5558121708661;606.2421972534332;616.7964571691341;694.4617921111142;719.8272414620493;43361.34957975633;44487.66537003887;48583;48649.51350486494;49037.50962490374;49418;49995;50219.49780502203;50562.24156637644;50621;9238.722838314861;10630.893691063067;10969.177311701615;10986.560537578487;11319.20765546412;10923.563057477691;10998.285111467769;11006.889931100706;11011.339319640807;11026.228164028522;10949.726256843564;11008.339499630009;11026.669199923976;11060.336379817196;11105.55577776888;10879;10949.671509854717;11026.889731102667;11035.613753518628;11037.282576632533;10965.945170274177;11034.503447344889;11063.280886742335;11069.667909962714;11085.556577736881;42256.57743422557;42262.788686056374;42539.36190957138;42573.57426425758;42813.57186428127;4418.182636212279;4440.2895536714295;4508.639308855284;4579.656525760548;4584.839530616412;32770.344593108246;32797.18007049843;33591.32817343664;33718.83140584306;34163.487547686804;4759.666823322369;4791.928121078186;4793.209120495114;4800.543948324904;4840.128776820206;378713;379682;380020;381503;381848;63494.36505634885;63569.36430635634;63877.68061159665;63916.68041659762;64013.67993160005;66034.66982665056;66115.33884661092;66318.66840665862;66530;66794;17800.198991045436;18093.7285940711;18925.81074189268;19522.023898805288;19582.216711331672;14935.551933442013;15052.397904083715;15125.470608528869;15627;15664;20170.495737606678;20395.286164984453;20451;20491.4877128073;20535.38393848187;7320.926790732131;7472.70109195637;7505.24947505256;7612.8477430451085;7659.693612255559;1003.5333569890037;1017.2065788684838;1028.3983869436313;1033.4419413516616;1042.0413219837617;33851.153721156676;33909.49135762965;33964.150896227795;34069.829650851585;34173.48739768905;1115.5426275227119;1189.1972918280126;1205.4635687119323;1205.698575356161;1231.2920070959235;17799.46601601954;17806.287748489915;17865.642687146443;17893.463196104138;17941.282348706165;508742;512287;513127;513745;513808;69895.65052174707;69911.65044174746;69983.3001669987;70098;70686.29313706797;1530.4872867589258;1563.5622025832786;1572.2688949638473;1601.7757513948056;1606.6465377616905;32786.50820237746;32793;33081;33100.503492448115;33453;57738;58443;58448;58451.4154858446;58467.415325846196;401963;404856;405024;406606;407430;28518.287042823264;29173.41653166967;29393.706062939098;31344.529832052995;31374;47543.76228118837;48067;48269.75865120652;48372.274415884494;49195.26207106968;40280;40622;40919.38620920629;41015.38476922908;42324.57675423206;39704;40197.39703904502;41088;41204.79397603113;41639.7918010408;39041.80479097586;40165.1966960665;40364.79817600893;40426.1914761709;40564.79717601511;34223.657763422045;34812.82593587016;35856.4621530672;35873.46189807207;35986.46020309645;26643.200703978913;26947.461050779268;27287.181384558495;27617.066805323433;27722.752476139027 12:17:07 INFO - PROCESS | 26626 | |2;jquery.html;426.6117832772178;439.2883528683531;446.61814148902675;450.1761775950012;456.1447286338116;20128.798712012893;21338.679919801216;22545.323640290797;22633.434164145903;22789;21964.341069767892;22774.544509109808;22858;22953.4261643459;23594.64608030881;6102.542309326796;6116.204893363856;6305.211848518935;6343.207099112611;6345.333739957307;6054.273487181545;6148.385161483839;6196.473299769525;6204.069389591552;6232.158658581079;6018.217631707894;6025.166395577414;6147.938520614782;6170.568060235785;6191.969040154793;6084.239470066242;6126.632402055869;6130.448259656608;6136.140940268321;6169.10547970544;5427;5490.6431081979945;5526.032944234743;5545.140503222007;5572.3870374258795;25897.741022589722;26161.869190654113;26188.08341708031;26478.470430591282;26500.337491562674;3252.886148984774;3312.7184189343934;3323.18581947422;3377.7297816174646;3407.0800883761244;16052.919735401365;16112.59718507035;16218;16351;16946.576335591584;2034.8168664820237;2051.887146206958;2059.6086743518686;2073.2018173003503;2081.6149012432747;95200.52399737957;95700.52149739277;96204;98459;99124.50437747837;11547.595834145932;11799.88200118005;11860.05119590448;11906.166568340133;12180.390980450942;16689.582760431087;16691.833081669272;16740.079295638614;16764.161791910356;16799.748003779954;9146.63413463454;9552.235821134293;9566.808663826685;9591.712248632552;9756.170725488271;9357.251419886392;9425.575849086808;9469;9473.100055494717;9521.90478095224;7588.506747061423;7608.657610407545;7841.803954901173;7853.450258481966;8031.839363212703;2017.253616162;2018.7678416982235;2062.4946888012532;2096.0986775686297;2177.967330490044;1131.5247596009697;1150.19792366868;1179.6696924861053;1185.8221266810046;1194.199886076331;21287;21355.67966480473;21357.67963480549;21520.139194432046;21534.78465215359;1023.2223510132353;1055.456439933435;1061.7398737309409;1087.4617064553097;1194.2714943884223;10736.624218152327;11505.252158609663;11535.596254131066;11604.187706860439;11611.88388116125;778559;778895;784187;797109;806838;114567;114970;117876;118001.4099929512;121716;1224.5407972010496;1242.2298175131477;1244.3591550351575;1246.7568824079399;1246.8316777235138;17327.306907724054;18066.638667226318;18184.272629095216;18184.545386365447;18247;44668.55331446774;45639;45848.31227531523;46304.305435417824;46792.298115528974;67641.32358676351;67776;67811.66094169498;68499.31500685129;68898.65550672215;9697.5151242439;9722.756931076497;9803.313768036169;9820.803583928424;9942.403455792675;12457.937710311753;14372.35324410425;14570.05294655844;14591.854081459049;14918.403263869757;12122.15144939881;12153.270803751802;12302.569410070604;12458.813117803058;12562.623121306375;12313.32276724753;12390.194637348544;12482;12594.685132871751;12706.047046471736;8941.37410381267;12368.81446778317;12676.112672112864;12754.744905101661;12839.101262911507;9656.855147172657;9871.753206169904;9999.35004224752;10016.799664006534;10047.274873875818;10275.948620256851;12359.814602781145;12675.17611355259;12685;12812.167209131376 12:17:07 INFO - PROCESS | 26626 | |3;mootools.html;1526.8931174817767;1530.5484881959828;1541.791858099157;1547.2031903569664;1565.3425561264264;8621.267192288655;8644.913550864505;8822.691205807798;9203.217726493247;9208.447493150406;9272.536373181347;9383.953080234607;9403.71788846334;9416.764580885481;9426.34015618907;2390.3307074019217;2435.6711843901026;2436.561418944589;2437.171361737009;2451.705795304557;2329.4176455886027;2380.1669415704537;2386.069432921162;2386.0813586769045;2392.031227352925;2476.826622136442;2488.9004439822475;2501.7873480754065;2502.249325202432;2504.524140413325;2424.7575242475787;2440.2191298784396;2452.460458699083;2459.6064629659168;2464.4578192797558;2316.7567405422524;2323;2330.1844354475966;2339.6256598944087;2404.7715467030603;9137.817243655156;9191.724248272496;9198.17216450516;9231.90768092324;9234.95382523083;5399.1091469907415;5440.483154100394;5486.698231597261;5528.834134975958;5550.4449555044575;3479.391106556368;3549.5563054618174;3622.1125824173246;3758;3800.4869342638945;1411.5200831717164;1428.8356838963443;1439.3954539093606;1446.2184415184772;1548.7676848472706;12516.812247816199;12533.74932501354;12570.30863302518;12654.620361389174;12659.113862029662;4445.911081778411;4626.190416677068;4690.15577196108;4747.1486120413065;4793.9041219176115;9851.310408271496;9851.655192068243;9883.258755593359;9883.950580247052;9900.356476828983;5494.340679118532;5533.391326954032;5541.778328866801;5548.750306236229;5563.276774019432;4989.17678583037;5122.436531981479;5150.433452320317;5196.636235463481;5260.6843589384;3979.542352629485;4068.9186216275507;4085.7140000200293;4136.028033412145;4136.751794892316;1281.9294938778457;1290.148501988683;1290.6128161551496;1292.780227361332;1294.566320282697;1036.3367444835312;1045.968620941373;1056.4559251985233;1067.2209287220373;1075.983860242097;6127.877442451126;6172.660503672341;6202.82146392184;6260.593061450991;6332.651704156224;661.5336187987457;673.1316601584;677.3598948993155;679.7383007542132;688.3563867783638;4066.044479547304;4180.602842729936;4273.081287523198;4296.226679197712;4406.515283318832;10787.460626968621;11087.83368249477;11093.889061109447;11155;11171.608993685344;11055.502502387411;11062.612808551663;11068.723281918017;11152.553897843994;11163.218574699693;8255.339572834158;8488.10874858131;8540.444871083484;8638.784030399165;8718.302535797122;6099.573029887865;6120.510359171345;6256.343083976117;6325.746970121328;6383.0744542042075;9932.801343972935;9987.250956178461;10188.083072523508;10194.847077293698;10204.897951020395;10468.947655261674;10507.527161277609;10564.630237941636;10566.788664226518;10574.365538067741;7783.571903545359;7910.129885712452;7945.642446090055;8081.030276366873;8109.878351824609;8689.217970382695;8699.173578510032;8740.388172827841;8744.300455963636;8818.470891746516;7338.229485903903;7452.06849143857;7560.546367217985;7572.734954276574;7597.088349398107;7740.496867703581;7745.7676269712;7800.6099695016155;7879.133295337394;7964.960175199319;7085.57486550788;7089.574625522485;7096.148462184571;7159.355657990805;7240.818979525554;5279.419263880894;5324.041672498987;5373.328333958255;5384.219288203267;5438.18427235902;5363.892722145457;5445.2104444854485;5537.667739935617;5538.667679939216;5581.972090139523 12:17:07 INFO - PROCESS | 26626 | |4;prototype.html;414.8817586987708;415.1541185175621;428.0262403033099;428.9699721019526;430.4963193064113;5278.736063196834;5321.6318738161535;5424.403315635282;5478.698946442489;5504.944950550494;5254.479498735846;5364.597655175858;5386.946130538693;5390.460953904608;5401.459854014596;4220.430241917348;4239.809208585606;4305.677074219446;4334.41485399471;4350.73895566267;4302.591253830881;4330.155619654169;4337.913241735163;4339.305711086226;4354.259775838115;4319.214106901047;4333.60997510224;4338.652907767387;4347.260965635834;4364.956350436502;4203.894902627459;4277.422547956017;4345;4367.650587952956;4368.322909948947;3915.569287378386;3922.8430862765454;3925.450436938831;3942.526896772377;3957;5290.867728306785;5301.443348448434;5316.282301889273;5330.28041214435;5346.866328341784;4980.2778597103215;5011.924821127686;5073.797048118071;5078.4159821620615;5090.669106508102;5699.316082070137;5751.971240143815;5756.625819321731;5763.538916886681;5766.740496677659;4385.8245670173155;4403.2954727243805;4403.647708183337;4411.492678342;4430.335449682541;5563.860903477445;5879.618289701916;5914.319853216849;5936.762529498815;5964.314103878066;4252.978735106305;4259.42497762798;4264.850730224427;4291.67812414064;4314.417553630283;4298.914021719548;4304.332828411601;4306.633936115465;4316.1583491219535;4327.7186982846015;4672.789724462407;4873.707577545359;4894.877628059327;4906.2640603909695;4915.3855768029;5565.693886836263;5660.773569057192;5673.77304907799;5737.225474560964;5748.425157484302;1445.04626946215;1445.219581426018;1447.7321695486369;1452.8304714704764;1475.638468575206;998.7602975285879;1016.4358780876537;1020.0462567499412;1023.1098943918838;1039.9029024379352;5429.239906413105;5431.212474191299;5450.291462109901;5467.851751132307;5472.20653005312;5702.777930469271;5704.600677952503;5719.628224165416;5724.0538217006415;5730.226419433323;5265.631405801557;5494.263900547586;5536.197251398525;5571.832845014656;5620.634658747168;3002.534607135897;3015.42706885691;3025.788194826341;3057.624069168883;3068.2942923127807;5659.377468478464;5886.498942769652;5903.144044113579;5918.023526118229;5964.642121472639;5771.740271687784;5795.362510123883;5799.623024503394;5842.802225543754;5866.3042283362065;5817.941820581825;5855.648661080349;5887.2052272943465;5890.558208134321;5895.174675545512;5597.328320601554;5691.186904773729;5753.712314384347;5820.592558520862;5872.765089396376;5806.216160818235;5810.796622118206;5817.95276850171;5819.301683797971;5820.447057529528;5867.442592953663;5976.193213916065;6079.392060794062;6080.270367555921;6112.38876112403;4242.893927651833;4311.6119549239465;4318.963448772335;4319.26572482685;4319.676024298253;5680.6591604503865;5851.1515830205235;5887.61730487517;5905.173275741314;5915.349311575809;5725.198472213977;5752.6836024019085;5764.50368712405;5783.566232532493;5803.274590676166;5760.33756118035;5761.020626493422;5769.249997500298;5780.624259423124;5808.796692115756;5620.8875822482505;5675.7445914933105;5721.313442386941;5728.541716662574;5740.368559458373;5710.428957104423;5710.543156547549;5726.74229659658;5729.023486897014;5767.7404516796005;5431.864203394946;5602.467765562265;5629.324481062299;5645.830625081254;5668.149777533238 12:17:07 INFO - PROCESS | 26626 | |5;yui.html;798.7173015825883;820.0569345252954;840.6427268410923;929.99535002325;953.4374718915841;16919.661606767873;17884.284628614856;17945.730814037768;17992.460226193234;18119;16562.917185414055;16797.66404671906;17108.657826843457;17252.654946901053;17341.132943352844;830.3481766813053;854.0647990450478;855.2046596665099;855.4354126276659;859.5014891362995;817.9591020448954;838.5136620759976;838.7483754873514;854.5470900422755;858.6522458404356;871.9754288710772;873.6723728601775;877.956102194891;880.9075047120057;883.0198479687542;882.7704796752827;886.171429713217;887.928965682747;888.1163242573648;888.5379602606608;646.1083704487824;646.2600322630561;649.9285078641345;651.563452486835;652.3541693723228;17346.7397989029;17640.91179544107;17744.733828992576;17819.10904454772;18012;15978.840211597968;16163.515094547183;16173.676526469404;16304.918475407547;16316.673666526722;13252.46990120394;13374.933125334408;13454.192748435027;13475.528356507475;13676.111052781636;3954.387070004154;3958.2281455116263;3958.6635136013474;3960.049588098864;4013.3779264213804;84087.15912840854;84548.57725711394;86153.56923215407;86795.56602217011;87637.56181219117;12282.631521054383;12347.19743216688;12386;12393.574738905141;12397.504099836086;22746.09015639389;23444.64833027506;23454.882725586263;23640.527189456458;24163;8723.77198151845;8986.640534378683;9038.954805226063;9174.311926605398;9221;4910;4957.504249575014;5046.167382381939;5074.82238121664;5110;3936.193080418507;3973.4635824163947;3995.9400608990886;4010.438538604598;4029.49631296088;669.394198250584;674.6761554453791;676.7834293026184;684.685044879361;689.0147089661832;832.4464231286127;852.6035393542032;870.216804875617;874.9256313213448;904.3398319226869;11124.833127503094;11150.832737508943;11164.553417863195;11333.603323883624;11702.70743231426;825.4799476329873;844.6114787197835;846.7417437681567;862.4609618988133;867.5662168915542;5389.400051668299;5475.616706830484;5508.91736623951;5537;5564.970480461127;79396.60301698455;81645.18354816375;84546;85827.57086214655;88279;75327;78896.60551697205;79441.60279198567;80177;80995.5950220257;67416.32583674199;67853.3214667847;68763.24947002163;70497;70918.64540677263;10299.176065914558;10620.734481638021;10688.198385120992;10776.730581735519;10781.137508999418;46897.53102468931;46921.53078469171;47022.589322319014;47038.52961470342;47409.81475463141;57126.428735712114;59329.70335148469;60526;60940.69529652501;61997;12530.564477976219;12920.35398230066;13015.739685206054;13107.737845242851;13214.405351759002;14710.264486775404;14856.925715371353;14859.034162779384;15019.399224030916;15939.44211952576;15380.461683841011;15648.4523041693;15774.684506310039;16016.839831601535;16440.67118657644;15366.67762862864;15510.612234694223;15695.215239237765;16031.599210019844;16929.492115236564;14250;14267.357968891218;14352.21062841512;15584.532464026097;15657.982231154938;12387.128835880234;12563.811542826683;12609.68475788076;13080.149790263602;13577.93211033978;12387.504499820267;12589.181703189264;12637.2417654941;12683.936580317039;12737.29944853042 12:17:07 INFO - PROCESS | 26626 | __end_tp_report 12:17:07 INFO - PROCESS | 26626 | __start_cc_report 12:17:07 INFO - PROCESS | 26626 | _x_x_mozilla_cycle_collect,304 12:17:07 INFO - PROCESS | 26626 | __end_cc_report 12:17:07 INFO - PROCESS | 26626 | __startTimestamp1486585027105__endTimestamp 12:17:07 INFO - PROCESS | 26626 | 12:17:07 INFO - PROCESS | 26626 | ------- Summary: start ------- 12:17:07 INFO - PROCESS | 26626 | Number of tests: 6 12:17:07 INFO - PROCESS | 26626 | 12:17:07 INFO - PROCESS | 26626 | [#0] dojo.html Cycles:165 Average:5543.83 Median:5757.86 stddev:612.46 (10.6%) stddev-sans-first:587.70 12:17:07 INFO - PROCESS | 26626 | Values: 3266.2 3290.1 3300.1 3303.6 3308.1 5463.1 5491.5 5505.7 5520.3 5538.2 5582.1 5598.0 5611.8 5627.1 5634.7 5039.7 5080.7 5117.8 5138.9 5177.4 5104.5 5154.9 5155.8 5159.3 5178.6 4912.7 4950.3 5138.8 5142.9 5147.4 4985.7 5054.2 5092.6 5117.1 5174.9 5028.1 5093.7 5097.3 5099.6 5123.0 5364.0 5558.2 5583.0 5674.8 5694.7 5774.6 5777.0 5809.8 5845.8 5915.7 5926.0 5929.1 5935.2 5946.1 5946.6 5546.1 5547.6 5551.5 5551.8 5563.9 5806.7 5807.4 5992.2 5994.6 6060.9 5905.4 5952.4 5962.9 5969.3 5993.1 5976.6 6017.1 6023.8 6028.2 6032.9 5706.3 5738.6 5800.1 6006.9 6026.7 5899.7 5972.8 5981.1 6012.4 6026.5 4628.2 4636.2 4644.0 4644.8 4671.3 4027.1 4029.6 4096.5 4104.0 4131.5 5675.3 5725.1 5757.9 5808.4 5853.9 6009.8 6030.4 6054.6 6063.4 6065.2 5625.5 5648.0 5700.3 5758.2 5762.2 5073.5 5078.6 5091.5 5126.8 5127.1 6144.1 6180.2 6197.6 6200.3 6221.5 5807.4 5841.5 5854.1 5998.3 6005.4 6109.4 6171.4 6185.4 6210.9 6218.0 5844.2 5866.8 5887.6 5890.9 5910.9 5805.7 5998.2 6000.5 6002.3 6020.0 5730.6 5742.7 5816.2 5816.6 5911.4 5877.4 5887.3 5889.7 5892.2 5896.1 5874.3 5875.0 5876.6 5880.6 5888.2 5510.1 5717.2 5756.9 5768.0 5771.5 5680.0 5688.2 5702.7 5707.1 5711.8 12:17:07 INFO - PROCESS | 26626 | 12:17:07 INFO - PROCESS | 26626 | [#1] ext.html Cycles:180 Average:61315.69 Median:379851.00 stddev:115171.65 (30.3%) stddev-sans-first:115404.34 12:17:07 INFO - PROCESS | 26626 | Values: 539.6 606.2 616.8 694.5 719.8 43361.3 44487.7 48583.0 48649.5 49037.5 49418.0 49995.0 50219.5 50562.2 50621.0 9238.7 10630.9 10969.2 10986.6 11319.2 10923.6 10998.3 11006.9 11011.3 11026.2 10949.7 11008.3 11026.7 11060.3 11105.6 10879.0 10949.7 11026.9 11035.6 11037.3 10965.9 11034.5 11063.3 11069.7 11085.6 42256.6 42262.8 42539.4 42573.6 42813.6 4418.2 4440.3 4508.6 4579.7 4584.8 32770.3 32797.2 33591.3 33718.8 34163.5 4759.7 4791.9 4793.2 4800.5 4840.1 378713.0 379682.0 380020.0 381503.0 381848.0 63494.4 63569.4 63877.7 63916.7 64013.7 66034.7 66115.3 66318.7 66530.0 66794.0 17800.2 18093.7 18925.8 19522.0 19582.2 14935.6 15052.4 15125.5 15627.0 15664.0 20170.5 20395.3 20451.0 20491.5 20535.4 7320.9 7472.7 7505.2 7612.8 7659.7 1003.5 1017.2 1028.4 1033.4 1042.0 33851.2 33909.5 33964.2 34069.8 34173.5 1115.5 1189.2 1205.5 1205.7 1231.3 17799.5 17806.3 17865.6 17893.5 17941.3 508742.0 512287.0 513127.0 513745.0 513808.0 69895.7 69911.7 69983.3 70098.0 70686.3 1530.5 1563.6 1572.3 1601.8 1606.6 32786.5 32793.0 33081.0 33100.5 33453.0 57738.0 58443.0 58448.0 58451.4 58467.4 401963.0 404856.0 405024.0 406606.0 407430.0 28518.3 29173.4 29393.7 31344.5 31374.0 47543.8 48067.0 48269.8 48372.3 49195.3 40280.0 40622.0 40919.4 41015.4 42324.6 39704.0 40197.4 41088.0 41204.8 41639.8 39041.8 40165.2 40364.8 40426.2 40564.8 34223.7 34812.8 35856.5 35873.5 35986.5 26643.2 26947.5 27287.2 27617.1 27722.8 12:17:07 INFO - PROCESS | 26626 | 12:17:07 INFO - PROCESS | 26626 | [#2] jquery.html Cycles:180 Average:39868.91 Median:22703.99 stddev:129489.89 (570.3%) stddev-sans-first:129819.27 12:17:07 INFO - PROCESS | 26626 | Values: 426.6 439.3 446.6 450.2 456.1 20128.8 21338.7 22545.3 22633.4 22789.0 21964.3 22774.5 22858.0 22953.4 23594.6 6102.5 6116.2 6305.2 6343.2 6345.3 6054.3 6148.4 6196.5 6204.1 6232.2 6018.2 6025.2 6147.9 6170.6 6192.0 6084.2 6126.6 6130.4 6136.1 6169.1 5427.0 5490.6 5526.0 5545.1 5572.4 25897.7 26161.9 26188.1 26478.5 26500.3 3252.9 3312.7 3323.2 3377.7 3407.1 16052.9 16112.6 16218.0 16351.0 16946.6 2034.8 2051.9 2059.6 2073.2 2081.6 95200.5 95700.5 96204.0 98459.0 99124.5 11547.6 11799.9 11860.1 11906.2 12180.4 16689.6 16691.8 16740.1 16764.2 16799.7 9146.6 9552.2 9566.8 9591.7 9756.2 9357.3 9425.6 9469.0 9473.1 9521.9 7588.5 7608.7 7841.8 7853.5 8031.8 2017.3 2018.8 2062.5 2096.1 2178.0 1131.5 1150.2 1179.7 1185.8 1194.2 21287.0 21355.7 21357.7 21520.1 21534.8 1023.2 1055.5 1061.7 1087.5 1194.3 10736.6 11505.3 11535.6 11604.2 11611.9 778559.0 778895.0 784187.0 797109.0 806838.0 114567.0 114970.0 117876.0 118001.4 121716.0 1224.5 1242.2 1244.4 1246.8 1246.8 17327.3 18066.6 18184.3 18184.5 18247.0 44668.6 45639.0 45848.3 46304.3 46792.3 67641.3 67776.0 67811.7 68499.3 68898.7 9697.5 9722.8 9803.3 9820.8 9942.4 12457.9 14372.4 14570.1 14591.9 14918.4 12122.2 12153.3 12302.6 12458.8 12562.6 12313.3 12390.2 12482.0 12594.7 12706.0 8941.4 12368.8 12676.1 12754.7 12839.1 9656.9 9871.8 9999.4 10016.8 10047.3 10275.9 12359.8 12675.2 12685.0 12812.2 12:17:07 INFO - PROCESS | 26626 | 12:17:07 INFO - PROCESS | 26626 | [#3] mootools.html Cycles:180 Average:5962.38 Median:5173.53 stddev:3334.66 (64.5%) stddev-sans-first:3327.36 12:17:07 INFO - PROCESS | 26626 | Values: 1526.9 1530.5 1541.8 1547.2 1565.3 8621.3 8644.9 8822.7 9203.2 9208.4 9272.5 9384.0 9403.7 9416.8 9426.3 2390.3 2435.7 2436.6 2437.2 2451.7 2329.4 2380.2 2386.1 2386.1 2392.0 2476.8 2488.9 2501.8 2502.2 2504.5 2424.8 2440.2 2452.5 2459.6 2464.5 2316.8 2323.0 2330.2 2339.6 2404.8 9137.8 9191.7 9198.2 9231.9 9235.0 5399.1 5440.5 5486.7 5528.8 5550.4 3479.4 3549.6 3622.1 3758.0 3800.5 1411.5 1428.8 1439.4 1446.2 1548.8 12516.8 12533.7 12570.3 12654.6 12659.1 4445.9 4626.2 4690.2 4747.1 4793.9 9851.3 9851.7 9883.3 9884.0 9900.4 5494.3 5533.4 5541.8 5548.8 5563.3 4989.2 5122.4 5150.4 5196.6 5260.7 3979.5 4068.9 4085.7 4136.0 4136.8 1281.9 1290.1 1290.6 1292.8 1294.6 1036.3 1046.0 1056.5 1067.2 1076.0 6127.9 6172.7 6202.8 6260.6 6332.7 661.5 673.1 677.4 679.7 688.4 4066.0 4180.6 4273.1 4296.2 4406.5 10787.5 11087.8 11093.9 11155.0 11171.6 11055.5 11062.6 11068.7 11152.6 11163.2 8255.3 8488.1 8540.4 8638.8 8718.3 6099.6 6120.5 6256.3 6325.7 6383.1 9932.8 9987.3 10188.1 10194.8 10204.9 10468.9 10507.5 10564.6 10566.8 10574.4 7783.6 7910.1 7945.6 8081.0 8109.9 8689.2 8699.2 8740.4 8744.3 8818.5 7338.2 7452.1 7560.5 7572.7 7597.1 7740.5 7745.8 7800.6 7879.1 7965.0 7085.6 7089.6 7096.1 7159.4 7240.8 5279.4 5324.0 5373.3 5384.2 5438.2 5363.9 5445.2 5537.7 5538.7 5582.0 12:17:07 INFO - PROCESS | 26626 | 12:17:07 INFO - PROCESS | 26626 | [#4] prototype.html Cycles:180 Average:4830.63 Median:5441.08 stddev:1378.15 (25.3%) stddev-sans-first:1341.57 12:17:07 INFO - PROCESS | 26626 | Values: 414.9 415.2 428.0 429.0 430.5 5278.7 5321.6 5424.4 5478.7 5504.9 5254.5 5364.6 5386.9 5390.5 5401.5 4220.4 4239.8 4305.7 4334.4 4350.7 4302.6 4330.2 4337.9 4339.3 4354.3 4319.2 4333.6 4338.7 4347.3 4365.0 4203.9 4277.4 4345.0 4367.7 4368.3 3915.6 3922.8 3925.5 3942.5 3957.0 5290.9 5301.4 5316.3 5330.3 5346.9 4980.3 5011.9 5073.8 5078.4 5090.7 5699.3 5752.0 5756.6 5763.5 5766.7 4385.8 4403.3 4403.6 4411.5 4430.3 5563.9 5879.6 5914.3 5936.8 5964.3 4253.0 4259.4 4264.9 4291.7 4314.4 4298.9 4304.3 4306.6 4316.2 4327.7 4672.8 4873.7 4894.9 4906.3 4915.4 5565.7 5660.8 5673.8 5737.2 5748.4 1445.0 1445.2 1447.7 1452.8 1475.6 998.8 1016.4 1020.0 1023.1 1039.9 5429.2 5431.2 5450.3 5467.9 5472.2 5702.8 5704.6 5719.6 5724.1 5730.2 5265.6 5494.3 5536.2 5571.8 5620.6 3002.5 3015.4 3025.8 3057.6 3068.3 5659.4 5886.5 5903.1 5918.0 5964.6 5771.7 5795.4 5799.6 5842.8 5866.3 5817.9 5855.6 5887.2 5890.6 5895.2 5597.3 5691.2 5753.7 5820.6 5872.8 5806.2 5810.8 5818.0 5819.3 5820.4 5867.4 5976.2 6079.4 6080.3 6112.4 4242.9 4311.6 4319.0 4319.3 4319.7 5680.7 5851.2 5887.6 5905.2 5915.3 5725.2 5752.7 5764.5 5783.6 5803.3 5760.3 5761.0 5769.2 5780.6 5808.8 5620.9 5675.7 5721.3 5728.5 5740.4 5710.4 5710.5 5726.7 5729.0 5767.7 5431.9 5602.5 5629.3 5645.8 5668.1 12:17:07 INFO - PROCESS | 26626 | 12:17:07 INFO - PROCESS | 26626 | [#5] yui.html Cycles:180 Average:19437.02 Median:46909.53 stddev:24553.62 (52.3%) stddev-sans-first:24582.61 12:17:07 INFO - PROCESS | 26626 | Values: 798.7 820.1 840.6 930.0 953.4 16919.7 17884.3 17945.7 17992.5 18119.0 16562.9 16797.7 17108.7 17252.7 17341.1 830.3 854.1 855.2 855.4 859.5 818.0 838.5 838.7 854.5 858.7 872.0 873.7 878.0 880.9 883.0 882.8 886.2 887.9 888.1 888.5 646.1 646.3 649.9 651.6 652.4 17346.7 17640.9 17744.7 17819.1 18012.0 15978.8 16163.5 16173.7 16304.9 16316.7 13252.5 13374.9 13454.2 13475.5 13676.1 3954.4 3958.2 3958.7 3960.0 4013.4 84087.2 84548.6 86153.6 86795.6 87637.6 12282.6 12347.2 12386.0 12393.6 12397.5 22746.1 23444.6 23454.9 23640.5 24163.0 8723.8 8986.6 9039.0 9174.3 9221.0 4910.0 4957.5 5046.2 5074.8 5110.0 3936.2 3973.5 3995.9 4010.4 4029.5 669.4 674.7 676.8 684.7 689.0 832.4 852.6 870.2 874.9 904.3 11124.8 11150.8 11164.6 11333.6 11702.7 825.5 844.6 846.7 862.5 867.6 5389.4 5475.6 5508.9 5537.0 5565.0 79396.6 81645.2 84546.0 85827.6 88279.0 75327.0 78896.6 79441.6 80177.0 80995.6 67416.3 67853.3 68763.2 70497.0 70918.6 10299.2 10620.7 10688.2 10776.7 10781.1 46897.5 46921.5 47022.6 47038.5 47409.8 57126.4 59329.7 60526.0 60940.7 61997.0 12530.6 12920.4 13015.7 13107.7 13214.4 14710.3 14856.9 14859.0 15019.4 15939.4 15380.5 15648.5 15774.7 16016.8 16440.7 15366.7 15510.6 15695.2 16031.6 16929.5 14250.0 14267.4 14352.2 15584.5 15658.0 12387.1 12563.8 12609.7 13080.1 13577.9 12387.5 12589.2 12637.2 12683.9 12737.3 12:17:07 INFO - PROCESS | 26626 | -------- Summary: end -------- 12:17:07 INFO - PROCESS | 26626 | 12:17:07 INFO - TEST-INFO | 26626: exit 0 12:17:07 INFO - TEST-OK | dromaeo_css | took 1112856ms 12:17:07 INFO - TEST-START | kraken 12:17:07 INFO - operating with platform_type : linux_ 12:17:07 INFO - Initialising browser for kraken test... 12:17:07 INFO - TEST-INFO | started process 26996 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZZfC2z/profile http://localhost:40409/getInfo.html) 12:17:12 INFO - PROCESS | 26996 | __metrics Screen width/height:1600/1200 12:17:12 INFO - PROCESS | 26996 | colorDepth:24 12:17:12 INFO - PROCESS | 26996 | Browser inner width/height: 1024/697 12:17:12 INFO - PROCESS | 26996 | __metrics 12:17:13 INFO - PROCESS | 26996 | 1486585033090 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpZZfC2z/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpZZfC2z/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpZZfC2z/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpZZfC2z/profile/extensions/talos-powers@TalosPowersService.js:55:9 12:17:13 ERROR - PROCESS | 26996 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 12:17:14 INFO - TEST-INFO | 26996: exit 0 12:17:14 INFO - Browser initialized. 12:17:14 INFO - Running cycle 1/1 for kraken test... 12:17:14 INFO - TEST-INFO | started process 27123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZZfC2z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:17:26 INFO - PROCESS | 27123 | RSS: Main: 144822272 12:17:26 INFO - PROCESS | 27123 | 12:17:28 INFO - PROCESS | 27123 | Cycle 1(1): loaded http://localhost:40409/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40409/tests/kraken/driver.html?testName=audio-beat-detection) 12:17:29 INFO - PROCESS | 27123 | RSS: Main: 151449600 12:17:29 INFO - PROCESS | 27123 | 12:17:32 INFO - PROCESS | 27123 | Cycle 1(1): loaded http://localhost:40409/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40409/tests/kraken/driver.html?testName=audio-dft) 12:17:32 INFO - PROCESS | 27123 | RSS: Main: 150634496 12:17:32 INFO - PROCESS | 27123 | 12:17:35 INFO - PROCESS | 27123 | Cycle 1(1): loaded http://localhost:40409/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40409/tests/kraken/driver.html?testName=audio-fft) 12:17:36 INFO - PROCESS | 27123 | RSS: Main: 150855680 12:17:36 INFO - PROCESS | 27123 | 12:17:38 INFO - PROCESS | 27123 | Cycle 1(1): loaded http://localhost:40409/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40409/tests/kraken/driver.html?testName=audio-oscillator) 12:17:38 INFO - PROCESS | 27123 | RSS: Main: 150310912 12:17:38 INFO - PROCESS | 27123 | 12:17:40 INFO - PROCESS | 27123 | Cycle 1(1): loaded http://localhost:40409/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40409/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:17:41 INFO - PROCESS | 27123 | RSS: Main: 150175744 12:17:41 INFO - PROCESS | 27123 | 12:17:44 INFO - PROCESS | 27123 | Cycle 1(1): loaded http://localhost:40409/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40409/tests/kraken/driver.html?testName=imaging-darkroom) 12:17:45 INFO - PROCESS | 27123 | RSS: Main: 153378816 12:17:45 INFO - PROCESS | 27123 | 12:17:48 INFO - PROCESS | 27123 | Cycle 1(1): loaded http://localhost:40409/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40409/tests/kraken/driver.html?testName=imaging-desaturate) 12:17:49 INFO - PROCESS | 27123 | RSS: Main: 153669632 12:17:49 INFO - PROCESS | 27123 | 12:17:51 INFO - PROCESS | 27123 | Cycle 1(1): loaded http://localhost:40409/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40409/tests/kraken/driver.html?testName=json-parse-financial) 12:17:52 INFO - PROCESS | 27123 | RSS: Main: 153026560 12:17:52 INFO - PROCESS | 27123 | 12:17:54 INFO - PROCESS | 27123 | Cycle 1(1): loaded http://localhost:40409/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40409/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:17:54 INFO - PROCESS | 27123 | RSS: Main: 152219648 12:17:54 INFO - PROCESS | 27123 | 12:17:56 INFO - PROCESS | 27123 | Cycle 1(1): loaded http://localhost:40409/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40409/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:17:57 INFO - PROCESS | 27123 | RSS: Main: 152481792 12:17:57 INFO - PROCESS | 27123 | 12:17:59 INFO - PROCESS | 27123 | Cycle 1(1): loaded http://localhost:40409/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40409/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:17:59 INFO - PROCESS | 27123 | RSS: Main: 152637440 12:17:59 INFO - PROCESS | 27123 | 12:18:02 INFO - PROCESS | 27123 | Cycle 1(1): loaded http://localhost:40409/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:18:03 INFO - PROCESS | 27123 | RSS: Main: 153174016 12:18:03 INFO - PROCESS | 27123 | 12:18:05 INFO - PROCESS | 27123 | Cycle 1(1): loaded http://localhost:40409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:18:06 INFO - PROCESS | 27123 | RSS: Main: 153440256 12:18:06 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | Cycle 1(1): loaded http://localhost:40409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40409/tests/kraken/driver.html?testName=ai-astar) 12:18:08 INFO - PROCESS | 27123 | RSS: Main: 155115520 12:18:08 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | __start_tp_report 12:18:08 INFO - PROCESS | 27123 | _x_x_mozilla_page_load 12:18:08 INFO - PROCESS | 27123 | _x_x_mozilla_page_load_details 12:18:08 INFO - PROCESS | 27123 | |i|pagename|runs| 12:18:08 INFO - PROCESS | 27123 | |0;ai-astar;103;113;114;115;113;114;113;112;112;113 12:18:08 INFO - PROCESS | 27123 | |1;audio-beat-detection;144;119;119;154;120;120;118;124;140;119 12:18:08 INFO - PROCESS | 27123 | |2;audio-dft;162;161;163;162;163;161;159;161;161;161 12:18:08 INFO - PROCESS | 27123 | |3;audio-fft;75;77;76;110;76;76;75;77;92;77 12:18:08 INFO - PROCESS | 27123 | |4;audio-oscillator;83;82;99;82;83;83;94;83;83;112 12:18:08 INFO - PROCESS | 27123 | |5;imaging-gaussian-blur;118;119;117;118;118;118;117;118;117;119 12:18:08 INFO - PROCESS | 27123 | |6;imaging-darkroom;148;146;146;147;148;147;147;146;147;147 12:18:08 INFO - PROCESS | 27123 | |7;imaging-desaturate;96;96;97;96;97;97;96;101;96;96 12:18:08 INFO - PROCESS | 27123 | |8;json-parse-financial;55;56;60;57;60;58;55;56;57;58 12:18:08 INFO - PROCESS | 27123 | |9;json-stringify-tinderbox;64;63;63;63;64;64;63;64;63;64 12:18:08 INFO - PROCESS | 27123 | |10;stanford-crypto-aes;77;77;78;77;76;77;77;76;79;77 12:18:08 INFO - PROCESS | 27123 | |11;stanford-crypto-ccm;124;122;131;130;121;129;121;126;156;125 12:18:08 INFO - PROCESS | 27123 | |12;stanford-crypto-pbkdf2;165;156;154;160;158;156;153;161;155;159 12:18:08 INFO - PROCESS | 27123 | |13;stanford-crypto-sha256-iterative;63;65;62;61;63;61;61;59;61;66 12:18:08 INFO - PROCESS | 27123 | __end_tp_report 12:18:08 INFO - PROCESS | 27123 | __start_cc_report 12:18:08 INFO - PROCESS | 27123 | _x_x_mozilla_cycle_collect,703 12:18:08 INFO - PROCESS | 27123 | __end_cc_report 12:18:08 INFO - PROCESS | 27123 | __startTimestamp1486585088323__endTimestamp 12:18:08 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | ------- Summary: start ------- 12:18:08 INFO - PROCESS | 27123 | Number of tests: 14 12:18:08 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:3.36 (3.0%) stddev-sans-first:0.97 12:18:08 INFO - PROCESS | 27123 | Values: 103.0 113.0 114.0 115.0 113.0 114.0 113.0 112.0 112.0 113.0 12:18:08 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:122.00 stddev:13.17 (10.8%) stddev-sans-first:12.58 12:18:08 INFO - PROCESS | 27123 | Values: 144.0 119.0 119.0 154.0 120.0 120.0 118.0 124.0 140.0 119.0 12:18:08 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 12:18:08 INFO - PROCESS | 27123 | Values: 162.0 161.0 163.0 162.0 163.0 161.0 159.0 161.0 161.0 161.0 12:18:08 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.50 stddev:11.34 (14.8%) stddev-sans-first:11.81 12:18:08 INFO - PROCESS | 27123 | Values: 75.0 77.0 76.0 110.0 76.0 76.0 75.0 77.0 92.0 77.0 12:18:08 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:83.00 stddev:10.16 (12.2%) stddev-sans-first:10.58 12:18:08 INFO - PROCESS | 27123 | Values: 83.0 82.0 99.0 82.0 83.0 83.0 94.0 83.0 83.0 112.0 12:18:08 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 12:18:08 INFO - PROCESS | 27123 | Values: 118.0 119.0 117.0 118.0 118.0 118.0 117.0 118.0 117.0 119.0 12:18:08 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 12:18:08 INFO - PROCESS | 27123 | Values: 148.0 146.0 146.0 147.0 148.0 147.0 147.0 146.0 147.0 147.0 12:18:08 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.55 (1.6%) stddev-sans-first:1.62 12:18:08 INFO - PROCESS | 27123 | Values: 96.0 96.0 97.0 96.0 97.0 97.0 96.0 101.0 96.0 96.0 12:18:08 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:1.81 (3.2%) stddev-sans-first:1.74 12:18:08 INFO - PROCESS | 27123 | Values: 55.0 56.0 60.0 57.0 60.0 58.0 55.0 56.0 57.0 58.0 12:18:08 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:64.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 12:18:08 INFO - PROCESS | 27123 | Values: 64.0 63.0 63.0 63.0 64.0 64.0 63.0 64.0 63.0 64.0 12:18:08 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:77.00 stddev:0.88 (1.1%) stddev-sans-first:0.93 12:18:08 INFO - PROCESS | 27123 | Values: 77.0 77.0 78.0 77.0 76.0 77.0 77.0 76.0 79.0 77.0 12:18:08 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:127.50 stddev:10.32 (8.1%) stddev-sans-first:10.82 12:18:08 INFO - PROCESS | 27123 | Values: 124.0 122.0 131.0 130.0 121.0 129.0 121.0 126.0 156.0 125.0 12:18:08 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:158.50 stddev:3.65 (2.3%) stddev-sans-first:2.76 12:18:08 INFO - PROCESS | 27123 | Values: 165.0 156.0 154.0 160.0 158.0 156.0 153.0 161.0 155.0 159.0 12:18:08 INFO - PROCESS | 27123 | 12:18:08 INFO - PROCESS | 27123 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.50 stddev:2.10 (3.4%) stddev-sans-first:2.20 12:18:08 INFO - PROCESS | 27123 | Values: 63.0 65.0 62.0 61.0 63.0 61.0 61.0 59.0 61.0 66.0 12:18:08 INFO - PROCESS | 27123 | -------- Summary: end -------- 12:18:08 INFO - PROCESS | 27123 | 12:18:09 INFO - TEST-INFO | 27123: exit 0 12:18:09 INFO - TEST-OK | kraken | took 61448ms 12:18:09 INFO - SUITE-END | took 1174s 12:18:09 INFO - Completed test suite (00:19:34) 12:18:09 INFO - javascript benchmark 12:18:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7741.506099403255, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3266.2487627845594, 3290.144562413772, 3300.141963089596, 3303.6365999740024, 3308.1398836302556, 5463.098588732859, 5491.478309560595, 5505.6696598204135, 5520.282363292771, 5538.169274608811, 5582.106862901936, 5598.0, 5611.849570837979, 5627.099664053752, 5634.746436410361, 5039.6976181429045, 5080.720560369178, 5117.8464646060675, 5138.897222055575, 5177.378714554259, 5104.464031276718, 5154.948450515484, 5155.793768249266, 5159.251908473269, 5178.559822415099, 4912.680675756064, 4950.257461380804, 5138.768755405997, 5142.871428214287, 5147.4080480744815, 4985.651004429691, 5054.191329387317, 5092.6180536459915, 5117.078925793356, 5174.922376164361, 5028.145215313405, 5093.694378337274, 5097.3118628984985, 5099.617528685363, 5123.0, 5364.0, 5558.249636299089, 5583.0, 5674.829755107354, 5694.715264236813, 5774.595778295521, 5777.046787280094, 5809.796657116981, 5845.766169353221, 5915.733791979371, 5925.992581261196, 5929.14027466015, 5935.228420305376, 5946.07835785454, 5946.583739138262, 5546.112621980504, 5547.583931205136, 5551.528120109796, 5551.750171242304, 5563.944360556424, 5806.65160090396, 5807.390224026501, 5992.161097446361, 5994.550408719363, 6060.878782424415, 5905.438983296666, 5952.375000624958, 5962.850928726816, 5969.343372229051, 5993.101034844721, 5976.6115202512565, 6017.1275165100815, 6023.849403764941, 6028.156058151862, 6032.939670603326, 5706.28671416073, 5738.569607279471, 5800.071988481907, 6006.879862402815, 6026.728797204137, 5899.7050147492455, 5972.790952316648, 5981.0729336952845, 6012.398760123952, 6026.487748541335, 4628.190066738307, 4636.188666983332, 4643.95356046442, 4644.790984405709, 4671.299305104261, 4027.134166154291, 4029.5970402960056, 4096.528899176573, 4104.0, 4131.462909821704, 5675.290588676416, 5725.141228815711, 5757.8560535986935, 5808.419158084243, 5853.882922341614, 6009.849753756191, 6030.366811484819, 6054.636721796706, 6063.363346848606, 6065.211522502046, 5625.46558076982, 5648.039833228278, 5700.344460387026, 5758.193852860602, 5762.164486149485, 5073.543381095719, 5078.619103567247, 5091.516305950929, 5126.79492820283, 5127.128388174019, 6144.078388241799, 6180.227471566054, 6197.628142311476, 6200.255969283625, 6221.5333849960525, 5807.361190269152, 5841.50347220491, 5854.063349864172, 5998.310194327533, 6005.399460054135, 6109.358517355614, 6171.352008039091, 6185.41238582334, 6210.937890621217, 6218.0, 5844.240248767633, 5866.823995280149, 5887.558433117619, 5890.852728681646, 5910.940890591039, 5805.680687562224, 5998.190244316961, 6000.459958603747, 6002.309734380602, 6020.0, 5730.570207234391, 5742.741576628978, 5816.1857339973285, 5816.563757718272, 5911.379305172895, 5877.441643043904, 5887.322957859729, 5889.676067816311, 5892.204552385373, 5896.056630939029, 5874.295084589877, 5874.970625146847, 5876.6180198286975, 5880.617759845596, 5888.205092312654, 5510.1459273812625, 5717.22817419643, 5756.884862302647, 5768.0, 5771.480566749013, 5680.0, 5688.175214593778, 5702.657840529581, 5707.1153971134545, 5711.828645140652], "value": 5503.874692049601, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.5558121708661, 606.2421972534332, 616.7964571691341, 694.4617921111142, 719.8272414620493, 43361.34957975633, 44487.66537003887, 48583.0, 48649.51350486494, 49037.50962490374, 49418.0, 49995.0, 50219.49780502203, 50562.24156637644, 50621.0, 9238.722838314861, 10630.893691063067, 10969.177311701615, 10986.560537578487, 11319.20765546412, 10923.563057477691, 10998.285111467769, 11006.889931100706, 11011.339319640807, 11026.228164028522, 10949.726256843564, 11008.339499630009, 11026.669199923976, 11060.336379817196, 11105.55577776888, 10879.0, 10949.671509854717, 11026.889731102667, 11035.613753518628, 11037.282576632533, 10965.945170274177, 11034.503447344889, 11063.280886742335, 11069.667909962714, 11085.556577736881, 42256.57743422557, 42262.788686056374, 42539.36190957138, 42573.57426425758, 42813.57186428127, 4418.182636212279, 4440.2895536714295, 4508.639308855284, 4579.656525760548, 4584.839530616412, 32770.344593108246, 32797.18007049843, 33591.32817343664, 33718.83140584306, 34163.487547686804, 4759.666823322369, 4791.928121078186, 4793.209120495114, 4800.543948324904, 4840.128776820206, 378713.0, 379682.0, 380020.0, 381503.0, 381848.0, 63494.36505634885, 63569.36430635634, 63877.68061159665, 63916.68041659762, 64013.67993160005, 66034.66982665056, 66115.33884661092, 66318.66840665862, 66530.0, 66794.0, 17800.198991045436, 18093.7285940711, 18925.81074189268, 19522.023898805288, 19582.216711331672, 14935.551933442013, 15052.397904083715, 15125.470608528869, 15627.0, 15664.0, 20170.495737606678, 20395.286164984453, 20451.0, 20491.4877128073, 20535.38393848187, 7320.926790732131, 7472.70109195637, 7505.24947505256, 7612.8477430451085, 7659.693612255559, 1003.5333569890037, 1017.2065788684838, 1028.3983869436313, 1033.4419413516616, 1042.0413219837617, 33851.153721156676, 33909.49135762965, 33964.150896227795, 34069.829650851585, 34173.48739768905, 1115.5426275227119, 1189.1972918280126, 1205.4635687119323, 1205.698575356161, 1231.2920070959235, 17799.46601601954, 17806.287748489915, 17865.642687146443, 17893.463196104138, 17941.282348706165, 508742.0, 512287.0, 513127.0, 513745.0, 513808.0, 69895.65052174707, 69911.65044174746, 69983.3001669987, 70098.0, 70686.29313706797, 1530.4872867589258, 1563.5622025832786, 1572.2688949638473, 1601.7757513948056, 1606.6465377616905, 32786.50820237746, 32793.0, 33081.0, 33100.503492448115, 33453.0, 57738.0, 58443.0, 58448.0, 58451.4154858446, 58467.415325846196, 401963.0, 404856.0, 405024.0, 406606.0, 407430.0, 28518.287042823264, 29173.41653166967, 29393.706062939098, 31344.529832052995, 31374.0, 47543.76228118837, 48067.0, 48269.75865120652, 48372.274415884494, 49195.26207106968, 40280.0, 40622.0, 40919.38620920629, 41015.38476922908, 42324.57675423206, 39704.0, 40197.39703904502, 41088.0, 41204.79397603113, 41639.7918010408, 39041.80479097586, 40165.1966960665, 40364.79817600893, 40426.1914761709, 40564.79717601511, 34223.657763422045, 34812.82593587016, 35856.4621530672, 35873.46189807207, 35986.46020309645, 26643.200703978913, 26947.461050779268, 27287.181384558495, 27617.066805323433, 27722.752476139027], "value": 21810.99285577368, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.6117832772178, 439.2883528683531, 446.61814148902675, 450.1761775950012, 456.1447286338116, 20128.798712012893, 21338.679919801216, 22545.323640290797, 22633.434164145903, 22789.0, 21964.341069767892, 22774.544509109808, 22858.0, 22953.4261643459, 23594.64608030881, 6102.542309326796, 6116.204893363856, 6305.211848518935, 6343.207099112611, 6345.333739957307, 6054.273487181545, 6148.385161483839, 6196.473299769525, 6204.069389591552, 6232.158658581079, 6018.217631707894, 6025.166395577414, 6147.938520614782, 6170.568060235785, 6191.969040154793, 6084.239470066242, 6126.632402055869, 6130.448259656608, 6136.140940268321, 6169.10547970544, 5427.0, 5490.6431081979945, 5526.032944234743, 5545.140503222007, 5572.3870374258795, 25897.741022589722, 26161.869190654113, 26188.08341708031, 26478.470430591282, 26500.337491562674, 3252.886148984774, 3312.7184189343934, 3323.18581947422, 3377.7297816174646, 3407.0800883761244, 16052.919735401365, 16112.59718507035, 16218.0, 16351.0, 16946.576335591584, 2034.8168664820237, 2051.887146206958, 2059.6086743518686, 2073.2018173003503, 2081.6149012432747, 95200.52399737957, 95700.52149739277, 96204.0, 98459.0, 99124.50437747837, 11547.595834145932, 11799.88200118005, 11860.05119590448, 11906.166568340133, 12180.390980450942, 16689.582760431087, 16691.833081669272, 16740.079295638614, 16764.161791910356, 16799.748003779954, 9146.63413463454, 9552.235821134293, 9566.808663826685, 9591.712248632552, 9756.170725488271, 9357.251419886392, 9425.575849086808, 9469.0, 9473.100055494717, 9521.90478095224, 7588.506747061423, 7608.657610407545, 7841.803954901173, 7853.450258481966, 8031.839363212703, 2017.253616162, 2018.7678416982235, 2062.4946888012532, 2096.0986775686297, 2177.967330490044, 1131.5247596009697, 1150.19792366868, 1179.6696924861053, 1185.8221266810046, 1194.199886076331, 21287.0, 21355.67966480473, 21357.67963480549, 21520.139194432046, 21534.78465215359, 1023.2223510132353, 1055.456439933435, 1061.7398737309409, 1087.4617064553097, 1194.2714943884223, 10736.624218152327, 11505.252158609663, 11535.596254131066, 11604.187706860439, 11611.88388116125, 778559.0, 778895.0, 784187.0, 797109.0, 806838.0, 114567.0, 114970.0, 117876.0, 118001.4099929512, 121716.0, 1224.5407972010496, 1242.2298175131477, 1244.3591550351575, 1246.7568824079399, 1246.8316777235138, 17327.306907724054, 18066.638667226318, 18184.272629095216, 18184.545386365447, 18247.0, 44668.55331446774, 45639.0, 45848.31227531523, 46304.305435417824, 46792.298115528974, 67641.32358676351, 67776.0, 67811.66094169498, 68499.31500685129, 68898.65550672215, 9697.5151242439, 9722.756931076497, 9803.313768036169, 9820.803583928424, 9942.403455792675, 12457.937710311753, 14372.35324410425, 14570.05294655844, 14591.854081459049, 14918.403263869757, 12122.15144939881, 12153.270803751802, 12302.569410070604, 12458.813117803058, 12562.623121306375, 12313.32276724753, 12390.194637348544, 12482.0, 12594.685132871751, 12706.047046471736, 8941.37410381267, 12368.81446778317, 12676.112672112864, 12754.744905101661, 12839.101262911507, 9656.855147172657, 9871.753206169904, 9999.35004224752, 10016.799664006534, 10047.274873875818, 10275.948620256851, 12359.814602781145, 12675.17611355259, 12685.0, 12812.167209131376], "value": 10628.325790334628, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1526.8931174817767, 1530.5484881959828, 1541.791858099157, 1547.2031903569664, 1565.3425561264264, 8621.267192288655, 8644.913550864505, 8822.691205807798, 9203.217726493247, 9208.447493150406, 9272.536373181347, 9383.953080234607, 9403.71788846334, 9416.764580885481, 9426.34015618907, 2390.3307074019217, 2435.6711843901026, 2436.561418944589, 2437.171361737009, 2451.705795304557, 2329.4176455886027, 2380.1669415704537, 2386.069432921162, 2386.0813586769045, 2392.031227352925, 2476.826622136442, 2488.9004439822475, 2501.7873480754065, 2502.249325202432, 2504.524140413325, 2424.7575242475787, 2440.2191298784396, 2452.460458699083, 2459.6064629659168, 2464.4578192797558, 2316.7567405422524, 2323.0, 2330.1844354475966, 2339.6256598944087, 2404.7715467030603, 9137.817243655156, 9191.724248272496, 9198.17216450516, 9231.90768092324, 9234.95382523083, 5399.1091469907415, 5440.483154100394, 5486.698231597261, 5528.834134975958, 5550.4449555044575, 3479.391106556368, 3549.5563054618174, 3622.1125824173246, 3758.0, 3800.4869342638945, 1411.5200831717164, 1428.8356838963443, 1439.3954539093606, 1446.2184415184772, 1548.7676848472706, 12516.812247816199, 12533.74932501354, 12570.30863302518, 12654.620361389174, 12659.113862029662, 4445.911081778411, 4626.190416677068, 4690.15577196108, 4747.1486120413065, 4793.9041219176115, 9851.310408271496, 9851.655192068243, 9883.258755593359, 9883.950580247052, 9900.356476828983, 5494.340679118532, 5533.391326954032, 5541.778328866801, 5548.750306236229, 5563.276774019432, 4989.17678583037, 5122.436531981479, 5150.433452320317, 5196.636235463481, 5260.6843589384, 3979.542352629485, 4068.9186216275507, 4085.7140000200293, 4136.028033412145, 4136.751794892316, 1281.9294938778457, 1290.148501988683, 1290.6128161551496, 1292.780227361332, 1294.566320282697, 1036.3367444835312, 1045.968620941373, 1056.4559251985233, 1067.2209287220373, 1075.983860242097, 6127.877442451126, 6172.660503672341, 6202.82146392184, 6260.593061450991, 6332.651704156224, 661.5336187987457, 673.1316601584, 677.3598948993155, 679.7383007542132, 688.3563867783638, 4066.044479547304, 4180.602842729936, 4273.081287523198, 4296.226679197712, 4406.515283318832, 10787.460626968621, 11087.83368249477, 11093.889061109447, 11155.0, 11171.608993685344, 11055.502502387411, 11062.612808551663, 11068.723281918017, 11152.553897843994, 11163.218574699693, 8255.339572834158, 8488.10874858131, 8540.444871083484, 8638.784030399165, 8718.302535797122, 6099.573029887865, 6120.510359171345, 6256.343083976117, 6325.746970121328, 6383.0744542042075, 9932.801343972935, 9987.250956178461, 10188.083072523508, 10194.847077293698, 10204.897951020395, 10468.947655261674, 10507.527161277609, 10564.630237941636, 10566.788664226518, 10574.365538067741, 7783.571903545359, 7910.129885712452, 7945.642446090055, 8081.030276366873, 8109.878351824609, 8689.217970382695, 8699.173578510032, 8740.388172827841, 8744.300455963636, 8818.470891746516, 7338.229485903903, 7452.06849143857, 7560.546367217985, 7572.734954276574, 7597.088349398107, 7740.496867703581, 7745.7676269712, 7800.6099695016155, 7879.133295337394, 7964.960175199319, 7085.57486550788, 7089.574625522485, 7096.148462184571, 7159.355657990805, 7240.818979525554, 5279.419263880894, 5324.041672498987, 5373.328333958255, 5384.219288203267, 5438.18427235902, 5363.892722145457, 5445.2104444854485, 5537.667739935617, 5538.667679939216, 5581.972090139523], "value": 4775.533728358628, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.8817586987708, 415.1541185175621, 428.0262403033099, 428.9699721019526, 430.4963193064113, 5278.736063196834, 5321.6318738161535, 5424.403315635282, 5478.698946442489, 5504.944950550494, 5254.479498735846, 5364.597655175858, 5386.946130538693, 5390.460953904608, 5401.459854014596, 4220.430241917348, 4239.809208585606, 4305.677074219446, 4334.41485399471, 4350.73895566267, 4302.591253830881, 4330.155619654169, 4337.913241735163, 4339.305711086226, 4354.259775838115, 4319.214106901047, 4333.60997510224, 4338.652907767387, 4347.260965635834, 4364.956350436502, 4203.894902627459, 4277.422547956017, 4345.0, 4367.650587952956, 4368.322909948947, 3915.569287378386, 3922.8430862765454, 3925.450436938831, 3942.526896772377, 3957.0, 5290.867728306785, 5301.443348448434, 5316.282301889273, 5330.28041214435, 5346.866328341784, 4980.2778597103215, 5011.924821127686, 5073.797048118071, 5078.4159821620615, 5090.669106508102, 5699.316082070137, 5751.971240143815, 5756.625819321731, 5763.538916886681, 5766.740496677659, 4385.8245670173155, 4403.2954727243805, 4403.647708183337, 4411.492678342, 4430.335449682541, 5563.860903477445, 5879.618289701916, 5914.319853216849, 5936.762529498815, 5964.314103878066, 4252.978735106305, 4259.42497762798, 4264.850730224427, 4291.67812414064, 4314.417553630283, 4298.914021719548, 4304.332828411601, 4306.633936115465, 4316.1583491219535, 4327.7186982846015, 4672.789724462407, 4873.707577545359, 4894.877628059327, 4906.2640603909695, 4915.3855768029, 5565.693886836263, 5660.773569057192, 5673.77304907799, 5737.225474560964, 5748.425157484302, 1445.04626946215, 1445.219581426018, 1447.7321695486369, 1452.8304714704764, 1475.638468575206, 998.7602975285879, 1016.4358780876537, 1020.0462567499412, 1023.1098943918838, 1039.9029024379352, 5429.239906413105, 5431.212474191299, 5450.291462109901, 5467.851751132307, 5472.20653005312, 5702.777930469271, 5704.600677952503, 5719.628224165416, 5724.0538217006415, 5730.226419433323, 5265.631405801557, 5494.263900547586, 5536.197251398525, 5571.832845014656, 5620.634658747168, 3002.534607135897, 3015.42706885691, 3025.788194826341, 3057.624069168883, 3068.2942923127807, 5659.377468478464, 5886.498942769652, 5903.144044113579, 5918.023526118229, 5964.642121472639, 5771.740271687784, 5795.362510123883, 5799.623024503394, 5842.802225543754, 5866.3042283362065, 5817.941820581825, 5855.648661080349, 5887.2052272943465, 5890.558208134321, 5895.174675545512, 5597.328320601554, 5691.186904773729, 5753.712314384347, 5820.592558520862, 5872.765089396376, 5806.216160818235, 5810.796622118206, 5817.95276850171, 5819.301683797971, 5820.447057529528, 5867.442592953663, 5976.193213916065, 6079.392060794062, 6080.270367555921, 6112.38876112403, 4242.893927651833, 4311.6119549239465, 4318.963448772335, 4319.26572482685, 4319.676024298253, 5680.6591604503865, 5851.1515830205235, 5887.61730487517, 5905.173275741314, 5915.349311575809, 5725.198472213977, 5752.6836024019085, 5764.50368712405, 5783.566232532493, 5803.274590676166, 5760.33756118035, 5761.020626493422, 5769.249997500298, 5780.624259423124, 5808.796692115756, 5620.8875822482505, 5675.7445914933105, 5721.313442386941, 5728.541716662574, 5740.368559458373, 5710.428957104423, 5710.543156547549, 5726.74229659658, 5729.023486897014, 5767.7404516796005, 5431.864203394946, 5602.467765562265, 5629.324481062299, 5645.830625081254, 5668.149777533238], "value": 4412.2696757081085, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.7173015825883, 820.0569345252954, 840.6427268410923, 929.99535002325, 953.4374718915841, 16919.661606767873, 17884.284628614856, 17945.730814037768, 17992.460226193234, 18119.0, 16562.917185414055, 16797.66404671906, 17108.657826843457, 17252.654946901053, 17341.132943352844, 830.3481766813053, 854.0647990450478, 855.2046596665099, 855.4354126276659, 859.5014891362995, 817.9591020448954, 838.5136620759976, 838.7483754873514, 854.5470900422755, 858.6522458404356, 871.9754288710772, 873.6723728601775, 877.956102194891, 880.9075047120057, 883.0198479687542, 882.7704796752827, 886.171429713217, 887.928965682747, 888.1163242573648, 888.5379602606608, 646.1083704487824, 646.2600322630561, 649.9285078641345, 651.563452486835, 652.3541693723228, 17346.7397989029, 17640.91179544107, 17744.733828992576, 17819.10904454772, 18012.0, 15978.840211597968, 16163.515094547183, 16173.676526469404, 16304.918475407547, 16316.673666526722, 13252.46990120394, 13374.933125334408, 13454.192748435027, 13475.528356507475, 13676.111052781636, 3954.387070004154, 3958.2281455116263, 3958.6635136013474, 3960.049588098864, 4013.3779264213804, 84087.15912840854, 84548.57725711394, 86153.56923215407, 86795.56602217011, 87637.56181219117, 12282.631521054383, 12347.19743216688, 12386.0, 12393.574738905141, 12397.504099836086, 22746.09015639389, 23444.64833027506, 23454.882725586263, 23640.527189456458, 24163.0, 8723.77198151845, 8986.640534378683, 9038.954805226063, 9174.311926605398, 9221.0, 4910.0, 4957.504249575014, 5046.167382381939, 5074.82238121664, 5110.0, 3936.193080418507, 3973.4635824163947, 3995.9400608990886, 4010.438538604598, 4029.49631296088, 669.394198250584, 674.6761554453791, 676.7834293026184, 684.685044879361, 689.0147089661832, 832.4464231286127, 852.6035393542032, 870.216804875617, 874.9256313213448, 904.3398319226869, 11124.833127503094, 11150.832737508943, 11164.553417863195, 11333.603323883624, 11702.70743231426, 825.4799476329873, 844.6114787197835, 846.7417437681567, 862.4609618988133, 867.5662168915542, 5389.400051668299, 5475.616706830484, 5508.91736623951, 5537.0, 5564.970480461127, 79396.60301698455, 81645.18354816375, 84546.0, 85827.57086214655, 88279.0, 75327.0, 78896.60551697205, 79441.60279198567, 80177.0, 80995.5950220257, 67416.32583674199, 67853.3214667847, 68763.24947002163, 70497.0, 70918.64540677263, 10299.176065914558, 10620.734481638021, 10688.198385120992, 10776.730581735519, 10781.137508999418, 46897.53102468931, 46921.53078469171, 47022.589322319014, 47038.52961470342, 47409.81475463141, 57126.428735712114, 59329.70335148469, 60526.0, 60940.69529652501, 61997.0, 12530.564477976219, 12920.35398230066, 13015.739685206054, 13107.737845242851, 13214.405351759002, 14710.264486775404, 14856.925715371353, 14859.034162779384, 15019.399224030916, 15939.44211952576, 15380.461683841011, 15648.4523041693, 15774.684506310039, 16016.839831601535, 16440.67118657644, 15366.67762862864, 15510.612234694223, 15695.215239237765, 16031.599210019844, 16929.492115236564, 14250.0, 14267.357968891218, 14352.21062841512, 15584.532464026097, 15657.982231154938, 12387.128835880234, 12563.811542826683, 12609.68475788076, 13080.149790263602, 13577.93211033978, 12387.504499820267, 12589.181703189264, 12637.2417654941, 12683.936580317039, 12737.29944853042], "value": 8005.957426400555, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1478.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 114.0, 115.0, 113.0, 114.0, 113.0, 112.0, 112.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 119.0, 119.0, 154.0, 120.0, 120.0, 118.0, 124.0, 140.0, 119.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 163.0, 161.0, 159.0, 161.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 110.0, 76.0, 76.0, 75.0, 77.0, 92.0, 77.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 99.0, 82.0, 83.0, 83.0, 94.0, 83.0, 83.0, 112.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 101.0, 96.0, 96.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 60.0, 57.0, 60.0, 58.0, 55.0, 56.0, 57.0, 58.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 77.0, 76.0, 77.0, 77.0, 76.0, 79.0, 77.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 122.0, 131.0, 130.0, 121.0, 129.0, 121.0, 126.0, 156.0, 125.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 156.0, 154.0, 160.0, 158.0, 156.0, 153.0, 161.0, 155.0, 159.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 62.0, 61.0, 63.0, 61.0, 61.0, 59.0, 61.0, 66.0], "value": 62.2, "unit": "score"}]}]} 12:18:09 INFO - Return code: 0 12:18:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:18:09 ERROR - # TBPL SUCCESS # 12:18:09 INFO - Running post-action listener: _resource_record_post_action 12:18:09 INFO - [mozharness: 2017-02-08 20:18:09.655735Z] Finished run-tests step (success) 12:18:09 INFO - Running post-run listener: _resource_record_post_run 12:18:09 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 274432; Write bytes: 370544640; Read time: 492; Write time: 352928 12:18:09 INFO - TinderboxPrint: CPU usage
13.3% 12:18:09 INFO - TinderboxPrint: I/O read bytes / time
274,432 / 492 12:18:09 INFO - TinderboxPrint: I/O write bytes / time
370,544,640 / 352,928 12:18:09 INFO - TinderboxPrint: CPU idle
8,235.4 (86.7%) 12:18:09 INFO - TinderboxPrint: CPU user
1,206.2 (12.7%) 12:18:09 INFO - TinderboxPrint: Swap in / out
0 / 0 12:18:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 120242176; Read time: 204; Write time: 150488 12:18:09 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 270336; Write bytes: 249135104; Read time: 288; Write time: 202408 12:18:10 INFO - Running post-run listener: _upload_blobber_files 12:18:10 INFO - Blob upload gear active. 12:18:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:18:10 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 12:18:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:18:10 INFO - (blobuploader) - INFO - Open directory for files ... 12:18:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:18:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:18:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:11 INFO - (blobuploader) - INFO - Done attempting. 12:18:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:18:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:18:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:12 INFO - (blobuploader) - INFO - Done attempting. 12:18:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:18:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:18:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:13 INFO - (blobuploader) - INFO - Done attempting. 12:18:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:18:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:18:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:16 INFO - (blobuploader) - INFO - Done attempting. 12:18:16 INFO - (blobuploader) - INFO - Iteration through files over. 12:18:16 INFO - Return code: 0 12:18:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:18:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:18:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5b31f4458f3878a9910acbef42333761bdf5b8187ca4e4eaf13983f528fcef61ff4fdbc9d7d450f081db455967e2a95d39e4b43160f8f1ef9214bcdbc64b90d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5239add0762f4dfdf8bbacbc431a6f53a31bb8efc39235d7ae491bfe6cce6241446b75dbe8bdff50b1842a9a3a6abdd6975a6796f3ed5028b7741e7def89f47d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1f5ade18f0d87e7f5ccd8054e2d4d7067a4051628db8ae7eedc822cb74b35c54ef7d2f0cea46d19fe5bdf19ab9da49efa82aa36dcd1a588235aedffa88cb03a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4a502e1ce0a5fe1186a42c6143e3eb4f192f079bffaef90a3948c9bd288d833454f61801b92fbcd457f36c2b863d12a78781873c0eee569cbf9ccfe80a8ca2b"} 12:18:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:18:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:18:16 INFO - Contents: 12:18:16 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5b31f4458f3878a9910acbef42333761bdf5b8187ca4e4eaf13983f528fcef61ff4fdbc9d7d450f081db455967e2a95d39e4b43160f8f1ef9214bcdbc64b90d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5239add0762f4dfdf8bbacbc431a6f53a31bb8efc39235d7ae491bfe6cce6241446b75dbe8bdff50b1842a9a3a6abdd6975a6796f3ed5028b7741e7def89f47d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1f5ade18f0d87e7f5ccd8054e2d4d7067a4051628db8ae7eedc822cb74b35c54ef7d2f0cea46d19fe5bdf19ab9da49efa82aa36dcd1a588235aedffa88cb03a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4a502e1ce0a5fe1186a42c6143e3eb4f192f079bffaef90a3948c9bd288d833454f61801b92fbcd457f36c2b863d12a78781873c0eee569cbf9ccfe80a8ca2b"} 12:18:16 INFO - Running post-run listener: copy_logs_to_upload_dir 12:18:16 INFO - Copying logs to upload dir... 12:18:16 INFO - mkdir: /builds/slave/test/build/upload/logs 12:18:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.634189 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-08 12:18:16.569400) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 12:18:16.575122) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5b31f4458f3878a9910acbef42333761bdf5b8187ca4e4eaf13983f528fcef61ff4fdbc9d7d450f081db455967e2a95d39e4b43160f8f1ef9214bcdbc64b90d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5239add0762f4dfdf8bbacbc431a6f53a31bb8efc39235d7ae491bfe6cce6241446b75dbe8bdff50b1842a9a3a6abdd6975a6796f3ed5028b7741e7def89f47d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1f5ade18f0d87e7f5ccd8054e2d4d7067a4051628db8ae7eedc822cb74b35c54ef7d2f0cea46d19fe5bdf19ab9da49efa82aa36dcd1a588235aedffa88cb03a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4a502e1ce0a5fe1186a42c6143e3eb4f192f079bffaef90a3948c9bd288d833454f61801b92fbcd457f36c2b863d12a78781873c0eee569cbf9ccfe80a8ca2b"} build_url:https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/PMsUT1-3S_e9od4rV3nGAg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5b31f4458f3878a9910acbef42333761bdf5b8187ca4e4eaf13983f528fcef61ff4fdbc9d7d450f081db455967e2a95d39e4b43160f8f1ef9214bcdbc64b90d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5239add0762f4dfdf8bbacbc431a6f53a31bb8efc39235d7ae491bfe6cce6241446b75dbe8bdff50b1842a9a3a6abdd6975a6796f3ed5028b7741e7def89f47d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1f5ade18f0d87e7f5ccd8054e2d4d7067a4051628db8ae7eedc822cb74b35c54ef7d2f0cea46d19fe5bdf19ab9da49efa82aa36dcd1a588235aedffa88cb03a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4a502e1ce0a5fe1186a42c6143e3eb4f192f079bffaef90a3948c9bd288d833454f61801b92fbcd457f36c2b863d12a78781873c0eee569cbf9ccfe80a8ca2b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 12:18:16.600136) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 12:18:16.600475) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1486583858.95347-206892941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 12:18:16.685555) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 12:18:16.685904) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 12:18:16.686247) ========= ========= Total master_lag: 0.17 =========