builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-088 starttime: 1493627962.07 results: success (0) revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 01:39:22.066909) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 01:39:22.067440) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 01:39:22.067748) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 01:39:22.083289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 01:39:22.083858) ========= 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=9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-01 01:39:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-05-01 01:39:24 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122510 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 01:39:22.227349) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 01:39:22.227687) ========= 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=9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017611 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 01:39:22.281580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 01:39:22.282405) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --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 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --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=9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-01 01:39:24,244 truncating revision to first 12 chars 2017-05-01 01:39:24,245 Setting DEBUG logging. 2017-05-01 01:39:24,245 attempt 1/10 2017-05-01 01:39:24,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/94b7e538af7d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-01 01:39:24,679 unpacking tar archive at: mozilla-aurora-94b7e538af7d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.838074 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 01:39:23.139683) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 01:39:23.140459) ========= script_repo_revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 01:39:23.141411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 01:39:23.142130) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 01:39:23.159687) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-01 01:39:23.160007) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:39:25 INFO - MultiFileLogger online at 20170501 01:39:25 in /builds/slave/test 01:39:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 01:39:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:39:25 INFO - {'append_to_log': False, 01:39:25 INFO - 'base_work_dir': '/builds/slave/test', 01:39:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 01:39:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:39:25 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 01:39:25 INFO - 'buildbot_json_path': 'buildprops.json', 01:39:25 INFO - 'config_files': ('talos/linux_config.py',), 01:39:25 INFO - 'default_actions': ('clobber', 01:39:25 INFO - 'read-buildbot-config', 01:39:25 INFO - 'download-and-extract', 01:39:25 INFO - 'populate-webroot', 01:39:25 INFO - 'create-virtualenv', 01:39:25 INFO - 'install', 01:39:25 INFO - 'run-tests'), 01:39:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:39:25 INFO - 'download_minidump_stackwalk': True, 01:39:25 INFO - 'download_symbols': 'ondemand', 01:39:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:39:25 INFO - 'tooltool.py': '/tools/tooltool.py', 01:39:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:39:25 INFO - '/tools/misc-python/virtualenv.py')}, 01:39:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:39:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:39:25 INFO - 'gecko_profile': False, 01:39:25 INFO - 'gecko_profile_interval': 0, 01:39:25 INFO - 'installer_path': 'installer.exe', 01:39:25 INFO - 'log_level': 'info', 01:39:25 INFO - 'log_name': 'talos', 01:39:25 INFO - 'log_to_console': True, 01:39:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:39:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:39:25 INFO - 'opt_config_files': (), 01:39:25 INFO - 'pip_index': False, 01:39:25 INFO - 'suite': 'dromaeojs', 01:39:25 INFO - 'system_bits': '32', 01:39:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:39:25 INFO - 'title': 'talos-linux64-ix-088', 01:39:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:39:25 INFO - 'use_talos_json': True, 01:39:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:39:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:39:25 INFO - 'work_dir': 'build'} 01:39:25 INFO - [mozharness: 2017-05-01 08:39:25.224103Z] Running clobber step. 01:39:25 INFO - Running pre-action listener: _resource_record_pre_action 01:39:25 INFO - Running main action method: clobber 01:39:25 INFO - rmtree: /builds/slave/test/build 01:39:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:39:26 INFO - Running post-action listener: _resource_record_post_action 01:39:26 INFO - [mozharness: 2017-05-01 08:39:26.667620Z] Finished clobber step (success) 01:39:26 INFO - [mozharness: 2017-05-01 08:39:26.667717Z] Running read-buildbot-config step. 01:39:26 INFO - Running pre-action listener: _resource_record_pre_action 01:39:26 INFO - Running main action method: read_buildbot_config 01:39:26 INFO - Using buildbot properties: 01:39:26 INFO - { 01:39:26 INFO - "project": "", 01:39:26 INFO - "product": "firefox", 01:39:26 INFO - "who": "nobody@mozilla.org", 01:39:26 INFO - "installer_path": "public/build/target.tar.bz2", 01:39:26 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:39:26 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora", 01:39:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 01:39:26 INFO - "stage_platform": "linux64", 01:39:26 INFO - "basedir": "/builds/slave/test", 01:39:26 INFO - "buildnumber": 0, 01:39:26 INFO - "platform": "ubuntu64_hw", 01:39:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:39:26 INFO - "slavebuilddir": "test", 01:39:26 INFO - "taskId": "e1O3lhzoQJCA5twKZjV4KA", 01:39:26 INFO - "branch": "mozilla-aurora", 01:39:26 INFO - "script_repo_revision": "production", 01:39:26 INFO - "revision": "94b7e538af7dbb9a6567cad9125c2f5411e7fb80", 01:39:26 INFO - "slavename": "talos-linux64-ix-088", 01:39:26 INFO - "repo_path": "releases/mozilla-aurora" 01:39:26 INFO - } 01:39:26 INFO - Finding installer, test and symbols from parent task. 01:39:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e1O3lhzoQJCA5twKZjV4KA'}, attempt #1 01:39:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e1O3lhzoQJCA5twKZjV4KA'}, attempt #1 01:39:27 INFO - Task dependencies: T-ZYPxv3RreHzcJyKDnwhw 01:39:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw'}, attempt #1 01:39:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.tar.bz2 01:39:28 INFO - Set test_url: https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/test_packages.json 01:39:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.crashreporter-symbols.zip 01:39:28 INFO - Running post-action listener: _resource_record_post_action 01:39:28 INFO - [mozharness: 2017-05-01 08:39:28.016474Z] Finished read-buildbot-config step (success) 01:39:28 INFO - [mozharness: 2017-05-01 08:39:28.016692Z] Running download-and-extract step. 01:39:28 INFO - Running pre-action listener: _resource_record_pre_action 01:39:28 INFO - Running main action method: download_and_extract 01:39:28 INFO - mkdir: /builds/slave/test/build/tests 01:39:28 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')]} 01:39:28 INFO - trying https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.test_packages.json 01:39:28 INFO - Downloading https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:39:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:39:28 INFO - Downloaded 896 bytes. 01:39:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:39:28 INFO - Using the following test package requirements: 01:39:28 INFO - {u'common': [u'target.common.tests.zip'], 01:39:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:39:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:39:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:39:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:39:28 INFO - u'mozbase': [u'target.common.tests.zip'], 01:39:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:39:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:39:28 INFO - u'web-platform': [u'target.common.tests.zip', 01:39:28 INFO - u'target.web-platform.tests.zip'], 01:39:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:39:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:39:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.common.tests.zip 01:39:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:39:28 INFO - Fetch https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.common.tests.zip into memory 01:39:30 INFO - Expected file size: 59542263 01:39:30 INFO - Obtained file size: 59542263 01:39:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:39:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.common.tests.zip 01:39:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:39:40 INFO - Fetch https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.common.tests.zip into memory 01:39:42 INFO - Expected file size: 59542263 01:39:42 INFO - Obtained file size: 59542263 01:39:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.talos.tests.zip 01:39:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:39:52 INFO - Fetch https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.talos.tests.zip into memory 01:39:53 INFO - Expected file size: 14404424 01:39:53 INFO - Obtained file size: 14404424 01:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:39:53 INFO - trying https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.tar.bz2 01:39:53 INFO - Downloading https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:39:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:39:56 INFO - Downloaded 66804194 bytes. 01:39:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.tar.bz2 01:39:56 INFO - mkdir: /builds/slave/test/properties 01:39:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:39:56 INFO - Writing to file /builds/slave/test/properties/build_url 01:39:56 INFO - Contents: 01:39:56 INFO - build_url:https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.tar.bz2 01:39:56 INFO - Running post-action listener: _resource_record_post_action 01:39:56 INFO - Running post-action listener: set_extra_try_arguments 01:39:56 INFO - [mozharness: 2017-05-01 08:39:56.348012Z] Finished download-and-extract step (success) 01:39:56 INFO - [mozharness: 2017-05-01 08:39:56.348184Z] Running populate-webroot step. 01:39:56 INFO - Running pre-action listener: _resource_record_pre_action 01:39:56 INFO - Running main action method: populate_webroot 01:39:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:39:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:39:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:39:56 INFO - '--tppagecycles', 01:39:56 INFO - '7'], 01:39:56 INFO - 'tests': ['tsvgm']}}, 01:39:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:39:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:39:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:39:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:39:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:39:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:39:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:39:56 INFO - 'talos_options': ['--disable-e10s'], 01:39:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:39:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:39:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:39:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:39:56 INFO - 'talos_options': ['--disable-e10s'], 01:39:56 INFO - 'tests': ['damp', 'tps']}, 01:39:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:39:56 INFO - 'tests': ['damp', 'tps']}, 01:39:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:39:56 INFO - 'tests': ['dromaeo_dom']}, 01:39:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:39:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:39:56 INFO - 'tests': ['basic_compositor_video']}, 01:39:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:39:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:39:56 INFO - 'tests': ['a11yr', 01:39:56 INFO - 'ts_paint', 01:39:56 INFO - 'tpaint', 01:39:56 INFO - 'sessionrestore', 01:39:56 INFO - 'sessionrestore_no_auto_restore', 01:39:56 INFO - 'tabpaint']}, 01:39:56 INFO - 'other-e10s': {'tests': ['a11yr', 01:39:56 INFO - 'ts_paint', 01:39:56 INFO - 'tpaint', 01:39:56 INFO - 'sessionrestore', 01:39:56 INFO - 'sessionrestore_no_auto_restore', 01:39:56 INFO - 'tabpaint']}, 01:39:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:39:56 INFO - 'ts_paint', 01:39:56 INFO - 'tpaint', 01:39:56 INFO - 'sessionrestore', 01:39:56 INFO - 'sessionrestore_no_auto_restore', 01:39:56 INFO - 'tabpaint']}, 01:39:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:39:56 INFO - 'ts_paint', 01:39:56 INFO - 'tpaint', 01:39:56 INFO - 'sessionrestore', 01:39:56 INFO - 'sessionrestore_no_auto_restore', 01:39:56 INFO - 'tabpaint']}, 01:39:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:39:56 INFO - 'tests': ['a11yr', 01:39:56 INFO - 'ts_paint', 01:39:56 INFO - 'tpaint', 01:39:56 INFO - 'sessionrestore', 01:39:56 INFO - 'sessionrestore_no_auto_restore', 01:39:56 INFO - 'tabpaint']}, 01:39:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:39:56 INFO - 'tests': ['a11yr', 01:39:56 INFO - 'ts_paint', 01:39:56 INFO - 'tpaint', 01:39:56 INFO - 'sessionrestore', 01:39:56 INFO - 'sessionrestore_no_auto_restore', 01:39:56 INFO - 'tabpaint']}, 01:39:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:39:56 INFO - 'tests': ['tsvgx', 01:39:56 INFO - 'tsvgr_opacity', 01:39:56 INFO - 'tart', 01:39:56 INFO - 'tscrollx', 01:39:56 INFO - 'cart', 01:39:56 INFO - 'tsvg_static']}, 01:39:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:39:56 INFO - 'tsvgr_opacity', 01:39:56 INFO - 'tart', 01:39:56 INFO - 'tscrollx', 01:39:56 INFO - 'cart', 01:39:56 INFO - 'tsvg_static']}, 01:39:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:39:56 INFO - 'talos_options': ['--disable-e10s'], 01:39:56 INFO - 'tests': ['tp5o']}, 01:39:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:39:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:39:56 INFO - 'talos_options': ['--disable-e10s', 01:39:56 INFO - '--xperf_path', 01:39:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:39:56 INFO - 'tests': ['tp5n']}, 01:39:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:39:56 INFO - 'talos_options': ['--xperf_path', 01:39:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:39:56 INFO - 'tests': ['tp5n']}}, 01:39:56 INFO - 'talos.zip': {'path': '', 01:39:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:39:56 INFO - Running post-action listener: _resource_record_post_action 01:39:56 INFO - [mozharness: 2017-05-01 08:39:56.366299Z] Finished populate-webroot step (success) 01:39:56 INFO - [mozharness: 2017-05-01 08:39:56.366398Z] Running create-virtualenv step. 01:39:56 INFO - Running pre-action listener: _resource_record_pre_action 01:39:56 INFO - Running main action method: create_virtualenv 01:39:56 INFO - Creating virtualenv /builds/slave/test/build/venv 01:39:56 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 01:39:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:39:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:39:56 INFO - Using real prefix '/usr' 01:39:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:39:56 INFO - Installing distribute.............................................................................................................................................................................................done. 01:39:58 INFO - Installing pip.................done. 01:39:58 INFO - Return code: 0 01:39:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:39:59 INFO - Reading from file tmpfile_stdout 01:39:59 INFO - Output received: 01:39:59 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) 01:39:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:39:59 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')]} 01:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:59 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')]} 01:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:59 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988400>, '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 0x19893b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1989840>, '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': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', '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 01:39:59 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 01:39:59 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 01:39:59 INFO - Using env: {'DISPLAY': ':0', 01:39:59 INFO - 'HOME': '/home/cltbld', 01:39:59 INFO - 'LANG': 'en_US.UTF-8', 01:39:59 INFO - 'LANGUAGE': 'en_US:en', 01:39:59 INFO - 'LOGNAME': 'cltbld', 01:39:59 INFO - 'MAIL': '/var/mail/cltbld', 01:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:59 INFO - 'MOZ_NO_REMOTE': '1', 01:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:39:59 INFO - 'NO_EM_RESTART': '1', 01:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:39:59 INFO - 'PWD': '/builds/slave/test', 01:39:59 INFO - 'SHELL': '/bin/bash', 01:39:59 INFO - 'SHLVL': '1', 01:39:59 INFO - 'TERM': 'linux', 01:39:59 INFO - 'TMOUT': '86400', 01:39:59 INFO - 'USER': 'cltbld', 01:39:59 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', 01:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:59 INFO - '_': '/tools/buildbot/bin/python'} 01:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:39:59 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 01:39:59 INFO - Cleaning up... 01:39:59 INFO - Return code: 0 01:39:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:39:59 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')]} 01:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:59 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')]} 01:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:59 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988400>, '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 0x19893b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1989840>, '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': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', '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 01:39:59 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 01:39:59 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 01:39:59 INFO - Using env: {'DISPLAY': ':0', 01:39:59 INFO - 'HOME': '/home/cltbld', 01:39:59 INFO - 'LANG': 'en_US.UTF-8', 01:39:59 INFO - 'LANGUAGE': 'en_US:en', 01:39:59 INFO - 'LOGNAME': 'cltbld', 01:39:59 INFO - 'MAIL': '/var/mail/cltbld', 01:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:59 INFO - 'MOZ_NO_REMOTE': '1', 01:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:39:59 INFO - 'NO_EM_RESTART': '1', 01:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:39:59 INFO - 'PWD': '/builds/slave/test', 01:39:59 INFO - 'SHELL': '/bin/bash', 01:39:59 INFO - 'SHLVL': '1', 01:39:59 INFO - 'TERM': 'linux', 01:39:59 INFO - 'TMOUT': '86400', 01:39:59 INFO - 'USER': 'cltbld', 01:39:59 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', 01:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:59 INFO - '_': '/tools/buildbot/bin/python'} 01:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:39:59 INFO - Downloading/unpacking psutil>=3.1.1 01:39:59 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 01:39:59 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 01:39:59 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 01:39:59 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 01:39:59 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 01:39:59 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 01:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:40:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:40:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:40:01 INFO - Installing collected packages: psutil 01:40:01 INFO - Running setup.py install for psutil 01:40:01 INFO - building 'psutil._psutil_linux' extension 01:40:01 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 01:40:02 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 01:40:02 INFO - building 'psutil._psutil_posix' extension 01:40:02 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 01:40:02 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 01:40:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:40:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:40:02 INFO - Successfully installed psutil 01:40:02 INFO - Cleaning up... 01:40:02 INFO - Return code: 0 01:40:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:40:02 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')]} 01:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:02 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')]} 01:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:02 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988400>, '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 0x19893b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1989840>, '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': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', '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 01:40:02 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 01:40:02 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 01:40:02 INFO - Using env: {'DISPLAY': ':0', 01:40:02 INFO - 'HOME': '/home/cltbld', 01:40:02 INFO - 'LANG': 'en_US.UTF-8', 01:40:02 INFO - 'LANGUAGE': 'en_US:en', 01:40:02 INFO - 'LOGNAME': 'cltbld', 01:40:02 INFO - 'MAIL': '/var/mail/cltbld', 01:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:02 INFO - 'MOZ_NO_REMOTE': '1', 01:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:02 INFO - 'NO_EM_RESTART': '1', 01:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:02 INFO - 'PWD': '/builds/slave/test', 01:40:02 INFO - 'SHELL': '/bin/bash', 01:40:02 INFO - 'SHLVL': '1', 01:40:02 INFO - 'TERM': 'linux', 01:40:02 INFO - 'TMOUT': '86400', 01:40:02 INFO - 'USER': 'cltbld', 01:40:02 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', 01:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:02 INFO - '_': '/tools/buildbot/bin/python'} 01:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:40:02 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 01:40:02 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 01:40:02 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 01:40:02 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 01:40:02 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 01:40:02 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 01:40:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:40:04 INFO - Installing collected packages: mozsystemmonitor 01:40:04 INFO - Running setup.py install for mozsystemmonitor 01:40:04 INFO - Successfully installed mozsystemmonitor 01:40:04 INFO - Cleaning up... 01:40:04 INFO - Return code: 0 01:40:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988400>, '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 0x19893b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1989840>, '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': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', '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 01:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:40:04 INFO - Using env: {'DISPLAY': ':0', 01:40:04 INFO - 'HOME': '/home/cltbld', 01:40:04 INFO - 'LANG': 'en_US.UTF-8', 01:40:04 INFO - 'LANGUAGE': 'en_US:en', 01:40:04 INFO - 'LOGNAME': 'cltbld', 01:40:04 INFO - 'MAIL': '/var/mail/cltbld', 01:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:04 INFO - 'MOZ_NO_REMOTE': '1', 01:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:04 INFO - 'NO_EM_RESTART': '1', 01:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:04 INFO - 'PWD': '/builds/slave/test', 01:40:04 INFO - 'SHELL': '/bin/bash', 01:40:04 INFO - 'SHLVL': '1', 01:40:04 INFO - 'TERM': 'linux', 01:40:04 INFO - 'TMOUT': '86400', 01:40:04 INFO - 'USER': 'cltbld', 01:40:04 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', 01:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:04 INFO - '_': '/tools/buildbot/bin/python'} 01:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:05 INFO - Downloading/unpacking jsonschema==2.5.1 01:40:05 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 01:40:05 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 01:40:05 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 01:40:05 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 01:40:05 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 01:40:05 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 01:40:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:40:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:40:07 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 01:40:07 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 01:40:07 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 01:40:07 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 01:40:07 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 01:40:07 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 01:40:07 INFO - Downloading functools32-3.2.3-2.tar.gz 01:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:40:07 INFO - warning: no files found matching '*.txt' 01:40:07 INFO - no previously-included directories found matching 'build' 01:40:07 INFO - no previously-included directories found matching 'dist' 01:40:07 INFO - no previously-included directories found matching '.git*' 01:40:07 INFO - Installing collected packages: jsonschema, functools32 01:40:07 INFO - Running setup.py install for functools32 01:40:07 INFO - warning: no files found matching '*.txt' 01:40:07 INFO - no previously-included directories found matching 'build' 01:40:07 INFO - no previously-included directories found matching 'dist' 01:40:07 INFO - no previously-included directories found matching '.git*' 01:40:07 INFO - Successfully installed jsonschema functools32 01:40:07 INFO - Cleaning up... 01:40:07 INFO - Return code: 0 01:40:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:40:07 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')]} 01:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:07 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')]} 01:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:07 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988400>, '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 0x19893b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1989840>, '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': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', '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 01:40:07 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 01:40:07 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 01:40:07 INFO - Using env: {'DISPLAY': ':0', 01:40:07 INFO - 'HOME': '/home/cltbld', 01:40:07 INFO - 'LANG': 'en_US.UTF-8', 01:40:07 INFO - 'LANGUAGE': 'en_US:en', 01:40:07 INFO - 'LOGNAME': 'cltbld', 01:40:07 INFO - 'MAIL': '/var/mail/cltbld', 01:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:07 INFO - 'MOZ_NO_REMOTE': '1', 01:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:07 INFO - 'NO_EM_RESTART': '1', 01:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:07 INFO - 'PWD': '/builds/slave/test', 01:40:07 INFO - 'SHELL': '/bin/bash', 01:40:07 INFO - 'SHLVL': '1', 01:40:07 INFO - 'TERM': 'linux', 01:40:07 INFO - 'TMOUT': '86400', 01:40:07 INFO - 'USER': 'cltbld', 01:40:07 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', 01:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:07 INFO - '_': '/tools/buildbot/bin/python'} 01:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:40:07 INFO - Cleaning up... 01:40:07 INFO - Return code: 0 01:40:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:40:07 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')]} 01:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:07 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')]} 01:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:07 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988400>, '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 0x19893b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1989840>, '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': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', '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 01:40:07 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 01:40:07 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 01:40:07 INFO - Using env: {'DISPLAY': ':0', 01:40:07 INFO - 'HOME': '/home/cltbld', 01:40:07 INFO - 'LANG': 'en_US.UTF-8', 01:40:07 INFO - 'LANGUAGE': 'en_US:en', 01:40:07 INFO - 'LOGNAME': 'cltbld', 01:40:07 INFO - 'MAIL': '/var/mail/cltbld', 01:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:07 INFO - 'MOZ_NO_REMOTE': '1', 01:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:07 INFO - 'NO_EM_RESTART': '1', 01:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:07 INFO - 'PWD': '/builds/slave/test', 01:40:07 INFO - 'SHELL': '/bin/bash', 01:40:07 INFO - 'SHLVL': '1', 01:40:07 INFO - 'TERM': 'linux', 01:40:07 INFO - 'TMOUT': '86400', 01:40:07 INFO - 'USER': 'cltbld', 01:40:07 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', 01:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:07 INFO - '_': '/tools/buildbot/bin/python'} 01:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:07 INFO - Downloading/unpacking blobuploader==1.2.4 01:40:07 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 01:40:07 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 01:40:07 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 01:40:07 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 01:40:07 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 01:40:07 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 01:40:09 INFO - Downloading blobuploader-1.2.4.tar.gz 01:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:40:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:40:10 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 01:40:10 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 01:40:10 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 01:40:10 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 01:40:10 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 01:40:10 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 01:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:40:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:40:10 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 01:40:10 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 01:40:10 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 01:40:10 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 01:40:10 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 01:40:10 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 01:40:10 INFO - Downloading docopt-0.6.1.tar.gz 01:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:40:10 INFO - Installing collected packages: blobuploader, requests, docopt 01:40:10 INFO - Running setup.py install for blobuploader 01:40:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:40:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:40:10 INFO - Running setup.py install for requests 01:40:11 INFO - Running setup.py install for docopt 01:40:11 INFO - Successfully installed blobuploader requests docopt 01:40:11 INFO - Cleaning up... 01:40:11 INFO - Return code: 0 01:40:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:40:11 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')]} 01:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:11 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')]} 01:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:11 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988400>, '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 0x19893b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1989840>, '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': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', '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 01:40:11 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 01:40:11 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 01:40:11 INFO - Using env: {'DISPLAY': ':0', 01:40:11 INFO - 'HOME': '/home/cltbld', 01:40:11 INFO - 'LANG': 'en_US.UTF-8', 01:40:11 INFO - 'LANGUAGE': 'en_US:en', 01:40:11 INFO - 'LOGNAME': 'cltbld', 01:40:11 INFO - 'MAIL': '/var/mail/cltbld', 01:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:11 INFO - 'MOZ_NO_REMOTE': '1', 01:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:11 INFO - 'NO_EM_RESTART': '1', 01:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:11 INFO - 'PWD': '/builds/slave/test', 01:40:11 INFO - 'SHELL': '/bin/bash', 01:40:11 INFO - 'SHLVL': '1', 01:40:11 INFO - 'TERM': 'linux', 01:40:11 INFO - 'TMOUT': '86400', 01:40:11 INFO - 'USER': 'cltbld', 01:40:11 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', 01:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:11 INFO - '_': '/tools/buildbot/bin/python'} 01:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:40:11 INFO - Running setup.py (path:/tmp/pip-34xzVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:40:11 INFO - Running setup.py (path:/tmp/pip-0Hiyeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:40:11 INFO - Running setup.py (path:/tmp/pip-xN8L8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:40:11 INFO - Running setup.py (path:/tmp/pip-O32Vxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:40:11 INFO - Running setup.py (path:/tmp/pip-qQWqs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:40:11 INFO - Running setup.py (path:/tmp/pip-CQ8E6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:40:12 INFO - Running setup.py (path:/tmp/pip-pwmXhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:40:12 INFO - Running setup.py (path:/tmp/pip-SDJ7id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:40:12 INFO - Running setup.py (path:/tmp/pip-gS_Cuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:40:12 INFO - Running setup.py (path:/tmp/pip-Wlskoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:40:12 INFO - Running setup.py (path:/tmp/pip-0t2LKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:40:12 INFO - Running setup.py (path:/tmp/pip-gLIw86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:40:12 INFO - Running setup.py (path:/tmp/pip-agQvA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:40:12 INFO - Running setup.py (path:/tmp/pip-KsNpPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:40:12 INFO - Running setup.py (path:/tmp/pip-fjMktf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:40:12 INFO - Running setup.py (path:/tmp/pip-hf5pSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:40:12 INFO - Running setup.py (path:/tmp/pip-yea01U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:40:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:40:12 INFO - Running setup.py install for manifestparser 01:40:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:40:12 INFO - Running setup.py install for mozcrash 01:40:13 INFO - Running setup.py install for mozdebug 01:40:13 INFO - Running setup.py install for mozdevice 01:40:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:40:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:40:13 INFO - Running setup.py install for mozfile 01:40:13 INFO - Running setup.py install for mozhttpd 01:40:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:40:13 INFO - Running setup.py install for mozinfo 01:40:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:40:13 INFO - Running setup.py install for mozInstall 01:40:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:40:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:40:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:40:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:40:13 INFO - Running setup.py install for mozleak 01:40:13 INFO - Running setup.py install for mozlog 01:40:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:40:13 INFO - Running setup.py install for moznetwork 01:40:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:40:13 INFO - Running setup.py install for mozprocess 01:40:14 INFO - Running setup.py install for mozprofile 01:40:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:40:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:40:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:40:14 INFO - Running setup.py install for mozrunner 01:40:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:40:14 INFO - Running setup.py install for mozscreenshot 01:40:14 INFO - Running setup.py install for moztest 01:40:14 INFO - Running setup.py install for mozversion 01:40:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:40:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:40:14 INFO - Cleaning up... 01:40:14 INFO - Return code: 0 01:40:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:40:14 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')]} 01:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:14 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')]} 01:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:14 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988400>, '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 0x19893b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1989840>, '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': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', '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 01:40:14 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 01:40:14 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 01:40:14 INFO - Using env: {'DISPLAY': ':0', 01:40:14 INFO - 'HOME': '/home/cltbld', 01:40:14 INFO - 'LANG': 'en_US.UTF-8', 01:40:14 INFO - 'LANGUAGE': 'en_US:en', 01:40:14 INFO - 'LOGNAME': 'cltbld', 01:40:14 INFO - 'MAIL': '/var/mail/cltbld', 01:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:14 INFO - 'MOZ_NO_REMOTE': '1', 01:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:14 INFO - 'NO_EM_RESTART': '1', 01:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:14 INFO - 'PWD': '/builds/slave/test', 01:40:14 INFO - 'SHELL': '/bin/bash', 01:40:14 INFO - 'SHLVL': '1', 01:40:14 INFO - 'TERM': 'linux', 01:40:14 INFO - 'TMOUT': '86400', 01:40:14 INFO - 'USER': 'cltbld', 01:40:14 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', 01:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:14 INFO - '_': '/tools/buildbot/bin/python'} 01:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:40:14 INFO - Running setup.py (path:/tmp/pip-ffqNAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:40:14 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)) 01:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:40:14 INFO - Running setup.py (path:/tmp/pip-2tuRla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:40:14 INFO - Running setup.py (path:/tmp/pip-8gW4hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:40:15 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)) 01:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:40:15 INFO - Running setup.py (path:/tmp/pip-RLaePQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:40:15 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)) 01:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:40:15 INFO - Running setup.py (path:/tmp/pip-QvZwV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:40:15 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)) 01:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:40:15 INFO - Running setup.py (path:/tmp/pip-hs1_M8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:40:15 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)) 01:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:40:15 INFO - Running setup.py (path:/tmp/pip-Px2n4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:40:15 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)) 01:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:40:15 INFO - Running setup.py (path:/tmp/pip-e57SGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:40:15 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)) 01:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:40:15 INFO - Running setup.py (path:/tmp/pip-ZwDZcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:40:15 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)) 01:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:40:15 INFO - Running setup.py (path:/tmp/pip-jaqHR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:40:15 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)) 01:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:40:15 INFO - Running setup.py (path:/tmp/pip-AevEQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:40:15 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)) 01:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:40:15 INFO - Running setup.py (path:/tmp/pip-7EQh8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 01:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:40:15 INFO - Running setup.py (path:/tmp/pip-LkldAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:40:15 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)) 01:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:40:15 INFO - Running setup.py (path:/tmp/pip-ipy30y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:40:15 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)) 01:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:40:15 INFO - Running setup.py (path:/tmp/pip-3BmJH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:40:15 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)) 01:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:40:15 INFO - Running setup.py (path:/tmp/pip-0rI3Za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:40:16 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)) 01:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:40:16 INFO - Running setup.py (path:/tmp/pip-4JcH2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:40:16 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)) 01:40:16 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)) 01:40:16 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)) 01:40:16 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)) 01:40:16 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)) 01:40:16 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)) 01:40:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:40:16 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 01:40:16 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 01:40:16 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 01:40:16 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 01:40:16 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 01:40:16 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 01:40:18 INFO - Downloading blessings-1.6.tar.gz 01:40:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:40:18 INFO - Installing collected packages: blessings 01:40:18 INFO - Running setup.py install for blessings 01:40:18 INFO - Successfully installed blessings 01:40:18 INFO - Cleaning up... 01:40:18 INFO - Return code: 0 01:40:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:40:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:40:18 INFO - Reading from file tmpfile_stdout 01:40:18 INFO - Current package versions: 01:40:18 INFO - argparse == 1.2.1 01:40:18 INFO - blessings == 1.6 01:40:18 INFO - blobuploader == 1.2.4 01:40:18 INFO - docopt == 0.6.1 01:40:18 INFO - functools32 == 3.2.3-2 01:40:18 INFO - jsonschema == 2.5.1 01:40:18 INFO - manifestparser == 1.1 01:40:18 INFO - mozInstall == 1.12 01:40:18 INFO - mozcrash == 1.0 01:40:18 INFO - mozdebug == 0.1 01:40:18 INFO - mozdevice == 0.49 01:40:18 INFO - mozfile == 1.2 01:40:18 INFO - mozhttpd == 0.7 01:40:18 INFO - mozinfo == 0.9 01:40:18 INFO - mozleak == 0.1 01:40:18 INFO - mozlog == 3.4 01:40:18 INFO - moznetwork == 0.27 01:40:18 INFO - mozprocess == 0.25 01:40:18 INFO - mozprofile == 0.28 01:40:18 INFO - mozrunner == 6.13 01:40:18 INFO - mozscreenshot == 0.1 01:40:18 INFO - mozsystemmonitor == 0.3 01:40:18 INFO - moztest == 0.8 01:40:18 INFO - mozversion == 1.4 01:40:18 INFO - psutil == 3.1.1 01:40:18 INFO - requests == 1.2.3 01:40:18 INFO - wsgiref == 0.1.2 01:40:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:40:18 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')]} 01:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:18 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')]} 01:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:18 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988400>, '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 0x19893b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1989840>, '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': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', '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 01:40:18 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 01:40:18 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 01:40:18 INFO - Using env: {'DISPLAY': ':0', 01:40:18 INFO - 'HOME': '/home/cltbld', 01:40:18 INFO - 'LANG': 'en_US.UTF-8', 01:40:18 INFO - 'LANGUAGE': 'en_US:en', 01:40:18 INFO - 'LOGNAME': 'cltbld', 01:40:18 INFO - 'MAIL': '/var/mail/cltbld', 01:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:18 INFO - 'MOZ_NO_REMOTE': '1', 01:40:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:18 INFO - 'NO_EM_RESTART': '1', 01:40:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:18 INFO - 'PWD': '/builds/slave/test', 01:40:18 INFO - 'SHELL': '/bin/bash', 01:40:18 INFO - 'SHLVL': '1', 01:40:18 INFO - 'TERM': 'linux', 01:40:18 INFO - 'TMOUT': '86400', 01:40:18 INFO - 'USER': 'cltbld', 01:40:18 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', 01:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:18 INFO - '_': '/tools/buildbot/bin/python'} 01:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:18 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)) 01:40:18 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)) 01:40:18 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)) 01:40:18 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)) 01:40:18 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)) 01:40:18 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)) 01:40:18 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)) 01:40:18 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)) 01:40:18 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)) 01:40:18 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)) 01:40:18 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)) 01:40:18 INFO - Cleaning up... 01:40:18 INFO - Return code: 0 01:40:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:40:18 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')]} 01:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:18 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')]} 01:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:40:18 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1988400>, '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 0x19893b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1989840>, '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': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', '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 01:40:18 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 01:40:18 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 01:40:18 INFO - Using env: {'DISPLAY': ':0', 01:40:18 INFO - 'HOME': '/home/cltbld', 01:40:18 INFO - 'LANG': 'en_US.UTF-8', 01:40:18 INFO - 'LANGUAGE': 'en_US:en', 01:40:18 INFO - 'LOGNAME': 'cltbld', 01:40:18 INFO - 'MAIL': '/var/mail/cltbld', 01:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:18 INFO - 'MOZ_NO_REMOTE': '1', 01:40:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:18 INFO - 'NO_EM_RESTART': '1', 01:40:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:18 INFO - 'PWD': '/builds/slave/test', 01:40:18 INFO - 'SHELL': '/bin/bash', 01:40:18 INFO - 'SHLVL': '1', 01:40:18 INFO - 'TERM': 'linux', 01:40:18 INFO - 'TMOUT': '86400', 01:40:18 INFO - 'USER': 'cltbld', 01:40:18 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', 01:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:18 INFO - '_': '/tools/buildbot/bin/python'} 01:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:40:19 INFO - Cleaning up... 01:40:19 INFO - Return code: 0 01:40:19 INFO - Running post-action listener: _resource_record_post_action 01:40:19 INFO - Running post-action listener: _start_resource_monitoring 01:40:19 INFO - Starting resource monitoring. 01:40:19 INFO - [mozharness: 2017-05-01 08:40:19.091919Z] Finished create-virtualenv step (success) 01:40:19 INFO - [mozharness: 2017-05-01 08:40:19.092386Z] Running install step. 01:40:19 INFO - Running pre-action listener: _resource_record_pre_action 01:40:19 INFO - Running main action method: install 01:40:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:40:19 INFO - Reading from file tmpfile_stdout 01:40:19 INFO - Detecting whether we're running mozinstall >=1.0... 01:40:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:40:19 INFO - Reading from file tmpfile_stdout 01:40:19 INFO - Output received: 01:40:19 INFO - Usage: mozinstall [options] installer 01:40:19 INFO - Options: 01:40:19 INFO - -h, --help show this help message and exit 01:40:19 INFO - -d DEST, --destination=DEST 01:40:19 INFO - Directory to install application into. [default: 01:40:19 INFO - "/builds/slave/test"] 01:40:19 INFO - --app=APP Application being installed. [default: firefox] 01:40:19 INFO - mkdir: /builds/slave/test/build/application 01:40:19 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'] 01:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:40:35 INFO - Reading from file tmpfile_stdout 01:40:35 INFO - Output received: 01:40:35 INFO - /builds/slave/test/build/application/firefox/firefox 01:40:35 INFO - Running post-action listener: _resource_record_post_action 01:40:35 INFO - [mozharness: 2017-05-01 08:40:35.963375Z] Finished install step (success) 01:40:35 INFO - [mozharness: 2017-05-01 08:40:35.963651Z] Running run-tests step. 01:40:35 INFO - Running pre-action listener: _resource_record_pre_action 01:40:35 INFO - Running main action method: run_tests 01:40:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:40:35 INFO - Python 2.7.3 01:40:35 INFO - Return code: 0 01:40:35 INFO - grabbing minidump binary from tooltool 01:40:35 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')]} 01:40:35 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 0x1988400>, '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 0x19893b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1989840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:40:35 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 01:40:35 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 01:40:35 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 01:40:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:40:36 INFO - Return code: 0 01:40:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:40:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:40:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:40:36 INFO - ENV: RUST_BACKTRACE is now 1 01:40:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:40:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:40:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:40:36 INFO - Using env: {'DISPLAY': ':0', 01:40:36 INFO - 'HOME': '/home/cltbld', 01:40:36 INFO - 'LANG': 'en_US.UTF-8', 01:40:36 INFO - 'LANGUAGE': 'en_US:en', 01:40:36 INFO - 'LOGNAME': 'cltbld', 01:40:36 INFO - 'MAIL': '/var/mail/cltbld', 01:40:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:40:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:40:36 INFO - 'MOZ_NO_REMOTE': '1', 01:40:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:40:36 INFO - 'NO_EM_RESTART': '1', 01:40:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:40:36 INFO - 'PWD': '/builds/slave/test', 01:40:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:40:36 INFO - 'RUST_BACKTRACE': '1', 01:40:36 INFO - 'SHELL': '/bin/bash', 01:40:36 INFO - 'SHLVL': '1', 01:40:36 INFO - 'TERM': 'linux', 01:40:36 INFO - 'TMOUT': '86400', 01:40:36 INFO - 'USER': 'cltbld', 01:40:36 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723', 01:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:40:36 INFO - '_': '/tools/buildbot/bin/python'} 01:40:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:40:36 INFO - mozversion application_buildid: 20170501074840 01:40:36 INFO - mozversion application_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 01:40:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:40:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:40:36 INFO - mozversion application_name: Firefox 01:40:36 INFO - mozversion application_remotingname: firefox-dev 01:40:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:40:36 INFO - mozversion application_vendor: Mozilla 01:40:36 INFO - mozversion application_version: 54.0a2 01:40:36 INFO - mozversion platform_buildid: 20170501074840 01:40:36 INFO - mozversion platform_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 01:40:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:40:36 INFO - mozversion platform_version: 54.0a2 01:40:36 INFO - using testdate: 1493628036 01:40:36 INFO - actual date: 1493628036 01:40:36 INFO - starting webserver on 'localhost:58459' 01:40:36 INFO - SUITE-START | Running 2 tests 01:40:36 INFO - TEST-START | dromaeo_css 01:40:36 INFO - operating with platform_type : linux_ 01:40:36 INFO - Initialising browser for dromaeo_css test... 01:40:36 INFO - TEST-INFO | started process 8650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8vBd_u/profile http://localhost:58459/getInfo.html) 01:40:40 INFO - PROCESS | 8650 | __metrics Screen width/height:1600/1200 01:40:40 INFO - PROCESS | 8650 | colorDepth:24 01:40:40 INFO - PROCESS | 8650 | Browser inner width/height: 1024/697 01:40:40 INFO - PROCESS | 8650 | __metrics 01:40:41 INFO - PROCESS | 8650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:40:41 INFO - PROCESS | 8650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:40:42 INFO - TEST-INFO | 8650: exit 0 01:40:42 INFO - Browser initialized. 01:40:42 INFO - Running cycle 1/1 for dromaeo_css test... 01:40:42 INFO - TEST-INFO | started process 8740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8vBd_u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:40:54 INFO - PROCESS | 8740 | RSS: Main: 139866112 01:40:54 INFO - PROCESS | 8740 | 01:43:55 INFO - PROCESS | 8740 | Cycle 1(1): loaded http://localhost:58459/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58459/tests/dromaeo/cssquery-ext.html) 01:43:56 INFO - PROCESS | 8740 | RSS: Main: 254840832 01:43:56 INFO - PROCESS | 8740 | 01:45:43 INFO - PROCESS | 8740 | ************************* 01:45:43 INFO - PROCESS | 8740 | A coding exception was thrown and uncaught in a Task. 01:45:43 INFO - PROCESS | 8740 | 01:45:43 ERROR - PROCESS | 8740 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:45:43 INFO - PROCESS | 8740 | Full stack: 01:45:43 INFO - PROCESS | 8740 | ************************* 01:45:43 INFO - PROCESS | 8740 | ************************* 01:45:43 INFO - PROCESS | 8740 | A coding exception was thrown and uncaught in a Task. 01:45:43 INFO - PROCESS | 8740 | 01:45:43 ERROR - PROCESS | 8740 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:45:43 INFO - PROCESS | 8740 | Full stack: 01:45:43 INFO - PROCESS | 8740 | ************************* 01:45:43 INFO - PROCESS | 8740 | ************************* 01:45:43 INFO - PROCESS | 8740 | A coding exception was thrown and uncaught in a Task. 01:45:43 INFO - PROCESS | 8740 | 01:45:43 ERROR - PROCESS | 8740 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:45:43 INFO - PROCESS | 8740 | Full stack: 01:45:43 INFO - PROCESS | 8740 | ************************* 01:45:43 INFO - PROCESS | 8740 | ************************* 01:45:43 INFO - PROCESS | 8740 | A coding exception was thrown and uncaught in a Task. 01:45:43 INFO - PROCESS | 8740 | 01:45:43 ERROR - PROCESS | 8740 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:45:43 INFO - PROCESS | 8740 | Full stack: 01:45:43 INFO - PROCESS | 8740 | ************************* 01:46:58 INFO - PROCESS | 8740 | Cycle 1(1): loaded http://localhost:58459/tests/dromaeo/cssquery-ext.html (next: http://localhost:58459/tests/dromaeo/cssquery-jquery.html) 01:46:59 INFO - PROCESS | 8740 | RSS: Main: 224468992 01:46:59 INFO - PROCESS | 8740 | 01:50:01 INFO - PROCESS | 8740 | Cycle 1(1): loaded http://localhost:58459/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58459/tests/dromaeo/cssquery-mootools.html) 01:50:01 INFO - PROCESS | 8740 | RSS: Main: 172605440 01:50:01 INFO - PROCESS | 8740 | 01:53:03 INFO - PROCESS | 8740 | Cycle 1(1): loaded http://localhost:58459/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58459/tests/dromaeo/cssquery-prototype.html) 01:53:04 INFO - PROCESS | 8740 | RSS: Main: 195203072 01:53:04 INFO - PROCESS | 8740 | 01:56:07 INFO - PROCESS | 8740 | Cycle 1(1): loaded http://localhost:58459/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58459/tests/dromaeo/cssquery-yui.html) 01:56:07 INFO - PROCESS | 8740 | RSS: Main: 174342144 01:56:07 INFO - PROCESS | 8740 | 01:59:10 INFO - PROCESS | 8740 | Cycle 1(1): loaded http://localhost:58459/tests/dromaeo/cssquery-yui.html (next: http://localhost:58459/tests/dromaeo/cssquery-dojo.html) 01:59:10 INFO - PROCESS | 8740 | RSS: Main: 266326016 01:59:10 INFO - PROCESS | 8740 | 01:59:10 INFO - PROCESS | 8740 | __start_tp_report 01:59:10 INFO - PROCESS | 8740 | _x_x_mozilla_page_load 01:59:10 INFO - PROCESS | 8740 | _x_x_mozilla_page_load_details 01:59:10 INFO - PROCESS | 8740 | |i|pagename|runs| 01:59:10 INFO - PROCESS | 8740 | |0;dojo.html;3401.1667141550324;3407.4888766685;3416.880409185679;3423.0244380351605;3478.791272523649;5649.8305050848485;5725.427457254278;5727.455891690282;5731.541476681866;5740.6268592541455;5721;5764.481196692297;5765.913511297334;5776.075827867531;5776.364599894008;5119.0273847968765;5122.8207012754565;5124.052050370675;5136.203888397305;5175.948240517603;4997.900041999158;5000.124978128831;5145.228215767627;5149.150390185615;5177.119889618773;5070.569001634865;5101.642884998052;5117.641765076446;5128.384593848743;5161.483851614846;5185.896282074356;5191.454897235812;5192.883530041022;5196.402413722413;5216.347956505437;4972.726500042496;5049.368828896388;5116;5158.484151584811;5170.870728231786;5592.7762889484375;5606.103023516218;5606.691631960241;5606.775728970836;5609.971950140264;5962.731677074498;6003.039513677791;6005.609635373687;6015.037593984942;6015.939840601625;6059.363766804466;6073.969630151865;6115.149072927094;6131.724072416752;6202.658853763041;5754.424557544212;5765.048766953448;5765.077587585966;5771.394003629643;5800.680962547058;6293.402126797947;6297.685115744194;6298.401651843067;6306.527010474141;6310.495160387158;5826.213461182686;5869.119632055226;6003.0695242237525;6058.0610005449225;6077.301110372276;6179.5056395488255;6191.907121393183;6194.411530904647;6194.659293738888;6200.3179650238435;6162.969185154046;6181;6187.597806142587;6191.659458729813;6193;5884.176215329857;5905.852353691106;5908.261467316585;5915.911261331084;6158.784442544489;4603.8849028773875;4608.331791890158;4638.373819534387;4684.531546845288;4704.553067458586;4156.147989662112;4162.125953549788;4162.375643653476;4163.854265100707;4189.685773566995;5975.043992961192;5975.43233392827;5979.282486101695;5983.521318294526;5984.042553191469;5938.881222375615;5949.524038076944;6134.78528251509;6151.415615516519;6154.169187159766;5987.161797348374;6040.577159598874;6043.033114701627;6046.516278697693;6063.423974722395;5264.473552644705;5271.973640131775;5273.525382715574;5277.762500687479;5280;6116.082587611894;6209.472194863397;6358.427741503379;6405.3594640535575;6458.580192287486;6177.351378105414;6191.907121393273;6202.255729312331;6203.4416902479;6204.162438070803;6459.903101453576;6461.709223084878;6462.4183823456115;6471.094046833353;6473.514486413444;5791.7683292667825;5901.350851406428;5940.495057920125;6087.634741915499;6092.208012958287;6078.5441091919165;6086.421789929949;6087.2999605044215;6096.634201947897;6126.08108783686;5960.374160713062;5965.254343207099;5967.91048134287;5972.163897054329;5974.970125149346;5844.824655260349;5879.794207202727;5910.6638558530785;5969.73136208863;5975.073863551156;5934.139549765174;5936.5844390892225;6042.456178943916;6062.757489700539;6080.69596520181;6062.42406971337;6099.054646529795;6118.449339559461;6118.847028824315;6122.020476723703;5720.17057526648;5749;5832.62087964281;5886.146508756292;5959.225300711053 01:59:10 INFO - PROCESS | 8740 | |1;ext.html;757.4546326644814;831.7504748575427;847.8007668197974;917.2295271971547;924.0297687428199;31950.84024579877;44722.10555788886;45080;45094.32358514625;45192.77403612978;47335.76332118343;47501.52498475014;47563;47593.286100708516;47599;7781.766547003571;7791;9059.50172740499;9207.355485116044;10594.099501542378;10176.389416635026;10249.487525623726;10262.281640285182;10264.384136951769;10264.53809578567;10310.278280520366;10331.070203681706;10339.069483746462;10344.482775861214;10347.948260258725;10259.281850270485;10270.845937310947;10321.535530901128;10327.225458090636;10727.463626818668;10468.110210632105;10534.841977370346;10537.473126343652;10541.894581054168;10543.103836173934;42866.571334286884;43180;43214.35178472326;43236.56763432357;43260.56739432628;3982.920341593181;4011.8194681239415;4037.1723796621623;4045.251628448717;4100.897477563085;29707;29819.552706709415;29993.550096748568;30313.69686303131;30569.541456878163;4265.232258193524;4343;4346;4397;4466.3523789050405;227635;228225;228773;229701;229791.8510407454;54306.45693543093;54627.72686136544;54662.72668636632;54684;54736.726316368164;55521;55524.44475555193;55652;55793;55844.44155558474;15163.545093647208;15454.459093931659;15456.459023934332;15468.149251791034;15471.613209669847;11022.173336999756;11332;12674;12984.545540906023;13175.538856140181;13849.099808512414;13989.621764300093;14055.789163162357;14101.435942562388;14176.574702758933;5667.376588575254;5701.800436984686;5706.80026199081;5775.27809023872;5859.912101318484;1029.5367084811865;1032.9173666106694;1035.404642330663;1038.4651904269308;1043.3166276089173;28444.146675599764;28454.288642784097;28646;28727.856360718062;28998.710012899603;1071.6249312740479;1076.612419528969;1097.3470784882982;1103.051375816797;1120.5125770289949;13677.794833077513;17038.74441883373;17040.48878533646;17235.827641723423;18467.53831154205;364113;364748;365185;365581;366652;60285.39714602885;60509.39490605125;60596.39403605996;60606.39393606008;60681;1487.4570781664831;1521.4446726944807;1534.8618624323865;1565.2877940537028;1568.1375243615967;31512;32894.34211315808;33003.83498082494;33149;33343;44242.115157697306;44376.556234437245;44381;44427.33358999553;44483;331634;333157;333869;333962;334458;27389.31526711848;28479.43041139207;31636.209094772814;31754.36491270208;33433.49849752304;45926.31110533411;46132;46342.76828615835;46565;47208;34756.82621586876;35189.29621407609;35326.47010294796;35496.29007419785;35726.10684732902;34359.48460773141;34528.136796580286;34597.65402346045;34816;34878.82560587181;39537.60462395339;39856.402153968294;40203;40847;40982.59017409907;33160.50259246065;33304.1673958153;33449.331013380084;33554.99335019953;33594.832025839714;26526.336841579116;26813.86593067022;26822;26831.731682683705;26976.73023269742 01:59:10 INFO - PROCESS | 8740 | |2;jquery.html;421.8924174335544;439.7493428745614;442.17534298533246;451.8825105472577;483.4054113440468;19719.704204436945;19734;21282.57434851302;21472.785272147274;21573.67639485409;21993.34019979403;21994.230201942933;22259.22092726755;22424.215152469667;22915;6622.337766223387;6781.966090169542;6919.44644428447;6943.72225110995;6955.582665040089;6722.193336799566;6796.150481189851;6823.215330237037;6823.351781580742;6833.863322733542;6581.638009909453;6804.115464989544;6836.623985680785;6855.862882742342;6857.588544687334;6584.5061620378665;6782.796516104525;6805.217399999014;6812.080369150176;6834.931650683479;6609.975453804668;6673.4661227101715;6679.933200668028;6684.465242780566;6689.197296324423;25611;25642.48715025708;25677.87161064183;25932.22203333884;25944.74055259442;3542.6457354264626;3562.536870206882;3571.8749843755345;3606.008347704376;3663.523741913561;16094;16628;16765.580860478465;16809.495715128567;17209;2209.6464565669576;2258.8531745436494;2282.63311615366;2315.617923042696;2332.4635333873302;91483;94931;98265;98444;99047.50476247644;18620.627587448176;19127.904360478387;19281.710774338397;19294.517637059187;19377.90311048464;34916.82541587276;34949.47575786365;34988.65011349905;35000.474992875126;35109.8934063957;9862.605495780088;9935.602575897028;9936.900630993741;10001.34991225568;10164.847527287096;7989.56057416836;8136.633851476698;8149.755507334789;8218.671253149927;8300.2114799094;9944.900550994398;10063.226290141198;10095.495225238708;10145.64490242838;10398.220133490018;3518.876839310663;3606.2213288487483;3864.4976153099915;3883.184531248413;3942.6630706222927;987.7135630667026;1001.1007127239362;1001.9649312274181;1016.7661437869332;1029.6036026129843;21911.67132492982;22253.332400028026;22286.888565557394;22300.55398892013;22303.553928921654;1015.94920253987;1019.887812340642;1021.4484178543652;1028.2236911132197;1044.8014877173464;11544.59593914209;12558;12592.244465331925;12595.433205505775;12733.872661273268;668701;694172;694923;715846;716934;90953;94096.52951735334;94633.5268323654;96022;108868;1325.4234408032537;1353.472145863114;1355.302019459979;1392.9442822286994;1399.7970294307268;17637.64724705473;18111;19174.328898488486;19176.328828491492;19326.806731932502;41351;51055.2341714882;52055;52626;53577.732111339195;71206;71328.64335678496;71775.28224717686;72738.63630681812;74421.25578744143;12087.697807554881;12193.695157620776;12193.878061219275;12304.630861074182;12395.566155184526;12708.618741437771;12836.101472896808;13299.800502992657;13518.797218041935;14753.778693319824;11485.253458525169;11774.764504710029;12239.164329585758;12588.30764307972;12882.742345152858;10486.842697359698;10529.842052369373;10601.946990265;10919;11118.332900026024;10964.451777410937;11541.942290288494;11574.710632233924;12163.939180304042;12516.123871329284;11378.772424551627;11633.243839150427;11739.295642261492;11750.94124529372;11753.412329383325;12012.579559715718;12053.397330133634;12146.939265303618;12184.086193535697;12695.619131426072 01:59:10 INFO - PROCESS | 8740 | |3;mootools.html;1446.994338934441;1563.9374425023;1578.3765412661999;1590.7216237158498;1603.4628399486169;9292.488913109784;11330.150238732098;11700.473478693459;12087.335196564185;12090;11755.41222938854;11818.7636247275;11888.167828252026;11928;11928.880711192885;2041.061111888533;2111.144986280551;2296.9885150574223;2332.230363979891;2337.1118974789642;2287.462446325112;2350.4123969007746;2350.518143780521;2356.1400088967575;2370.3600027992434;2355.2463211772238;2408.313630615275;2416.154345978911;2417.806575473967;2420.854748715074;2356.646503024543;2398.304491697406;2398.688170537828;2403.170906037414;2403.6875206223253;2311.179531266393;2317;2319.5476882008015;2320.872352020638;2324.7675232476786;11915.106367022508;12015.158938874283;12016.399180040962;12022;12024.579139730067;5637.887242255132;5731.254936858223;5888.823335299948;5890.528757699374;5891.882162356772;3156.9052928412184;3242.4974129010043;3392.8473218705217;3406.557147570825;3408.727301815849;1267.9492820287178;1304.4390911907876;1309.9127723989066;1316.3681432912256;2316.455632926261;17957.191926363346;18202.63594728098;18210.180541875514;18211.360977511955;18217.362392316205;4507.18870603288;4585.220512512881;4602.332661764092;4602.631789456836;4625.629949604024;13323.13399629021;13330.933345333406;13342.466301347837;13355.933220334031;13376.866231337563;5761.625494342854;5767.279090113736;5772.422757724278;5776.566757493205;5779.7110144493445;4332.393464914914;4433.512313645497;5122;5205.583553315726;5226.320578324793;3972.662323702518;4045.0696339842;4080.2451546464;4116.135611521554;4145.067359844011;995.2386424385351;1011.4133802394593;1014.2190513304714;1020.4897551224387;1023.2019025160387;990.821652102614;1005.1305620638095;1007.254631572631;1010.0354161775487;1010.2776514791959;6288.371162883675;6417.486601071903;6439.5170362223025;6476.643784591893;6559.8032059038305;1004.7588578741196;1027.075631931253;1039.1478987230398;1045.7856139491387;1100.0979197058496;3968.6825053995613;4095.5970839507845;4190.350495673176;4194.979614677427;4220.725652832556;14315;14944.40222391114;14964.850351496345;14964.850351496345;15025.549233523012;14537.273136343141;14792.408303667733;14993.850061499244;14996.775048374284;15033.398664053535;10335.94832025835;10522.31604945676;10595.09941654968;10842.94578527118;10973.50619222137;6612.867742645217;6694.230163531256;6701.932980670131;6748.527603067738;6750.223724271772;12628.368581570701;12773;12804.167729097579;12817.935910320388;12945.676358091123;12624.55814046504;12636.494540218288;12694.238345698917;12741.426635801596;12842.165259258118;8632.179942905414;8741.694040708544;9459.952700236454;9701.272404569545;9819.116279534876;11289;11420.543178272776;11525.423728813357;11528.481218345027;11539.307641541534;9434.716958491255;9475.526223688927;9498.382605130644;9563.521823908637;9702.029797020241;8867.73396798097;8887.244584210155;9009.144131307516;9070.954645226731;9315;8537.53043582609;8538.316934645089;8538.487690738575;8550.957245213984;8561.357898157788;5756.856078598069;5787.94212057874;5805.680687562056;5840.707964601668;5960.821175364746;5963.642181469126;5986.9401305986385;5997.3402925677265;6056.818295451144;6091.116788065794 01:59:10 INFO - PROCESS | 8740 | |4;prototype.html;391.9811297526479;397.5368695469778;409.7848629469528;421.515257453928;423.4537446693764;5173.637845350827;5198.922016169756;5238.449962753908;5249.790008399669;5267.762950667219;4974.204127339626;5066.468020857812;5078.263651770491;5116.488351164881;5129.871753206172;4319.935200971988;4334.436523251989;4337.566243375653;4343.087951530182;4343.348497725351;4345.152695224432;4364.367166760818;4364.541723119059;4367.235733746597;4375.890602734925;4190.685698572604;4285.635720963722;4290.957090429087;4291.969927217461;4305.741655500664;4259.723117997351;4315.892102697442;4318.740875547477;4331.6534677225745;4342.696011279212;4076.4496792932873;4083.7141400102005;4102.671786257092;4116.938245926313;4142.275101857163;4851.757412129415;5098.796048158069;5110.897782044375;5138.126518491828;5168.586513078944;5079.2127220280545;5080.30072183229;5087.440381558025;5105.8723531912;5126.846194614131;5468.9726551367385;5477.000894673455;5477.589180811455;5481.369642491085;5511.641743286674;4391.49497807753;4491.663125265618;4501.909961800746;4602.079584083197;4606.700564463299;5380.461953804588;5457.372402173761;5467.289252397163;5604.495595396434;5617.522510586605;4570.497245303014;4612.515685852937;4623.630109591225;4634.957134644746;4635.698679585884;4554.884053406937;4721.716696998191;4737.786799594027;4743.691660042086;4746.145693775154;4924.852254432372;4932.802687892516;4991.775370108354;5005.849824505271;5016.197408414636;5392.272043274108;5426.290718423684;5430.239766432703;5433.83698489038;5435.728213589305;1568.3726509396333;1614.564067701714;1625.634701509301;1633.3466613354753;1641.1712085396798;1221.4015132584968;1261.4575732435142;1276.2087505746497;1276.961691149267;1286.7297867447753;5368.624196306221;5371.731413429313;5413.566914646819;5426.8371948841595;5432.2123292123215;5558.388577256498;5571.860703482445;5591.692456914909;5612.494875461228;5619.550435965113;5129.281900533928;5406.972965135228;5431.83704488866;5433.646812957224;5441.319835020622;2898.971010289912;2906.3751293472005;2911.2721819545113;2924.9707502925125;2939.882404703788;5682.971585142048;5781.364049954502;5830.82507524775;5865.970670146622;5885.146653735184;5571.693556854331;5667.291588551431;5677.971610141923;5699.316082070178;5723.284589426322;5810.854728631818;5818.44724751148;5838.737256823369;5862.530997520188;5866.823995280149;5283.418823929288;5461.726913654381;5462.180672899097;5493.258410114583;5660;5302.647824804651;5379.704116273642;5404.945950540444;5574.637648552831;5574.832755017356;5744.4829965303325;5763.308402991668;5794.449527294901;5826.329972053268;5854.941450585439;4579.885502862322;4662.347271382077;4662.580367766917;4698.8355407560575;4702.247640377524;5498.725063746877;5622.803201887914;5629.831105066854;5631.6902570359025;5644.153376993484;5417.377001644862;5427;5459.535939445032;5492.368377636623;5492.588055895744;5228.869278268074;5424.511793938565;5430.565554755531;5455.972720136374;5514.338279406497;5325.573954083741;5359.624826262124;5408.810691625774;5422.755975981011;5464.371597266365;5436.429174936575;5466.644668096561;5540.833774986757;5552.86214807294;5561.332640083054;4962.6774259673;5250.346140965584;5330.9466905332;5393.271908292487;5424.593155513431 01:59:10 INFO - PROCESS | 8740 | |5;yui.html;815.6207363575936;826.2852632472913;897.6992707443011;897.7127319257836;898.2125570115472;15934.601634959117;17611.119444027794;17852.64294714105;17865.553361165978;17882.105894705262;16629;16958.745618815698;16988.065656388895;17003.57491062724;17019.82980170198;863.740877736678;879.4371602174614;882.5190271302124;889.1686273334453;889.6130183370254;881.383031877685;883.9690610828623;886.4149661223594;886.6054605700466;887.0464250930244;937.0488953711988;938.1650331205233;938.3572253006678;938.3853575907791;938.6245501799267;929.2287401456808;930.2000279759402;930.241852889896;931.0177762460602;932.5570354081825;686.4817063117315;687.779910428663;687.9208890977552;688.2601203705987;688.5042769206163;17952.91023544874;17996.910015449837;18048.729269060976;18573;18805.717914231296;15845.92077039619;16029.15664698563;16224.432144874872;16284.674306513803;16339.918300408423;13630.659233519142;13766.380512876945;13862.237576933265;14468.131912085308;14809.481668141563;4082.4692789937417;4092.1815636872448;4114.053767633432;4153.169366126786;4240.130773191519;90179.09820901773;90488.54755726179;90708.54645726795;92123.07876921212;94391.52804235935;11434.599789007345;11530.711732206762;11600.303981760953;11656.41717914101;11708.473118709679;23417.531649366916;23565.29304120879;23582.882085589463;23609.1736789215;23705.7629423707;8222.917770822334;8317.334613230927;8325.583720813935;8431;8432.347656909102;4880.389951256093;4963.950360496421;4997.425296090923;5006.3992320921725;5089.185730283137;3704.9259014819554;3808.1431677872256;3809.8666546670734;3811.009137624182;3813.0848596336677;591.9197464626986;593.5666963116948;610.206731249374;617.102116420607;625.0967352176062;801.8276070644723;818.5334359415076;836.5022811427191;838.6058552480324;853.2363534636589;11419.31484110956;11468.4839182237;11482.311061336346;11553.826692599618;11793.11551633631;794.586814856283;795.3478147918767;804.8511025460191;806.6531391501711;808.8686311569057;5427.864303392446;5436.91844622331;5452.672839629635;5496.285482887199;5517.2551705520045;83791.5810420944;87603;88402;90353.54823225974;90901;75503.24496755072;76886.23113768903;78303;78521.60739196268;79312;67660.6616966912;68393.65803170952;68610.65694671594;68883.65558172077;69071;10514.474276286308;10607.591785936527;10822.621208257673;10831;10874;48419.27371089366;48831.511684882695;48866.75566622144;49242.75378623084;50603.13029608185;53343;53756.19365709596;53844;54973.45026549683;56040;12177.330246836154;12408.75182496363;12461.439235234617;12464.626061218178;12793.8080928788;14567.41730330775;14595.270236488346;14807.777883331973;14828.481003164838;14976.326065327305;12860.164089334163;13171.47314107425;13560.86439135596;13710.451581936612;14170.058683980522;13390.129641573267;13413.731725365244;13488.460461581426;13527.053106282467;13548.458061677422;13268.867311326763;13270.071095023643;13357.866421335662;13723.588292351245;13859.099158554662;9967.850482242917;10031.147352475122;10091.041351071637;10259.487025648838;10263.384196947909;11300.773984520429;11301.963408969421;11399.886001139883;11567.479463423997;11586.652400428 01:59:10 INFO - PROCESS | 8740 | __end_tp_report 01:59:10 INFO - PROCESS | 8740 | __start_cc_report 01:59:10 INFO - PROCESS | 8740 | _x_x_mozilla_cycle_collect,1088 01:59:10 INFO - PROCESS | 8740 | __end_cc_report 01:59:10 INFO - PROCESS | 8740 | __startTimestamp1493629150504__endTimestamp 01:59:10 INFO - PROCESS | 8740 | 01:59:10 INFO - PROCESS | 8740 | ------- Summary: start ------- 01:59:10 INFO - PROCESS | 8740 | Number of tests: 6 01:59:10 INFO - PROCESS | 8740 | 01:59:10 INFO - PROCESS | 8740 | [#0] dojo.html Cycles:165 Average:5686.52 Median:5938.88 stddev:652.29 (11.0%) stddev-sans-first:629.17 01:59:10 INFO - PROCESS | 8740 | Values: 3401.2 3407.5 3416.9 3423.0 3478.8 5649.8 5725.4 5727.5 5731.5 5740.6 5721.0 5764.5 5765.9 5776.1 5776.4 5119.0 5122.8 5124.1 5136.2 5175.9 4997.9 5000.1 5145.2 5149.2 5177.1 5070.6 5101.6 5117.6 5128.4 5161.5 5185.9 5191.5 5192.9 5196.4 5216.3 4972.7 5049.4 5116.0 5158.5 5170.9 5592.8 5606.1 5606.7 5606.8 5610.0 5962.7 6003.0 6005.6 6015.0 6015.9 6059.4 6074.0 6115.1 6131.7 6202.7 5754.4 5765.0 5765.1 5771.4 5800.7 6293.4 6297.7 6298.4 6306.5 6310.5 5826.2 5869.1 6003.1 6058.1 6077.3 6179.5 6191.9 6194.4 6194.7 6200.3 6163.0 6181.0 6187.6 6191.7 6193.0 5884.2 5905.9 5908.3 5915.9 6158.8 4603.9 4608.3 4638.4 4684.5 4704.6 4156.1 4162.1 4162.4 4163.9 4189.7 5975.0 5975.4 5979.3 5983.5 5984.0 5938.9 5949.5 6134.8 6151.4 6154.2 5987.2 6040.6 6043.0 6046.5 6063.4 5264.5 5272.0 5273.5 5277.8 5280.0 6116.1 6209.5 6358.4 6405.4 6458.6 6177.4 6191.9 6202.3 6203.4 6204.2 6459.9 6461.7 6462.4 6471.1 6473.5 5791.8 5901.4 5940.5 6087.6 6092.2 6078.5 6086.4 6087.3 6096.6 6126.1 5960.4 5965.3 5967.9 5972.2 5975.0 5844.8 5879.8 5910.7 5969.7 5975.1 5934.1 5936.6 6042.5 6062.8 6080.7 6062.4 6099.1 6118.4 6118.8 6122.0 5720.2 5749.0 5832.6 5886.1 5959.2 01:59:10 INFO - PROCESS | 8740 | 01:59:10 INFO - PROCESS | 8740 | [#1] ext.html Cycles:180 Average:48391.10 Median:333915.50 stddev:82480.64 (24.7%) stddev-sans-first:82634.48 01:59:10 INFO - PROCESS | 8740 | Values: 757.5 831.8 847.8 917.2 924.0 31950.8 44722.1 45080.0 45094.3 45192.8 47335.8 47501.5 47563.0 47593.3 47599.0 7781.8 7791.0 9059.5 9207.4 10594.1 10176.4 10249.5 10262.3 10264.4 10264.5 10310.3 10331.1 10339.1 10344.5 10347.9 10259.3 10270.8 10321.5 10327.2 10727.5 10468.1 10534.8 10537.5 10541.9 10543.1 42866.6 43180.0 43214.4 43236.6 43260.6 3982.9 4011.8 4037.2 4045.3 4100.9 29707.0 29819.6 29993.6 30313.7 30569.5 4265.2 4343.0 4346.0 4397.0 4466.4 227635.0 228225.0 228773.0 229701.0 229791.9 54306.5 54627.7 54662.7 54684.0 54736.7 55521.0 55524.4 55652.0 55793.0 55844.4 15163.5 15454.5 15456.5 15468.1 15471.6 11022.2 11332.0 12674.0 12984.5 13175.5 13849.1 13989.6 14055.8 14101.4 14176.6 5667.4 5701.8 5706.8 5775.3 5859.9 1029.5 1032.9 1035.4 1038.5 1043.3 28444.1 28454.3 28646.0 28727.9 28998.7 1071.6 1076.6 1097.3 1103.1 1120.5 13677.8 17038.7 17040.5 17235.8 18467.5 364113.0 364748.0 365185.0 365581.0 366652.0 60285.4 60509.4 60596.4 60606.4 60681.0 1487.5 1521.4 1534.9 1565.3 1568.1 31512.0 32894.3 33003.8 33149.0 33343.0 44242.1 44376.6 44381.0 44427.3 44483.0 331634.0 333157.0 333869.0 333962.0 334458.0 27389.3 28479.4 31636.2 31754.4 33433.5 45926.3 46132.0 46342.8 46565.0 47208.0 34756.8 35189.3 35326.5 35496.3 35726.1 34359.5 34528.1 34597.7 34816.0 34878.8 39537.6 39856.4 40203.0 40847.0 40982.6 33160.5 33304.2 33449.3 33555.0 33594.8 26526.3 26813.9 26822.0 26831.7 26976.7 01:59:10 INFO - PROCESS | 8740 | 01:59:10 INFO - PROCESS | 8740 | [#2] jquery.html Cycles:180 Average:37963.29 Median:12341.53 stddev:114372.97 (926.7%) stddev-sans-first:114659.07 01:59:10 INFO - PROCESS | 8740 | Values: 421.9 439.7 442.2 451.9 483.4 19719.7 19734.0 21282.6 21472.8 21573.7 21993.3 21994.2 22259.2 22424.2 22915.0 6622.3 6782.0 6919.4 6943.7 6955.6 6722.2 6796.2 6823.2 6823.4 6833.9 6581.6 6804.1 6836.6 6855.9 6857.6 6584.5 6782.8 6805.2 6812.1 6834.9 6610.0 6673.5 6679.9 6684.5 6689.2 25611.0 25642.5 25677.9 25932.2 25944.7 3542.6 3562.5 3571.9 3606.0 3663.5 16094.0 16628.0 16765.6 16809.5 17209.0 2209.6 2258.9 2282.6 2315.6 2332.5 91483.0 94931.0 98265.0 98444.0 99047.5 18620.6 19127.9 19281.7 19294.5 19377.9 34916.8 34949.5 34988.7 35000.5 35109.9 9862.6 9935.6 9936.9 10001.3 10164.8 7989.6 8136.6 8149.8 8218.7 8300.2 9944.9 10063.2 10095.5 10145.6 10398.2 3518.9 3606.2 3864.5 3883.2 3942.7 987.7 1001.1 1002.0 1016.8 1029.6 21911.7 22253.3 22286.9 22300.6 22303.6 1015.9 1019.9 1021.4 1028.2 1044.8 11544.6 12558.0 12592.2 12595.4 12733.9 668701.0 694172.0 694923.0 715846.0 716934.0 90953.0 94096.5 94633.5 96022.0 108868.0 1325.4 1353.5 1355.3 1392.9 1399.8 17637.6 18111.0 19174.3 19176.3 19326.8 41351.0 51055.2 52055.0 52626.0 53577.7 71206.0 71328.6 71775.3 72738.6 74421.3 12087.7 12193.7 12193.9 12304.6 12395.6 12708.6 12836.1 13299.8 13518.8 14753.8 11485.3 11774.8 12239.2 12588.3 12882.7 10486.8 10529.8 10601.9 10919.0 11118.3 10964.5 11541.9 11574.7 12163.9 12516.1 11378.8 11633.2 11739.3 11750.9 11753.4 12012.6 12053.4 12146.9 12184.1 12695.6 01:59:10 INFO - PROCESS | 8740 | 01:59:10 INFO - PROCESS | 8740 | [#3] mootools.html Cycles:180 Average:7103.44 Median:2355.69 stddev:4717.55 (200.3%) stddev-sans-first:4711.64 01:59:10 INFO - PROCESS | 8740 | Values: 1447.0 1563.9 1578.4 1590.7 1603.5 9292.5 11330.2 11700.5 12087.3 12090.0 11755.4 11818.8 11888.2 11928.0 11928.9 2041.1 2111.1 2297.0 2332.2 2337.1 2287.5 2350.4 2350.5 2356.1 2370.4 2355.2 2408.3 2416.2 2417.8 2420.9 2356.6 2398.3 2398.7 2403.2 2403.7 2311.2 2317.0 2319.5 2320.9 2324.8 11915.1 12015.2 12016.4 12022.0 12024.6 5637.9 5731.3 5888.8 5890.5 5891.9 3156.9 3242.5 3392.8 3406.6 3408.7 1267.9 1304.4 1309.9 1316.4 2316.5 17957.2 18202.6 18210.2 18211.4 18217.4 4507.2 4585.2 4602.3 4602.6 4625.6 13323.1 13330.9 13342.5 13355.9 13376.9 5761.6 5767.3 5772.4 5776.6 5779.7 4332.4 4433.5 5122.0 5205.6 5226.3 3972.7 4045.1 4080.2 4116.1 4145.1 995.2 1011.4 1014.2 1020.5 1023.2 990.8 1005.1 1007.3 1010.0 1010.3 6288.4 6417.5 6439.5 6476.6 6559.8 1004.8 1027.1 1039.1 1045.8 1100.1 3968.7 4095.6 4190.4 4195.0 4220.7 14315.0 14944.4 14964.9 14964.9 15025.5 14537.3 14792.4 14993.9 14996.8 15033.4 10335.9 10522.3 10595.1 10842.9 10973.5 6612.9 6694.2 6701.9 6748.5 6750.2 12628.4 12773.0 12804.2 12817.9 12945.7 12624.6 12636.5 12694.2 12741.4 12842.2 8632.2 8741.7 9460.0 9701.3 9819.1 11289.0 11420.5 11525.4 11528.5 11539.3 9434.7 9475.5 9498.4 9563.5 9702.0 8867.7 8887.2 9009.1 9071.0 9315.0 8537.5 8538.3 8538.5 8551.0 8561.4 5756.9 5787.9 5805.7 5840.7 5960.8 5963.6 5986.9 5997.3 6056.8 6091.1 01:59:10 INFO - PROCESS | 8740 | 01:59:10 INFO - PROCESS | 8740 | [#4] prototype.html Cycles:180 Average:4749.92 Median:5244.12 stddev:1266.62 (24.2%) stddev-sans-first:1227.21 01:59:10 INFO - PROCESS | 8740 | Values: 392.0 397.5 409.8 421.5 423.5 5173.6 5198.9 5238.4 5249.8 5267.8 4974.2 5066.5 5078.3 5116.5 5129.9 4319.9 4334.4 4337.6 4343.1 4343.3 4345.2 4364.4 4364.5 4367.2 4375.9 4190.7 4285.6 4291.0 4292.0 4305.7 4259.7 4315.9 4318.7 4331.7 4342.7 4076.4 4083.7 4102.7 4116.9 4142.3 4851.8 5098.8 5110.9 5138.1 5168.6 5079.2 5080.3 5087.4 5105.9 5126.8 5469.0 5477.0 5477.6 5481.4 5511.6 4391.5 4491.7 4501.9 4602.1 4606.7 5380.5 5457.4 5467.3 5604.5 5617.5 4570.5 4612.5 4623.6 4635.0 4635.7 4554.9 4721.7 4737.8 4743.7 4746.1 4924.9 4932.8 4991.8 5005.8 5016.2 5392.3 5426.3 5430.2 5433.8 5435.7 1568.4 1614.6 1625.6 1633.3 1641.2 1221.4 1261.5 1276.2 1277.0 1286.7 5368.6 5371.7 5413.6 5426.8 5432.2 5558.4 5571.9 5591.7 5612.5 5619.6 5129.3 5407.0 5431.8 5433.6 5441.3 2899.0 2906.4 2911.3 2925.0 2939.9 5683.0 5781.4 5830.8 5866.0 5885.1 5571.7 5667.3 5678.0 5699.3 5723.3 5810.9 5818.4 5838.7 5862.5 5866.8 5283.4 5461.7 5462.2 5493.3 5660.0 5302.6 5379.7 5404.9 5574.6 5574.8 5744.5 5763.3 5794.4 5826.3 5854.9 4579.9 4662.3 4662.6 4698.8 4702.2 5498.7 5622.8 5629.8 5631.7 5644.2 5417.4 5427.0 5459.5 5492.4 5492.6 5228.9 5424.5 5430.6 5456.0 5514.3 5325.6 5359.6 5408.8 5422.8 5464.4 5436.4 5466.6 5540.8 5552.9 5561.3 4962.7 5250.3 5330.9 5393.3 5424.6 01:59:10 INFO - PROCESS | 8740 | 01:59:10 INFO - PROCESS | 8740 | [#5] yui.html Cycles:180 Average:19258.40 Median:26855.95 stddev:25112.95 (93.5%) stddev-sans-first:25145.21 01:59:10 INFO - PROCESS | 8740 | Values: 815.6 826.3 897.7 897.7 898.2 15934.6 17611.1 17852.6 17865.6 17882.1 16629.0 16958.7 16988.1 17003.6 17019.8 863.7 879.4 882.5 889.2 889.6 881.4 884.0 886.4 886.6 887.0 937.0 938.2 938.4 938.4 938.6 929.2 930.2 930.2 931.0 932.6 686.5 687.8 687.9 688.3 688.5 17952.9 17996.9 18048.7 18573.0 18805.7 15845.9 16029.2 16224.4 16284.7 16339.9 13630.7 13766.4 13862.2 14468.1 14809.5 4082.5 4092.2 4114.1 4153.2 4240.1 90179.1 90488.5 90708.5 92123.1 94391.5 11434.6 11530.7 11600.3 11656.4 11708.5 23417.5 23565.3 23582.9 23609.2 23705.8 8222.9 8317.3 8325.6 8431.0 8432.3 4880.4 4964.0 4997.4 5006.4 5089.2 3704.9 3808.1 3809.9 3811.0 3813.1 591.9 593.6 610.2 617.1 625.1 801.8 818.5 836.5 838.6 853.2 11419.3 11468.5 11482.3 11553.8 11793.1 794.6 795.3 804.9 806.7 808.9 5427.9 5436.9 5452.7 5496.3 5517.3 83791.6 87603.0 88402.0 90353.5 90901.0 75503.2 76886.2 78303.0 78521.6 79312.0 67660.7 68393.7 68610.7 68883.7 69071.0 10514.5 10607.6 10822.6 10831.0 10874.0 48419.3 48831.5 48866.8 49242.8 50603.1 53343.0 53756.2 53844.0 54973.5 56040.0 12177.3 12408.8 12461.4 12464.6 12793.8 14567.4 14595.3 14807.8 14828.5 14976.3 12860.2 13171.5 13560.9 13710.5 14170.1 13390.1 13413.7 13488.5 13527.1 13548.5 13268.9 13270.1 13357.9 13723.6 13859.1 9967.9 10031.1 10091.0 10259.5 10263.4 11300.8 11302.0 11399.9 11567.5 11586.7 01:59:10 INFO - PROCESS | 8740 | -------- Summary: end -------- 01:59:10 INFO - PROCESS | 8740 | 01:59:11 INFO - TEST-INFO | 8740: exit 0 01:59:11 INFO - TEST-OK | dromaeo_css | took 1115045ms 01:59:11 INFO - TEST-START | kraken 01:59:11 INFO - operating with platform_type : linux_ 01:59:11 INFO - Initialising browser for kraken test... 01:59:11 INFO - TEST-INFO | started process 9062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpznVy9P/profile http://localhost:58459/getInfo.html) 01:59:15 INFO - PROCESS | 9062 | __metrics Screen width/height:1600/1200 01:59:15 INFO - PROCESS | 9062 | colorDepth:24 01:59:15 INFO - PROCESS | 9062 | Browser inner width/height: 1024/697 01:59:15 INFO - PROCESS | 9062 | __metrics 01:59:16 INFO - PROCESS | 9062 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:59:16 INFO - PROCESS | 9062 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:59:17 INFO - TEST-INFO | 9062: exit 0 01:59:17 INFO - Browser initialized. 01:59:17 INFO - Running cycle 1/1 for kraken test... 01:59:17 INFO - TEST-INFO | started process 9155 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpznVy9P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:59:28 INFO - PROCESS | 9155 | RSS: Main: 139583488 01:59:28 INFO - PROCESS | 9155 | 01:59:31 INFO - PROCESS | 9155 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58459/tests/kraken/driver.html?testName=audio-beat-detection) 01:59:32 INFO - PROCESS | 9155 | RSS: Main: 182820864 01:59:32 INFO - PROCESS | 9155 | 01:59:34 INFO - PROCESS | 9155 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58459/tests/kraken/driver.html?testName=audio-dft) 01:59:35 INFO - PROCESS | 9155 | RSS: Main: 173686784 01:59:35 INFO - PROCESS | 9155 | 01:59:38 INFO - PROCESS | 9155 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58459/tests/kraken/driver.html?testName=audio-fft) 01:59:38 INFO - PROCESS | 9155 | RSS: Main: 265134080 01:59:38 INFO - PROCESS | 9155 | 01:59:40 INFO - PROCESS | 9155 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58459/tests/kraken/driver.html?testName=audio-oscillator) 01:59:41 INFO - PROCESS | 9155 | RSS: Main: 171802624 01:59:41 INFO - PROCESS | 9155 | 01:59:43 INFO - PROCESS | 9155 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58459/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:59:44 INFO - PROCESS | 9155 | RSS: Main: 174202880 01:59:44 INFO - PROCESS | 9155 | 01:59:47 INFO - PROCESS | 9155 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58459/tests/kraken/driver.html?testName=imaging-darkroom) 01:59:47 INFO - PROCESS | 9155 | RSS: Main: 213610496 01:59:47 INFO - PROCESS | 9155 | 01:59:51 INFO - PROCESS | 9155 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58459/tests/kraken/driver.html?testName=imaging-desaturate) 01:59:51 INFO - PROCESS | 9155 | RSS: Main: 211664896 01:59:51 INFO - PROCESS | 9155 | 01:59:54 INFO - PROCESS | 9155 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58459/tests/kraken/driver.html?testName=json-parse-financial) 01:59:54 INFO - PROCESS | 9155 | RSS: Main: 209936384 01:59:54 INFO - PROCESS | 9155 | 01:59:56 INFO - PROCESS | 9155 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58459/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:59:57 INFO - PROCESS | 9155 | RSS: Main: 172675072 01:59:57 INFO - PROCESS | 9155 | 01:59:58 INFO - PROCESS | 9155 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58459/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:59:59 INFO - PROCESS | 9155 | RSS: Main: 179744768 01:59:59 INFO - PROCESS | 9155 | 02:00:01 INFO - PROCESS | 9155 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58459/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:00:01 INFO - PROCESS | 9155 | RSS: Main: 188964864 02:00:01 INFO - PROCESS | 9155 | 02:00:04 INFO - PROCESS | 9155 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:00:05 INFO - PROCESS | 9155 | RSS: Main: 198250496 02:00:05 INFO - PROCESS | 9155 | 02:00:07 INFO - PROCESS | 9155 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:00:08 INFO - PROCESS | 9155 | RSS: Main: 194355200 02:00:08 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | Cycle 1(1): loaded http://localhost:58459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58459/tests/kraken/driver.html?testName=ai-astar) 02:00:10 INFO - PROCESS | 9155 | RSS: Main: 245202944 02:00:10 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | __start_tp_report 02:00:10 INFO - PROCESS | 9155 | _x_x_mozilla_page_load 02:00:10 INFO - PROCESS | 9155 | _x_x_mozilla_page_load_details 02:00:10 INFO - PROCESS | 9155 | |i|pagename|runs| 02:00:10 INFO - PROCESS | 9155 | |0;ai-astar;103;113;112;112;114;113;113;112;114;112 02:00:10 INFO - PROCESS | 9155 | |1;audio-beat-detection;142;115;117;157;118;116;116;115;131;117 02:00:10 INFO - PROCESS | 9155 | |2;audio-dft;160;162;161;161;160;161;161;160;160;161 02:00:10 INFO - PROCESS | 9155 | |3;audio-fft;76;75;76;109;76;77;77;78;96;75 02:00:10 INFO - PROCESS | 9155 | |4;audio-oscillator;83;82;108;82;83;82;94;82;82;98 02:00:10 INFO - PROCESS | 9155 | |5;imaging-gaussian-blur;113;113;114;113;114;113;113;114;113;113 02:00:10 INFO - PROCESS | 9155 | |6;imaging-darkroom;146;146;147;148;149;146;146;146;146;146 02:00:10 INFO - PROCESS | 9155 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;93 02:00:10 INFO - PROCESS | 9155 | |8;json-parse-financial;53;53;54;53;54;55;54;53;53;54 02:00:10 INFO - PROCESS | 9155 | |9;json-stringify-tinderbox;54;53;66;56;53;54;52;53;53;56 02:00:10 INFO - PROCESS | 9155 | |10;stanford-crypto-aes;79;76;75;77;79;79;76;76;79;80 02:00:10 INFO - PROCESS | 9155 | |11;stanford-crypto-ccm;132;134;136;122;121;122;127;120;163;145 02:00:10 INFO - PROCESS | 9155 | |12;stanford-crypto-pbkdf2;163;164;162;162;156;157;163;158;160;158 02:00:10 INFO - PROCESS | 9155 | |13;stanford-crypto-sha256-iterative;61;61;60;60;60;60;60;59;60;59 02:00:10 INFO - PROCESS | 9155 | __end_tp_report 02:00:10 INFO - PROCESS | 9155 | __start_cc_report 02:00:10 INFO - PROCESS | 9155 | _x_x_mozilla_cycle_collect,1687 02:00:10 INFO - PROCESS | 9155 | __end_cc_report 02:00:10 INFO - PROCESS | 9155 | __startTimestamp1493629210374__endTimestamp 02:00:10 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | ------- Summary: start ------- 02:00:10 INFO - PROCESS | 9155 | Number of tests: 14 02:00:10 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:3.19 (2.8%) stddev-sans-first:0.83 02:00:10 INFO - PROCESS | 9155 | Values: 103.0 113.0 112.0 112.0 114.0 113.0 113.0 112.0 114.0 112.0 02:00:10 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | [#1] audio-beat-detection Cycles:10 Average:124.40 Median:117.50 stddev:14.47 (12.3%) stddev-sans-first:13.88 02:00:10 INFO - PROCESS | 9155 | Values: 142.0 115.0 117.0 157.0 118.0 116.0 116.0 115.0 131.0 117.0 02:00:10 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 02:00:10 INFO - PROCESS | 9155 | Values: 160.0 162.0 161.0 161.0 160.0 161.0 161.0 160.0 160.0 161.0 02:00:10 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.50 stddev:11.52 (15.1%) stddev-sans-first:12.05 02:00:10 INFO - PROCESS | 9155 | Values: 76.0 75.0 76.0 109.0 76.0 77.0 77.0 78.0 96.0 75.0 02:00:10 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | [#4] audio-oscillator Cycles:10 Average:87.60 Median:82.50 stddev:9.22 (11.2%) stddev-sans-first:9.62 02:00:10 INFO - PROCESS | 9155 | Values: 83.0 82.0 108.0 82.0 83.0 82.0 94.0 82.0 82.0 98.0 02:00:10 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:00:10 INFO - PROCESS | 9155 | Values: 113.0 113.0 114.0 113.0 114.0 113.0 113.0 114.0 113.0 113.0 02:00:10 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 02:00:10 INFO - PROCESS | 9155 | Values: 146.0 146.0 147.0 148.0 149.0 146.0 146.0 146.0 146.0 146.0 02:00:10 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:00:10 INFO - PROCESS | 9155 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 02:00:10 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 02:00:10 INFO - PROCESS | 9155 | Values: 53.0 53.0 54.0 53.0 54.0 55.0 54.0 53.0 53.0 54.0 02:00:10 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:54.00 stddev:4.08 (7.6%) stddev-sans-first:4.31 02:00:10 INFO - PROCESS | 9155 | Values: 54.0 53.0 66.0 56.0 53.0 54.0 52.0 53.0 53.0 56.0 02:00:10 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:79.00 stddev:1.78 (2.2%) stddev-sans-first:1.81 02:00:10 INFO - PROCESS | 9155 | Values: 79.0 76.0 75.0 77.0 79.0 79.0 76.0 76.0 79.0 80.0 02:00:10 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:133.00 stddev:13.50 (10.1%) stddev-sans-first:14.32 02:00:10 INFO - PROCESS | 9155 | Values: 132.0 134.0 136.0 122.0 121.0 122.0 127.0 120.0 163.0 145.0 02:00:10 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:162.00 stddev:2.87 (1.8%) stddev-sans-first:2.87 02:00:10 INFO - PROCESS | 9155 | Values: 163.0 164.0 162.0 162.0 156.0 157.0 163.0 158.0 160.0 158.0 02:00:10 INFO - PROCESS | 9155 | 02:00:10 INFO - PROCESS | 9155 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.00 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 02:00:10 INFO - PROCESS | 9155 | Values: 61.0 61.0 60.0 60.0 60.0 60.0 60.0 59.0 60.0 59.0 02:00:10 INFO - PROCESS | 9155 | -------- Summary: end -------- 02:00:10 INFO - PROCESS | 9155 | 02:00:11 INFO - TEST-INFO | 9155: exit 0 02:00:11 INFO - TEST-OK | kraken | took 60134ms 02:00:11 INFO - SUITE-END | took 1175s 02:00:11 INFO - Completed test suite (00:19:35) 02:00:11 INFO - javascript benchmark 02:00:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7820.109064234415, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3401.1667141550324, 3407.4888766685, 3416.880409185679, 3423.0244380351605, 3478.791272523649, 5649.8305050848485, 5725.427457254278, 5727.455891690282, 5731.541476681866, 5740.6268592541455, 5721.0, 5764.481196692297, 5765.913511297334, 5776.075827867531, 5776.364599894008, 5119.0273847968765, 5122.8207012754565, 5124.052050370675, 5136.203888397305, 5175.948240517603, 4997.900041999158, 5000.124978128831, 5145.228215767627, 5149.150390185615, 5177.119889618773, 5070.569001634865, 5101.642884998052, 5117.641765076446, 5128.384593848743, 5161.483851614846, 5185.896282074356, 5191.454897235812, 5192.883530041022, 5196.402413722413, 5216.347956505437, 4972.726500042496, 5049.368828896388, 5116.0, 5158.484151584811, 5170.870728231786, 5592.7762889484375, 5606.103023516218, 5606.691631960241, 5606.775728970836, 5609.971950140264, 5962.731677074498, 6003.039513677791, 6005.609635373687, 6015.037593984942, 6015.939840601625, 6059.363766804466, 6073.969630151865, 6115.149072927094, 6131.724072416752, 6202.658853763041, 5754.424557544212, 5765.048766953448, 5765.077587585966, 5771.394003629643, 5800.680962547058, 6293.402126797947, 6297.685115744194, 6298.401651843067, 6306.527010474141, 6310.495160387158, 5826.213461182686, 5869.119632055226, 6003.0695242237525, 6058.0610005449225, 6077.301110372276, 6179.5056395488255, 6191.907121393183, 6194.411530904647, 6194.659293738888, 6200.3179650238435, 6162.969185154046, 6181.0, 6187.597806142587, 6191.659458729813, 6193.0, 5884.176215329857, 5905.852353691106, 5908.261467316585, 5915.911261331084, 6158.784442544489, 4603.8849028773875, 4608.331791890158, 4638.373819534387, 4684.531546845288, 4704.553067458586, 4156.147989662112, 4162.125953549788, 4162.375643653476, 4163.854265100707, 4189.685773566995, 5975.043992961192, 5975.43233392827, 5979.282486101695, 5983.521318294526, 5984.042553191469, 5938.881222375615, 5949.524038076944, 6134.78528251509, 6151.415615516519, 6154.169187159766, 5987.161797348374, 6040.577159598874, 6043.033114701627, 6046.516278697693, 6063.423974722395, 5264.473552644705, 5271.973640131775, 5273.525382715574, 5277.762500687479, 5280.0, 6116.082587611894, 6209.472194863397, 6358.427741503379, 6405.3594640535575, 6458.580192287486, 6177.351378105414, 6191.907121393273, 6202.255729312331, 6203.4416902479, 6204.162438070803, 6459.903101453576, 6461.709223084878, 6462.4183823456115, 6471.094046833353, 6473.514486413444, 5791.7683292667825, 5901.350851406428, 5940.495057920125, 6087.634741915499, 6092.208012958287, 6078.5441091919165, 6086.421789929949, 6087.2999605044215, 6096.634201947897, 6126.08108783686, 5960.374160713062, 5965.254343207099, 5967.91048134287, 5972.163897054329, 5974.970125149346, 5844.824655260349, 5879.794207202727, 5910.6638558530785, 5969.73136208863, 5975.073863551156, 5934.139549765174, 5936.5844390892225, 6042.456178943916, 6062.757489700539, 6080.69596520181, 6062.42406971337, 6099.054646529795, 6118.449339559461, 6118.847028824315, 6122.020476723703, 5720.17057526648, 5749.0, 5832.62087964281, 5886.146508756292, 5959.225300711053], "value": 5642.996974998817, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.4546326644814, 831.7504748575427, 847.8007668197974, 917.2295271971547, 924.0297687428199, 31950.84024579877, 44722.10555788886, 45080.0, 45094.32358514625, 45192.77403612978, 47335.76332118343, 47501.52498475014, 47563.0, 47593.286100708516, 47599.0, 7781.766547003571, 7791.0, 9059.50172740499, 9207.355485116044, 10594.099501542378, 10176.389416635026, 10249.487525623726, 10262.281640285182, 10264.384136951769, 10264.53809578567, 10310.278280520366, 10331.070203681706, 10339.069483746462, 10344.482775861214, 10347.948260258725, 10259.281850270485, 10270.845937310947, 10321.535530901128, 10327.225458090636, 10727.463626818668, 10468.110210632105, 10534.841977370346, 10537.473126343652, 10541.894581054168, 10543.103836173934, 42866.571334286884, 43180.0, 43214.35178472326, 43236.56763432357, 43260.56739432628, 3982.920341593181, 4011.8194681239415, 4037.1723796621623, 4045.251628448717, 4100.897477563085, 29707.0, 29819.552706709415, 29993.550096748568, 30313.69686303131, 30569.541456878163, 4265.232258193524, 4343.0, 4346.0, 4397.0, 4466.3523789050405, 227635.0, 228225.0, 228773.0, 229701.0, 229791.8510407454, 54306.45693543093, 54627.72686136544, 54662.72668636632, 54684.0, 54736.726316368164, 55521.0, 55524.44475555193, 55652.0, 55793.0, 55844.44155558474, 15163.545093647208, 15454.459093931659, 15456.459023934332, 15468.149251791034, 15471.613209669847, 11022.173336999756, 11332.0, 12674.0, 12984.545540906023, 13175.538856140181, 13849.099808512414, 13989.621764300093, 14055.789163162357, 14101.435942562388, 14176.574702758933, 5667.376588575254, 5701.800436984686, 5706.80026199081, 5775.27809023872, 5859.912101318484, 1029.5367084811865, 1032.9173666106694, 1035.404642330663, 1038.4651904269308, 1043.3166276089173, 28444.146675599764, 28454.288642784097, 28646.0, 28727.856360718062, 28998.710012899603, 1071.6249312740479, 1076.612419528969, 1097.3470784882982, 1103.051375816797, 1120.5125770289949, 13677.794833077513, 17038.74441883373, 17040.48878533646, 17235.827641723423, 18467.53831154205, 364113.0, 364748.0, 365185.0, 365581.0, 366652.0, 60285.39714602885, 60509.39490605125, 60596.39403605996, 60606.39393606008, 60681.0, 1487.4570781664831, 1521.4446726944807, 1534.8618624323865, 1565.2877940537028, 1568.1375243615967, 31512.0, 32894.34211315808, 33003.83498082494, 33149.0, 33343.0, 44242.115157697306, 44376.556234437245, 44381.0, 44427.33358999553, 44483.0, 331634.0, 333157.0, 333869.0, 333962.0, 334458.0, 27389.31526711848, 28479.43041139207, 31636.209094772814, 31754.36491270208, 33433.49849752304, 45926.31110533411, 46132.0, 46342.76828615835, 46565.0, 47208.0, 34756.82621586876, 35189.29621407609, 35326.47010294796, 35496.29007419785, 35726.10684732902, 34359.48460773141, 34528.136796580286, 34597.65402346045, 34816.0, 34878.82560587181, 39537.60462395339, 39856.402153968294, 40203.0, 40847.0, 40982.59017409907, 33160.50259246065, 33304.1673958153, 33449.331013380084, 33554.99335019953, 33594.832025839714, 26526.336841579116, 26813.86593067022, 26822.0, 26831.731682683705, 26976.73023269742], "value": 19423.53950743242, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.8924174335544, 439.7493428745614, 442.17534298533246, 451.8825105472577, 483.4054113440468, 19719.704204436945, 19734.0, 21282.57434851302, 21472.785272147274, 21573.67639485409, 21993.34019979403, 21994.230201942933, 22259.22092726755, 22424.215152469667, 22915.0, 6622.337766223387, 6781.966090169542, 6919.44644428447, 6943.72225110995, 6955.582665040089, 6722.193336799566, 6796.150481189851, 6823.215330237037, 6823.351781580742, 6833.863322733542, 6581.638009909453, 6804.115464989544, 6836.623985680785, 6855.862882742342, 6857.588544687334, 6584.5061620378665, 6782.796516104525, 6805.217399999014, 6812.080369150176, 6834.931650683479, 6609.975453804668, 6673.4661227101715, 6679.933200668028, 6684.465242780566, 6689.197296324423, 25611.0, 25642.48715025708, 25677.87161064183, 25932.22203333884, 25944.74055259442, 3542.6457354264626, 3562.536870206882, 3571.8749843755345, 3606.008347704376, 3663.523741913561, 16094.0, 16628.0, 16765.580860478465, 16809.495715128567, 17209.0, 2209.6464565669576, 2258.8531745436494, 2282.63311615366, 2315.617923042696, 2332.4635333873302, 91483.0, 94931.0, 98265.0, 98444.0, 99047.50476247644, 18620.627587448176, 19127.904360478387, 19281.710774338397, 19294.517637059187, 19377.90311048464, 34916.82541587276, 34949.47575786365, 34988.65011349905, 35000.474992875126, 35109.8934063957, 9862.605495780088, 9935.602575897028, 9936.900630993741, 10001.34991225568, 10164.847527287096, 7989.56057416836, 8136.633851476698, 8149.755507334789, 8218.671253149927, 8300.2114799094, 9944.900550994398, 10063.226290141198, 10095.495225238708, 10145.64490242838, 10398.220133490018, 3518.876839310663, 3606.2213288487483, 3864.4976153099915, 3883.184531248413, 3942.6630706222927, 987.7135630667026, 1001.1007127239362, 1001.9649312274181, 1016.7661437869332, 1029.6036026129843, 21911.67132492982, 22253.332400028026, 22286.888565557394, 22300.55398892013, 22303.553928921654, 1015.94920253987, 1019.887812340642, 1021.4484178543652, 1028.2236911132197, 1044.8014877173464, 11544.59593914209, 12558.0, 12592.244465331925, 12595.433205505775, 12733.872661273268, 668701.0, 694172.0, 694923.0, 715846.0, 716934.0, 90953.0, 94096.52951735334, 94633.5268323654, 96022.0, 108868.0, 1325.4234408032537, 1353.472145863114, 1355.302019459979, 1392.9442822286994, 1399.7970294307268, 17637.64724705473, 18111.0, 19174.328898488486, 19176.328828491492, 19326.806731932502, 41351.0, 51055.2341714882, 52055.0, 52626.0, 53577.732111339195, 71206.0, 71328.64335678496, 71775.28224717686, 72738.63630681812, 74421.25578744143, 12087.697807554881, 12193.695157620776, 12193.878061219275, 12304.630861074182, 12395.566155184526, 12708.618741437771, 12836.101472896808, 13299.800502992657, 13518.797218041935, 14753.778693319824, 11485.253458525169, 11774.764504710029, 12239.164329585758, 12588.30764307972, 12882.742345152858, 10486.842697359698, 10529.842052369373, 10601.946990265, 10919.0, 11118.332900026024, 10964.451777410937, 11541.942290288494, 11574.710632233924, 12163.939180304042, 12516.123871329284, 11378.772424551627, 11633.243839150427, 11739.295642261492, 11750.94124529372, 11753.412329383325, 12012.579559715718, 12053.397330133634, 12146.939265303618, 12184.086193535697, 12695.619131426072], "value": 11458.102869449389, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.994338934441, 1563.9374425023, 1578.3765412661999, 1590.7216237158498, 1603.4628399486169, 9292.488913109784, 11330.150238732098, 11700.473478693459, 12087.335196564185, 12090.0, 11755.41222938854, 11818.7636247275, 11888.167828252026, 11928.0, 11928.880711192885, 2041.061111888533, 2111.144986280551, 2296.9885150574223, 2332.230363979891, 2337.1118974789642, 2287.462446325112, 2350.4123969007746, 2350.518143780521, 2356.1400088967575, 2370.3600027992434, 2355.2463211772238, 2408.313630615275, 2416.154345978911, 2417.806575473967, 2420.854748715074, 2356.646503024543, 2398.304491697406, 2398.688170537828, 2403.170906037414, 2403.6875206223253, 2311.179531266393, 2317.0, 2319.5476882008015, 2320.872352020638, 2324.7675232476786, 11915.106367022508, 12015.158938874283, 12016.399180040962, 12022.0, 12024.579139730067, 5637.887242255132, 5731.254936858223, 5888.823335299948, 5890.528757699374, 5891.882162356772, 3156.9052928412184, 3242.4974129010043, 3392.8473218705217, 3406.557147570825, 3408.727301815849, 1267.9492820287178, 1304.4390911907876, 1309.9127723989066, 1316.3681432912256, 2316.455632926261, 17957.191926363346, 18202.63594728098, 18210.180541875514, 18211.360977511955, 18217.362392316205, 4507.18870603288, 4585.220512512881, 4602.332661764092, 4602.631789456836, 4625.629949604024, 13323.13399629021, 13330.933345333406, 13342.466301347837, 13355.933220334031, 13376.866231337563, 5761.625494342854, 5767.279090113736, 5772.422757724278, 5776.566757493205, 5779.7110144493445, 4332.393464914914, 4433.512313645497, 5122.0, 5205.583553315726, 5226.320578324793, 3972.662323702518, 4045.0696339842, 4080.2451546464, 4116.135611521554, 4145.067359844011, 995.2386424385351, 1011.4133802394593, 1014.2190513304714, 1020.4897551224387, 1023.2019025160387, 990.821652102614, 1005.1305620638095, 1007.254631572631, 1010.0354161775487, 1010.2776514791959, 6288.371162883675, 6417.486601071903, 6439.5170362223025, 6476.643784591893, 6559.8032059038305, 1004.7588578741196, 1027.075631931253, 1039.1478987230398, 1045.7856139491387, 1100.0979197058496, 3968.6825053995613, 4095.5970839507845, 4190.350495673176, 4194.979614677427, 4220.725652832556, 14315.0, 14944.40222391114, 14964.850351496345, 14964.850351496345, 15025.549233523012, 14537.273136343141, 14792.408303667733, 14993.850061499244, 14996.775048374284, 15033.398664053535, 10335.94832025835, 10522.31604945676, 10595.09941654968, 10842.94578527118, 10973.50619222137, 6612.867742645217, 6694.230163531256, 6701.932980670131, 6748.527603067738, 6750.223724271772, 12628.368581570701, 12773.0, 12804.167729097579, 12817.935910320388, 12945.676358091123, 12624.55814046504, 12636.494540218288, 12694.238345698917, 12741.426635801596, 12842.165259258118, 8632.179942905414, 8741.694040708544, 9459.952700236454, 9701.272404569545, 9819.116279534876, 11289.0, 11420.543178272776, 11525.423728813357, 11528.481218345027, 11539.307641541534, 9434.716958491255, 9475.526223688927, 9498.382605130644, 9563.521823908637, 9702.029797020241, 8867.73396798097, 8887.244584210155, 9009.144131307516, 9070.954645226731, 9315.0, 8537.53043582609, 8538.316934645089, 8538.487690738575, 8550.957245213984, 8561.357898157788, 5756.856078598069, 5787.94212057874, 5805.680687562056, 5840.707964601668, 5960.821175364746, 5963.642181469126, 5986.9401305986385, 5997.3402925677265, 6056.818295451144, 6091.116788065794], "value": 5310.836346106243, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.9811297526479, 397.5368695469778, 409.7848629469528, 421.515257453928, 423.4537446693764, 5173.637845350827, 5198.922016169756, 5238.449962753908, 5249.790008399669, 5267.762950667219, 4974.204127339626, 5066.468020857812, 5078.263651770491, 5116.488351164881, 5129.871753206172, 4319.935200971988, 4334.436523251989, 4337.566243375653, 4343.087951530182, 4343.348497725351, 4345.152695224432, 4364.367166760818, 4364.541723119059, 4367.235733746597, 4375.890602734925, 4190.685698572604, 4285.635720963722, 4290.957090429087, 4291.969927217461, 4305.741655500664, 4259.723117997351, 4315.892102697442, 4318.740875547477, 4331.6534677225745, 4342.696011279212, 4076.4496792932873, 4083.7141400102005, 4102.671786257092, 4116.938245926313, 4142.275101857163, 4851.757412129415, 5098.796048158069, 5110.897782044375, 5138.126518491828, 5168.586513078944, 5079.2127220280545, 5080.30072183229, 5087.440381558025, 5105.8723531912, 5126.846194614131, 5468.9726551367385, 5477.000894673455, 5477.589180811455, 5481.369642491085, 5511.641743286674, 4391.49497807753, 4491.663125265618, 4501.909961800746, 4602.079584083197, 4606.700564463299, 5380.461953804588, 5457.372402173761, 5467.289252397163, 5604.495595396434, 5617.522510586605, 4570.497245303014, 4612.515685852937, 4623.630109591225, 4634.957134644746, 4635.698679585884, 4554.884053406937, 4721.716696998191, 4737.786799594027, 4743.691660042086, 4746.145693775154, 4924.852254432372, 4932.802687892516, 4991.775370108354, 5005.849824505271, 5016.197408414636, 5392.272043274108, 5426.290718423684, 5430.239766432703, 5433.83698489038, 5435.728213589305, 1568.3726509396333, 1614.564067701714, 1625.634701509301, 1633.3466613354753, 1641.1712085396798, 1221.4015132584968, 1261.4575732435142, 1276.2087505746497, 1276.961691149267, 1286.7297867447753, 5368.624196306221, 5371.731413429313, 5413.566914646819, 5426.8371948841595, 5432.2123292123215, 5558.388577256498, 5571.860703482445, 5591.692456914909, 5612.494875461228, 5619.550435965113, 5129.281900533928, 5406.972965135228, 5431.83704488866, 5433.646812957224, 5441.319835020622, 2898.971010289912, 2906.3751293472005, 2911.2721819545113, 2924.9707502925125, 2939.882404703788, 5682.971585142048, 5781.364049954502, 5830.82507524775, 5865.970670146622, 5885.146653735184, 5571.693556854331, 5667.291588551431, 5677.971610141923, 5699.316082070178, 5723.284589426322, 5810.854728631818, 5818.44724751148, 5838.737256823369, 5862.530997520188, 5866.823995280149, 5283.418823929288, 5461.726913654381, 5462.180672899097, 5493.258410114583, 5660.0, 5302.647824804651, 5379.704116273642, 5404.945950540444, 5574.637648552831, 5574.832755017356, 5744.4829965303325, 5763.308402991668, 5794.449527294901, 5826.329972053268, 5854.941450585439, 4579.885502862322, 4662.347271382077, 4662.580367766917, 4698.8355407560575, 4702.247640377524, 5498.725063746877, 5622.803201887914, 5629.831105066854, 5631.6902570359025, 5644.153376993484, 5417.377001644862, 5427.0, 5459.535939445032, 5492.368377636623, 5492.588055895744, 5228.869278268074, 5424.511793938565, 5430.565554755531, 5455.972720136374, 5514.338279406497, 5325.573954083741, 5359.624826262124, 5408.810691625774, 5422.755975981011, 5464.371597266365, 5436.429174936575, 5466.644668096561, 5540.833774986757, 5552.86214807294, 5561.332640083054, 4962.6774259673, 5250.346140965584, 5330.9466905332, 5393.271908292487, 5424.593155513431], "value": 4380.825582474442, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.6207363575936, 826.2852632472913, 897.6992707443011, 897.7127319257836, 898.2125570115472, 15934.601634959117, 17611.119444027794, 17852.64294714105, 17865.553361165978, 17882.105894705262, 16629.0, 16958.745618815698, 16988.065656388895, 17003.57491062724, 17019.82980170198, 863.740877736678, 879.4371602174614, 882.5190271302124, 889.1686273334453, 889.6130183370254, 881.383031877685, 883.9690610828623, 886.4149661223594, 886.6054605700466, 887.0464250930244, 937.0488953711988, 938.1650331205233, 938.3572253006678, 938.3853575907791, 938.6245501799267, 929.2287401456808, 930.2000279759402, 930.241852889896, 931.0177762460602, 932.5570354081825, 686.4817063117315, 687.779910428663, 687.9208890977552, 688.2601203705987, 688.5042769206163, 17952.91023544874, 17996.910015449837, 18048.729269060976, 18573.0, 18805.717914231296, 15845.92077039619, 16029.15664698563, 16224.432144874872, 16284.674306513803, 16339.918300408423, 13630.659233519142, 13766.380512876945, 13862.237576933265, 14468.131912085308, 14809.481668141563, 4082.4692789937417, 4092.1815636872448, 4114.053767633432, 4153.169366126786, 4240.130773191519, 90179.09820901773, 90488.54755726179, 90708.54645726795, 92123.07876921212, 94391.52804235935, 11434.599789007345, 11530.711732206762, 11600.303981760953, 11656.41717914101, 11708.473118709679, 23417.531649366916, 23565.29304120879, 23582.882085589463, 23609.1736789215, 23705.7629423707, 8222.917770822334, 8317.334613230927, 8325.583720813935, 8431.0, 8432.347656909102, 4880.389951256093, 4963.950360496421, 4997.425296090923, 5006.3992320921725, 5089.185730283137, 3704.9259014819554, 3808.1431677872256, 3809.8666546670734, 3811.009137624182, 3813.0848596336677, 591.9197464626986, 593.5666963116948, 610.206731249374, 617.102116420607, 625.0967352176062, 801.8276070644723, 818.5334359415076, 836.5022811427191, 838.6058552480324, 853.2363534636589, 11419.31484110956, 11468.4839182237, 11482.311061336346, 11553.826692599618, 11793.11551633631, 794.586814856283, 795.3478147918767, 804.8511025460191, 806.6531391501711, 808.8686311569057, 5427.864303392446, 5436.91844622331, 5452.672839629635, 5496.285482887199, 5517.2551705520045, 83791.5810420944, 87603.0, 88402.0, 90353.54823225974, 90901.0, 75503.24496755072, 76886.23113768903, 78303.0, 78521.60739196268, 79312.0, 67660.6616966912, 68393.65803170952, 68610.65694671594, 68883.65558172077, 69071.0, 10514.474276286308, 10607.591785936527, 10822.621208257673, 10831.0, 10874.0, 48419.27371089366, 48831.511684882695, 48866.75566622144, 49242.75378623084, 50603.13029608185, 53343.0, 53756.19365709596, 53844.0, 54973.45026549683, 56040.0, 12177.330246836154, 12408.75182496363, 12461.439235234617, 12464.626061218178, 12793.8080928788, 14567.41730330775, 14595.270236488346, 14807.777883331973, 14828.481003164838, 14976.326065327305, 12860.164089334163, 13171.47314107425, 13560.86439135596, 13710.451581936612, 14170.058683980522, 13390.129641573267, 13413.731725365244, 13488.460461581426, 13527.053106282467, 13548.458061677422, 13268.867311326763, 13270.071095023643, 13357.866421335662, 13723.588292351245, 13859.099158554662, 9967.850482242917, 10031.147352475122, 10091.041351071637, 10259.487025648838, 10263.384196947909, 11300.773984520429, 11301.963408969421, 11399.886001139883, 11567.479463423997, 11586.652400428], "value": 7826.483439030635, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 112.0, 114.0, 113.0, 113.0, 112.0, 114.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 115.0, 117.0, 157.0, 118.0, 116.0, 116.0, 115.0, 131.0, 117.0], "value": 124.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 161.0, 160.0, 161.0, 161.0, 160.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 109.0, 76.0, 77.0, 77.0, 78.0, 96.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 108.0, 82.0, 83.0, 82.0, 94.0, 82.0, 82.0, 98.0], "value": 87.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 148.0, 149.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 54.0, 55.0, 54.0, 53.0, 53.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 66.0, 56.0, 53.0, 54.0, 52.0, 53.0, 53.0, 56.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 75.0, 77.0, 79.0, 79.0, 76.0, 76.0, 79.0, 80.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 134.0, 136.0, 122.0, 121.0, 122.0, 127.0, 120.0, 163.0, 145.0], "value": 132.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 162.0, 156.0, 157.0, 163.0, 158.0, 160.0, 158.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0], "value": 60.0, "unit": "score"}]}]} 02:00:11 INFO - Return code: 0 02:00:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:00:11 ERROR - # TBPL SUCCESS # 02:00:11 INFO - Running post-action listener: _resource_record_post_action 02:00:11 INFO - [mozharness: 2017-05-01 09:00:11.662084Z] Finished run-tests step (success) 02:00:11 INFO - Running post-run listener: _resource_record_post_run 02:00:11 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 366096384; Read time: 36; Write time: 338468 02:00:11 INFO - TinderboxPrint: CPU usage
13.1% 02:00:11 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 36 02:00:11 INFO - TinderboxPrint: I/O write bytes / time
366,096,384 / 338,468 02:00:11 INFO - TinderboxPrint: CPU idle
8,261.7 (86.8%) 02:00:11 INFO - TinderboxPrint: CPU user
1,203.9 (12.7%) 02:00:11 INFO - TinderboxPrint: Swap in / out
0 / 0 02:00:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111144960; Read time: 0; Write time: 136668 02:00:11 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 254951424; Read time: 36; Write time: 201800 02:00:12 INFO - Running post-run listener: _upload_blobber_files 02:00:12 INFO - Blob upload gear active. 02:00:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:00:12 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 02:00:12 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:00:12 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:00:12 INFO - (blobuploader) - INFO - Open directory for files ... 02:00:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:00:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:00:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:00:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:00:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:00:13 INFO - (blobuploader) - INFO - Done attempting. 02:00:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:00:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:00:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:00:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:00:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:00:16 INFO - (blobuploader) - INFO - Done attempting. 02:00:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:00:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:00:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:00:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:00:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:00:17 INFO - (blobuploader) - INFO - Done attempting. 02:00:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:00:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:00:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:00:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:00:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:00:18 INFO - (blobuploader) - INFO - Done attempting. 02:00:18 INFO - (blobuploader) - INFO - Iteration through files over. 02:00:18 INFO - Return code: 0 02:00:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:00:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:00:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6b8c3727be7cd3245e65f1f36eb8d2c7093beebb50305069c1a1e1c41d2d10485069e1fe426aedb15faff34e4967efcb73a8252dc43b5ad417a7e4d178edba34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9ea98c814b8f23a026ed403e4889595668047b705e6600ac6e36f4e3f9a6755af24a554d3251460c4e4cbbb7535255bd56b7fde7d37e5757a8063a40c6dc6331", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0658f92d98aec9b2b38cf68850751490874f8c41f661e99f01226a755a81644f7a697342260c3ec187ddcb0280f3efd85b68a0076dfeb8f597a63479123af9e9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/229495488caab3d52dd9dd18043c790e101e04f9dce8cf60567812a5aa9d943f0eae10e45cd80a712800b9712ed3edace6e5cc1285fdfcbce4aab5e9872ea67b"} 02:00:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:00:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:00:18 INFO - Contents: 02:00:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6b8c3727be7cd3245e65f1f36eb8d2c7093beebb50305069c1a1e1c41d2d10485069e1fe426aedb15faff34e4967efcb73a8252dc43b5ad417a7e4d178edba34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9ea98c814b8f23a026ed403e4889595668047b705e6600ac6e36f4e3f9a6755af24a554d3251460c4e4cbbb7535255bd56b7fde7d37e5757a8063a40c6dc6331", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0658f92d98aec9b2b38cf68850751490874f8c41f661e99f01226a755a81644f7a697342260c3ec187ddcb0280f3efd85b68a0076dfeb8f597a63479123af9e9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/229495488caab3d52dd9dd18043c790e101e04f9dce8cf60567812a5aa9d943f0eae10e45cd80a712800b9712ed3edace6e5cc1285fdfcbce4aab5e9872ea67b"} 02:00:18 INFO - Running post-run listener: copy_logs_to_upload_dir 02:00:18 INFO - Copying logs to upload dir... 02:00:18 INFO - mkdir: /builds/slave/test/build/upload/logs 02:00:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.566092 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-01 02:00:16.741789) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 02:00:16.745173) ========= 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=9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6b8c3727be7cd3245e65f1f36eb8d2c7093beebb50305069c1a1e1c41d2d10485069e1fe426aedb15faff34e4967efcb73a8252dc43b5ad417a7e4d178edba34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9ea98c814b8f23a026ed403e4889595668047b705e6600ac6e36f4e3f9a6755af24a554d3251460c4e4cbbb7535255bd56b7fde7d37e5757a8063a40c6dc6331", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0658f92d98aec9b2b38cf68850751490874f8c41f661e99f01226a755a81644f7a697342260c3ec187ddcb0280f3efd85b68a0076dfeb8f597a63479123af9e9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/229495488caab3d52dd9dd18043c790e101e04f9dce8cf60567812a5aa9d943f0eae10e45cd80a712800b9712ed3edace6e5cc1285fdfcbce4aab5e9872ea67b"} build_url:https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/T-ZYPxv3RreHzcJyKDnwhw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6b8c3727be7cd3245e65f1f36eb8d2c7093beebb50305069c1a1e1c41d2d10485069e1fe426aedb15faff34e4967efcb73a8252dc43b5ad417a7e4d178edba34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9ea98c814b8f23a026ed403e4889595668047b705e6600ac6e36f4e3f9a6755af24a554d3251460c4e4cbbb7535255bd56b7fde7d37e5757a8063a40c6dc6331", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0658f92d98aec9b2b38cf68850751490874f8c41f661e99f01226a755a81644f7a697342260c3ec187ddcb0280f3efd85b68a0076dfeb8f597a63479123af9e9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/229495488caab3d52dd9dd18043c790e101e04f9dce8cf60567812a5aa9d943f0eae10e45cd80a712800b9712ed3edace6e5cc1285fdfcbce4aab5e9872ea67b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 02:00:16.771250) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 02:00:16.771588) ========= 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=9f7544b6a75ada7b6b576032000001a7-1493615856.208101-983672723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 02:00:16.853637) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 02:00:16.853994) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 02:00:16.854307) ========= ========= Total master_lag: 0.18 =========