builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1493973967.9 results: success (0) revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 01:46:07.902973) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 01:46:07.903445) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 01:46:07.903734) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 01:46:07.931371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 01:46:07.931727) ========= 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=232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-05 01:46:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2017-05-05 01:46:08 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145167 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 01:46:08.097894) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 01:46:08.098274) ========= 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=232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019651 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 01:46:08.152118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 01:46:08.152435) ========= 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=232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-05 01:46:09,064 truncating revision to first 12 chars 2017-05-05 01:46:09,064 Setting DEBUG logging. 2017-05-05 01:46:09,064 attempt 1/10 2017-05-05 01:46:09,064 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-05 01:46:09,377 unpacking tar archive at: mozilla-aurora-94b7e538af7d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622874 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 01:46:08.790709) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 01:46:08.791003) ========= script_repo_revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 01:46:08.794370) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 01:46:08.794637) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 01:46:08.804726) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-05 01:46:08.805004) ========= /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=232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:46:09 INFO - MultiFileLogger online at 20170505 01:46:09 in /builds/slave/test 01:46:09 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:46:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:46:09 INFO - {'append_to_log': False, 01:46:09 INFO - 'base_work_dir': '/builds/slave/test', 01:46:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 01:46:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:46:09 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 01:46:09 INFO - 'buildbot_json_path': 'buildprops.json', 01:46:09 INFO - 'config_files': ('talos/linux_config.py',), 01:46:09 INFO - 'default_actions': ('clobber', 01:46:09 INFO - 'read-buildbot-config', 01:46:09 INFO - 'download-and-extract', 01:46:09 INFO - 'populate-webroot', 01:46:09 INFO - 'create-virtualenv', 01:46:09 INFO - 'install', 01:46:09 INFO - 'run-tests'), 01:46:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:46:09 INFO - 'download_minidump_stackwalk': True, 01:46:09 INFO - 'download_symbols': 'ondemand', 01:46:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:46:09 INFO - 'tooltool.py': '/tools/tooltool.py', 01:46:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:46:09 INFO - '/tools/misc-python/virtualenv.py')}, 01:46:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:46:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:46:09 INFO - 'gecko_profile': False, 01:46:09 INFO - 'gecko_profile_interval': 0, 01:46:09 INFO - 'installer_path': 'installer.exe', 01:46:09 INFO - 'log_level': 'info', 01:46:09 INFO - 'log_name': 'talos', 01:46:09 INFO - 'log_to_console': True, 01:46:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:46:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:46:09 INFO - 'opt_config_files': (), 01:46:09 INFO - 'pip_index': False, 01:46:09 INFO - 'suite': 'dromaeojs', 01:46:09 INFO - 'system_bits': '32', 01:46:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:46:09 INFO - 'title': 'talos-linux64-ix-025', 01:46:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:46:09 INFO - 'use_talos_json': True, 01:46:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:46:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:46:09 INFO - 'work_dir': 'build'} 01:46:09 INFO - [mozharness: 2017-05-05 08:46:09.814136Z] Running clobber step. 01:46:09 INFO - Running pre-action listener: _resource_record_pre_action 01:46:09 INFO - Running main action method: clobber 01:46:09 INFO - rmtree: /builds/slave/test/build 01:46:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:46:11 INFO - Running post-action listener: _resource_record_post_action 01:46:11 INFO - [mozharness: 2017-05-05 08:46:11.254423Z] Finished clobber step (success) 01:46:11 INFO - [mozharness: 2017-05-05 08:46:11.254522Z] Running read-buildbot-config step. 01:46:11 INFO - Running pre-action listener: _resource_record_pre_action 01:46:11 INFO - Running main action method: read_buildbot_config 01:46:11 INFO - Using buildbot properties: 01:46:11 INFO - { 01:46:11 INFO - "project": "", 01:46:11 INFO - "product": "firefox", 01:46:11 INFO - "who": "nobody@mozilla.org", 01:46:11 INFO - "installer_path": "public/build/target.tar.bz2", 01:46:11 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:46:11 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora", 01:46:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 01:46:11 INFO - "stage_platform": "linux64", 01:46:11 INFO - "basedir": "/builds/slave/test", 01:46:11 INFO - "buildnumber": 146, 01:46:11 INFO - "platform": "ubuntu64_hw", 01:46:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:46:11 INFO - "slavebuilddir": "test", 01:46:11 INFO - "taskId": "TV-RzfklTM6ULck_pfblzg", 01:46:11 INFO - "branch": "mozilla-aurora", 01:46:11 INFO - "script_repo_revision": "production", 01:46:11 INFO - "revision": "94b7e538af7dbb9a6567cad9125c2f5411e7fb80", 01:46:11 INFO - "slavename": "talos-linux64-ix-025", 01:46:11 INFO - "repo_path": "releases/mozilla-aurora" 01:46:11 INFO - } 01:46:11 INFO - Finding installer, test and symbols from parent task. 01:46:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TV-RzfklTM6ULck_pfblzg'}, attempt #1 01:46:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TV-RzfklTM6ULck_pfblzg'}, attempt #1 01:46:12 INFO - Task dependencies: Lgk3gZt8T02vdt9-KMA-Jw 01:46:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw'}, attempt #1 01:46:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.tar.bz2 01:46:12 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/test_packages.json 01:46:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.crashreporter-symbols.zip 01:46:12 INFO - Running post-action listener: _resource_record_post_action 01:46:12 INFO - [mozharness: 2017-05-05 08:46:12.606720Z] Finished read-buildbot-config step (success) 01:46:12 INFO - [mozharness: 2017-05-05 08:46:12.606938Z] Running download-and-extract step. 01:46:12 INFO - Running pre-action listener: _resource_record_pre_action 01:46:12 INFO - Running main action method: download_and_extract 01:46:12 INFO - mkdir: /builds/slave/test/build/tests 01:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:46:12 INFO - trying https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.test_packages.json 01:46:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:46:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:46:13 INFO - Downloaded 896 bytes. 01:46:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:46:13 INFO - Using the following test package requirements: 01:46:13 INFO - {u'common': [u'target.common.tests.zip'], 01:46:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:46:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:46:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:46:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:46:13 INFO - u'mozbase': [u'target.common.tests.zip'], 01:46:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:46:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:46:13 INFO - u'web-platform': [u'target.common.tests.zip', 01:46:13 INFO - u'target.web-platform.tests.zip'], 01:46:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:46:13 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:46:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.common.tests.zip 01:46:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:46:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.common.tests.zip into memory 01:46:15 INFO - Expected file size: 59542816 01:46:15 INFO - Obtained file size: 59542816 01:46:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:46:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.common.tests.zip 01:46:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:46:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.common.tests.zip into memory 01:46:26 INFO - Expected file size: 59542816 01:46:26 INFO - Obtained file size: 59542816 01:46:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.talos.tests.zip 01:46:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:46:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.talos.tests.zip into memory 01:46:38 INFO - Expected file size: 14404424 01:46:38 INFO - Obtained file size: 14404424 01:46:38 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:46:38 INFO - trying https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.tar.bz2 01:46:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:46:41 INFO - Downloaded 66772362 bytes. 01:46:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.tar.bz2 01:46:41 INFO - mkdir: /builds/slave/test/properties 01:46:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:46:41 INFO - Writing to file /builds/slave/test/properties/build_url 01:46:41 INFO - Contents: 01:46:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.tar.bz2 01:46:41 INFO - Running post-action listener: _resource_record_post_action 01:46:41 INFO - Running post-action listener: set_extra_try_arguments 01:46:41 INFO - [mozharness: 2017-05-05 08:46:41.029722Z] Finished download-and-extract step (success) 01:46:41 INFO - [mozharness: 2017-05-05 08:46:41.029830Z] Running populate-webroot step. 01:46:41 INFO - Running pre-action listener: _resource_record_pre_action 01:46:41 INFO - Running main action method: populate_webroot 01:46:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:46:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:46:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:46:41 INFO - '--tppagecycles', 01:46:41 INFO - '7'], 01:46:41 INFO - 'tests': ['tsvgm']}}, 01:46:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:46:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:46:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:46:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:46:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:46:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:46:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:46:41 INFO - 'talos_options': ['--disable-e10s'], 01:46:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:46:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:46:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:46:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:46:41 INFO - 'talos_options': ['--disable-e10s'], 01:46:41 INFO - 'tests': ['damp', 'tps']}, 01:46:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:46:41 INFO - 'tests': ['damp', 'tps']}, 01:46:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:46:41 INFO - 'tests': ['dromaeo_dom']}, 01:46:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:46:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:46:41 INFO - 'tests': ['basic_compositor_video']}, 01:46:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:46:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:46:41 INFO - 'tests': ['a11yr', 01:46:41 INFO - 'ts_paint', 01:46:41 INFO - 'tpaint', 01:46:41 INFO - 'sessionrestore', 01:46:41 INFO - 'sessionrestore_no_auto_restore', 01:46:41 INFO - 'tabpaint']}, 01:46:41 INFO - 'other-e10s': {'tests': ['a11yr', 01:46:41 INFO - 'ts_paint', 01:46:41 INFO - 'tpaint', 01:46:41 INFO - 'sessionrestore', 01:46:41 INFO - 'sessionrestore_no_auto_restore', 01:46:41 INFO - 'tabpaint']}, 01:46:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:46:41 INFO - 'ts_paint', 01:46:41 INFO - 'tpaint', 01:46:41 INFO - 'sessionrestore', 01:46:41 INFO - 'sessionrestore_no_auto_restore', 01:46:41 INFO - 'tabpaint']}, 01:46:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:46:41 INFO - 'ts_paint', 01:46:41 INFO - 'tpaint', 01:46:41 INFO - 'sessionrestore', 01:46:41 INFO - 'sessionrestore_no_auto_restore', 01:46:41 INFO - 'tabpaint']}, 01:46:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:46:41 INFO - 'tests': ['a11yr', 01:46:41 INFO - 'ts_paint', 01:46:41 INFO - 'tpaint', 01:46:41 INFO - 'sessionrestore', 01:46:41 INFO - 'sessionrestore_no_auto_restore', 01:46:41 INFO - 'tabpaint']}, 01:46:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:46:41 INFO - 'tests': ['a11yr', 01:46:41 INFO - 'ts_paint', 01:46:41 INFO - 'tpaint', 01:46:41 INFO - 'sessionrestore', 01:46:41 INFO - 'sessionrestore_no_auto_restore', 01:46:41 INFO - 'tabpaint']}, 01:46:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:46:41 INFO - 'tests': ['tsvgx', 01:46:41 INFO - 'tsvgr_opacity', 01:46:41 INFO - 'tart', 01:46:41 INFO - 'tscrollx', 01:46:41 INFO - 'cart', 01:46:41 INFO - 'tsvg_static']}, 01:46:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:46:41 INFO - 'tsvgr_opacity', 01:46:41 INFO - 'tart', 01:46:41 INFO - 'tscrollx', 01:46:41 INFO - 'cart', 01:46:41 INFO - 'tsvg_static']}, 01:46:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:46:41 INFO - 'talos_options': ['--disable-e10s'], 01:46:41 INFO - 'tests': ['tp5o']}, 01:46:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:46:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:46:41 INFO - 'talos_options': ['--disable-e10s', 01:46:41 INFO - '--xperf_path', 01:46:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:46:41 INFO - 'tests': ['tp5n']}, 01:46:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:46:41 INFO - 'talos_options': ['--xperf_path', 01:46:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:46:41 INFO - 'tests': ['tp5n']}}, 01:46:41 INFO - 'talos.zip': {'path': '', 01:46:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:46:41 INFO - Running post-action listener: _resource_record_post_action 01:46:41 INFO - [mozharness: 2017-05-05 08:46:41.042892Z] Finished populate-webroot step (success) 01:46:41 INFO - [mozharness: 2017-05-05 08:46:41.042983Z] Running create-virtualenv step. 01:46:41 INFO - Running pre-action listener: _resource_record_pre_action 01:46:41 INFO - Running main action method: create_virtualenv 01:46:41 INFO - Creating virtualenv /builds/slave/test/build/venv 01:46:41 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:46:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:46:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:46:41 INFO - Using real prefix '/usr' 01:46:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:46:41 INFO - Installing distribute.............................................................................................................................................................................................done. 01:46:43 INFO - Installing pip.................done. 01:46:43 INFO - Return code: 0 01:46:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:46:43 INFO - Reading from file tmpfile_stdout 01:46:43 INFO - Output received: 01:46:43 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:46:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:46:43 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:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:43 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:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, '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 0x12ef3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ef840>, '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': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', '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:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:46:43 INFO - Using env: {'DISPLAY': ':0', 01:46:43 INFO - 'HOME': '/home/cltbld', 01:46:43 INFO - 'LANG': 'en_US.UTF-8', 01:46:43 INFO - 'LANGUAGE': 'en_US:en', 01:46:43 INFO - 'LOGNAME': 'cltbld', 01:46:43 INFO - 'MAIL': '/var/mail/cltbld', 01:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:43 INFO - 'MOZ_NO_REMOTE': '1', 01:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:43 INFO - 'NO_EM_RESTART': '1', 01:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:43 INFO - 'PWD': '/builds/slave/test', 01:46:43 INFO - 'SHELL': '/bin/bash', 01:46:43 INFO - 'SHLVL': '1', 01:46:43 INFO - 'TERM': 'linux', 01:46:43 INFO - 'TMOUT': '86400', 01:46:43 INFO - 'USER': 'cltbld', 01:46:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', 01:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:43 INFO - '_': '/tools/buildbot/bin/python'} 01:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:44 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:46:44 INFO - Cleaning up... 01:46:44 INFO - Return code: 0 01:46:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:44 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 0x10531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, '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 0x12ef3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ef840>, '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': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', '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:46:44 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:46:44 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:46:44 INFO - Using env: {'DISPLAY': ':0', 01:46:44 INFO - 'HOME': '/home/cltbld', 01:46:44 INFO - 'LANG': 'en_US.UTF-8', 01:46:44 INFO - 'LANGUAGE': 'en_US:en', 01:46:44 INFO - 'LOGNAME': 'cltbld', 01:46:44 INFO - 'MAIL': '/var/mail/cltbld', 01:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:44 INFO - 'MOZ_NO_REMOTE': '1', 01:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:44 INFO - 'NO_EM_RESTART': '1', 01:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:44 INFO - 'PWD': '/builds/slave/test', 01:46:44 INFO - 'SHELL': '/bin/bash', 01:46:44 INFO - 'SHLVL': '1', 01:46:44 INFO - 'TERM': 'linux', 01:46:44 INFO - 'TMOUT': '86400', 01:46:44 INFO - 'USER': 'cltbld', 01:46:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', 01:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:44 INFO - '_': '/tools/buildbot/bin/python'} 01:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:44 INFO - Downloading/unpacking psutil>=3.1.1 01:46:44 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:46:44 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:46:44 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:46:44 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:46:44 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:46:44 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:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:46:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:46:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:46:45 INFO - Installing collected packages: psutil 01:46:45 INFO - Running setup.py install for psutil 01:46:45 INFO - building 'psutil._psutil_linux' extension 01:46:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:46:45 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:46:45 INFO - building 'psutil._psutil_posix' extension 01:46:45 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:46:45 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:46:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:46:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:46:45 INFO - Successfully installed psutil 01:46:45 INFO - Cleaning up... 01:46:45 INFO - Return code: 0 01:46:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:46:45 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:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:45 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:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:45 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 0x10531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, '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 0x12ef3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ef840>, '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': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', '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:46:45 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:46:45 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:46:45 INFO - Using env: {'DISPLAY': ':0', 01:46:45 INFO - 'HOME': '/home/cltbld', 01:46:45 INFO - 'LANG': 'en_US.UTF-8', 01:46:45 INFO - 'LANGUAGE': 'en_US:en', 01:46:45 INFO - 'LOGNAME': 'cltbld', 01:46:45 INFO - 'MAIL': '/var/mail/cltbld', 01:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:45 INFO - 'MOZ_NO_REMOTE': '1', 01:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:45 INFO - 'NO_EM_RESTART': '1', 01:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:45 INFO - 'PWD': '/builds/slave/test', 01:46:45 INFO - 'SHELL': '/bin/bash', 01:46:45 INFO - 'SHLVL': '1', 01:46:45 INFO - 'TERM': 'linux', 01:46:45 INFO - 'TMOUT': '86400', 01:46:45 INFO - 'USER': 'cltbld', 01:46:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', 01:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:45 INFO - '_': '/tools/buildbot/bin/python'} 01:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:46:46 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:46:46 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:46:46 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:46:46 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:46:46 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:46:46 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:46:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:46:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:46:47 INFO - Installing collected packages: mozsystemmonitor 01:46:47 INFO - Running setup.py install for mozsystemmonitor 01:46:47 INFO - Successfully installed mozsystemmonitor 01:46:47 INFO - Cleaning up... 01:46:47 INFO - Return code: 0 01:46:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, '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 0x12ef3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ef840>, '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': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', '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:46:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:46:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:46:47 INFO - Using env: {'DISPLAY': ':0', 01:46:47 INFO - 'HOME': '/home/cltbld', 01:46:47 INFO - 'LANG': 'en_US.UTF-8', 01:46:47 INFO - 'LANGUAGE': 'en_US:en', 01:46:47 INFO - 'LOGNAME': 'cltbld', 01:46:47 INFO - 'MAIL': '/var/mail/cltbld', 01:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:47 INFO - 'MOZ_NO_REMOTE': '1', 01:46:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:47 INFO - 'NO_EM_RESTART': '1', 01:46:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:47 INFO - 'PWD': '/builds/slave/test', 01:46:47 INFO - 'SHELL': '/bin/bash', 01:46:47 INFO - 'SHLVL': '1', 01:46:47 INFO - 'TERM': 'linux', 01:46:47 INFO - 'TMOUT': '86400', 01:46:47 INFO - 'USER': 'cltbld', 01:46:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', 01:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:47 INFO - '_': '/tools/buildbot/bin/python'} 01:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:47 INFO - Downloading/unpacking jsonschema==2.5.1 01:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:46:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:46:48 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:46:48 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:46:48 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:46:48 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:46:48 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:46:48 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:46:48 INFO - Downloading functools32-3.2.3-2.tar.gz 01:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:46:48 INFO - warning: no files found matching '*.txt' 01:46:48 INFO - no previously-included directories found matching 'build' 01:46:48 INFO - no previously-included directories found matching 'dist' 01:46:48 INFO - no previously-included directories found matching '.git*' 01:46:48 INFO - Installing collected packages: jsonschema, functools32 01:46:49 INFO - Running setup.py install for functools32 01:46:49 INFO - warning: no files found matching '*.txt' 01:46:49 INFO - no previously-included directories found matching 'build' 01:46:49 INFO - no previously-included directories found matching 'dist' 01:46:49 INFO - no previously-included directories found matching '.git*' 01:46:49 INFO - Successfully installed jsonschema functools32 01:46:49 INFO - Cleaning up... 01:46:49 INFO - Return code: 0 01:46:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:46:49 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:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:49 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:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:49 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 0x10531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, '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 0x12ef3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ef840>, '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': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', '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:46:49 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:46:49 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:46:49 INFO - Using env: {'DISPLAY': ':0', 01:46:49 INFO - 'HOME': '/home/cltbld', 01:46:49 INFO - 'LANG': 'en_US.UTF-8', 01:46:49 INFO - 'LANGUAGE': 'en_US:en', 01:46:49 INFO - 'LOGNAME': 'cltbld', 01:46:49 INFO - 'MAIL': '/var/mail/cltbld', 01:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:49 INFO - 'MOZ_NO_REMOTE': '1', 01:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:49 INFO - 'NO_EM_RESTART': '1', 01:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:49 INFO - 'PWD': '/builds/slave/test', 01:46:49 INFO - 'SHELL': '/bin/bash', 01:46:49 INFO - 'SHLVL': '1', 01:46:49 INFO - 'TERM': 'linux', 01:46:49 INFO - 'TMOUT': '86400', 01:46:49 INFO - 'USER': 'cltbld', 01:46:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', 01:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:49 INFO - '_': '/tools/buildbot/bin/python'} 01:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:46:49 INFO - Cleaning up... 01:46:49 INFO - Return code: 0 01:46:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:46:49 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:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:49 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:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:49 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 0x10531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, '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 0x12ef3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ef840>, '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': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', '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:46:49 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:46:49 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:46:49 INFO - Using env: {'DISPLAY': ':0', 01:46:49 INFO - 'HOME': '/home/cltbld', 01:46:49 INFO - 'LANG': 'en_US.UTF-8', 01:46:49 INFO - 'LANGUAGE': 'en_US:en', 01:46:49 INFO - 'LOGNAME': 'cltbld', 01:46:49 INFO - 'MAIL': '/var/mail/cltbld', 01:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:49 INFO - 'MOZ_NO_REMOTE': '1', 01:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:49 INFO - 'NO_EM_RESTART': '1', 01:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:49 INFO - 'PWD': '/builds/slave/test', 01:46:49 INFO - 'SHELL': '/bin/bash', 01:46:49 INFO - 'SHLVL': '1', 01:46:49 INFO - 'TERM': 'linux', 01:46:49 INFO - 'TMOUT': '86400', 01:46:49 INFO - 'USER': 'cltbld', 01:46:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', 01:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:49 INFO - '_': '/tools/buildbot/bin/python'} 01:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:49 INFO - Downloading/unpacking blobuploader==1.2.4 01:46:49 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:46:49 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:46:49 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:46:49 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:46:49 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:46:49 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:46:50 INFO - Downloading blobuploader-1.2.4.tar.gz 01:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:46:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:46:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:46:51 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:46:51 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:46:51 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:46:51 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:46:51 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:46:51 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:46:51 INFO - Downloading docopt-0.6.1.tar.gz 01:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:46:51 INFO - Installing collected packages: blobuploader, requests, docopt 01:46:51 INFO - Running setup.py install for blobuploader 01:46:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:46:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:46:51 INFO - Running setup.py install for requests 01:46:51 INFO - Running setup.py install for docopt 01:46:52 INFO - Successfully installed blobuploader requests docopt 01:46:52 INFO - Cleaning up... 01:46:52 INFO - Return code: 0 01:46:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:46:52 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:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:52 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:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:52 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 0x10531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, '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 0x12ef3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ef840>, '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': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', '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:46:52 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:46:52 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:46:52 INFO - Using env: {'DISPLAY': ':0', 01:46:52 INFO - 'HOME': '/home/cltbld', 01:46:52 INFO - 'LANG': 'en_US.UTF-8', 01:46:52 INFO - 'LANGUAGE': 'en_US:en', 01:46:52 INFO - 'LOGNAME': 'cltbld', 01:46:52 INFO - 'MAIL': '/var/mail/cltbld', 01:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:52 INFO - 'MOZ_NO_REMOTE': '1', 01:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:52 INFO - 'NO_EM_RESTART': '1', 01:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:52 INFO - 'PWD': '/builds/slave/test', 01:46:52 INFO - 'SHELL': '/bin/bash', 01:46:52 INFO - 'SHLVL': '1', 01:46:52 INFO - 'TERM': 'linux', 01:46:52 INFO - 'TMOUT': '86400', 01:46:52 INFO - 'USER': 'cltbld', 01:46:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', 01:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:52 INFO - '_': '/tools/buildbot/bin/python'} 01:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:46:52 INFO - Running setup.py (path:/tmp/pip-8Yt0r2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:46:52 INFO - Running setup.py (path:/tmp/pip-EucMrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:46:52 INFO - Running setup.py (path:/tmp/pip-GYZV_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:46:52 INFO - Running setup.py (path:/tmp/pip-oebZWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:46:52 INFO - Running setup.py (path:/tmp/pip-TFfIw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:46:52 INFO - Running setup.py (path:/tmp/pip-KPQyBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:46:52 INFO - Running setup.py (path:/tmp/pip-h732Jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:46:52 INFO - Running setup.py (path:/tmp/pip-3EdkCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:46:52 INFO - Running setup.py (path:/tmp/pip-j2DsSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:46:52 INFO - Running setup.py (path:/tmp/pip-tyzlel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:46:53 INFO - Running setup.py (path:/tmp/pip-g9MqZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:46:53 INFO - Running setup.py (path:/tmp/pip-GdsD1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:46:53 INFO - Running setup.py (path:/tmp/pip-1VBEGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:46:53 INFO - Running setup.py (path:/tmp/pip-bhxLJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:46:53 INFO - Running setup.py (path:/tmp/pip-Arqurm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:46:53 INFO - Running setup.py (path:/tmp/pip-LXXj3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:46:53 INFO - Running setup.py (path:/tmp/pip-qq8Amg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:46:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:46:53 INFO - Running setup.py install for manifestparser 01:46:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:46:53 INFO - Running setup.py install for mozcrash 01:46:53 INFO - Running setup.py install for mozdebug 01:46:53 INFO - Running setup.py install for mozdevice 01:46:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:46:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:46:53 INFO - Running setup.py install for mozfile 01:46:54 INFO - Running setup.py install for mozhttpd 01:46:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:46:54 INFO - Running setup.py install for mozinfo 01:46:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:46:54 INFO - Running setup.py install for mozInstall 01:46:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:46:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:46:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:46:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:46:54 INFO - Running setup.py install for mozleak 01:46:54 INFO - Running setup.py install for mozlog 01:46:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:46:54 INFO - Running setup.py install for moznetwork 01:46:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:46:54 INFO - Running setup.py install for mozprocess 01:46:54 INFO - Running setup.py install for mozprofile 01:46:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:46:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:46:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:46:54 INFO - Running setup.py install for mozrunner 01:46:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:46:55 INFO - Running setup.py install for mozscreenshot 01:46:55 INFO - Running setup.py install for moztest 01:46:55 INFO - Running setup.py install for mozversion 01:46:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:46:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:46:55 INFO - Cleaning up... 01:46:55 INFO - Return code: 0 01:46:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:46:55 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:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:55 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:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:55 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 0x10531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, '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 0x12ef3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ef840>, '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': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', '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:46:55 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:46:55 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:46:55 INFO - Using env: {'DISPLAY': ':0', 01:46:55 INFO - 'HOME': '/home/cltbld', 01:46:55 INFO - 'LANG': 'en_US.UTF-8', 01:46:55 INFO - 'LANGUAGE': 'en_US:en', 01:46:55 INFO - 'LOGNAME': 'cltbld', 01:46:55 INFO - 'MAIL': '/var/mail/cltbld', 01:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:55 INFO - 'MOZ_NO_REMOTE': '1', 01:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:55 INFO - 'NO_EM_RESTART': '1', 01:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:55 INFO - 'PWD': '/builds/slave/test', 01:46:55 INFO - 'SHELL': '/bin/bash', 01:46:55 INFO - 'SHLVL': '1', 01:46:55 INFO - 'TERM': 'linux', 01:46:55 INFO - 'TMOUT': '86400', 01:46:55 INFO - 'USER': 'cltbld', 01:46:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', 01:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:55 INFO - '_': '/tools/buildbot/bin/python'} 01:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:46:55 INFO - Running setup.py (path:/tmp/pip-n1vSiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:46:55 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:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:46:55 INFO - Running setup.py (path:/tmp/pip-HDcyhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:46:55 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:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:46:55 INFO - Running setup.py (path:/tmp/pip-azAAoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:46:55 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:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:46:55 INFO - Running setup.py (path:/tmp/pip-c6KVzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:46:55 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:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:46:55 INFO - Running setup.py (path:/tmp/pip-Pr9udz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:46:55 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:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:46:55 INFO - Running setup.py (path:/tmp/pip-Teft9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:46:56 INFO - Running setup.py (path:/tmp/pip-fyjMW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:46:56 INFO - Running setup.py (path:/tmp/pip-gJwnv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:46:56 INFO - Running setup.py (path:/tmp/pip-L9d0mN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:46:56 INFO - Running setup.py (path:/tmp/pip-nCnpjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:46:56 INFO - Running setup.py (path:/tmp/pip-6G1MnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:46:56 INFO - Running setup.py (path:/tmp/pip-_Zn_aZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:46:56 INFO - Running setup.py (path:/tmp/pip-IT0Oq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:46:56 INFO - Running setup.py (path:/tmp/pip-Ju8pN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:46:56 INFO - Running setup.py (path:/tmp/pip-hlcPMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:46:56 INFO - Running setup.py (path:/tmp/pip-tfORRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:46:56 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:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:46:56 INFO - Running setup.py (path:/tmp/pip-vKcPcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:46:56 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:46:56 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:46:56 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:46:56 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:46:56 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:46:56 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:46:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:57 INFO - Downloading blessings-1.6.tar.gz 01:46:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:46:57 INFO - Installing collected packages: blessings 01:46:57 INFO - Running setup.py install for blessings 01:46:58 INFO - Successfully installed blessings 01:46:58 INFO - Cleaning up... 01:46:58 INFO - Return code: 0 01:46:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:46:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:46:58 INFO - Reading from file tmpfile_stdout 01:46:58 INFO - Current package versions: 01:46:58 INFO - argparse == 1.2.1 01:46:58 INFO - blessings == 1.6 01:46:58 INFO - blobuploader == 1.2.4 01:46:58 INFO - docopt == 0.6.1 01:46:58 INFO - functools32 == 3.2.3-2 01:46:58 INFO - jsonschema == 2.5.1 01:46:58 INFO - manifestparser == 1.1 01:46:58 INFO - mozInstall == 1.12 01:46:58 INFO - mozcrash == 1.0 01:46:58 INFO - mozdebug == 0.1 01:46:58 INFO - mozdevice == 0.49 01:46:58 INFO - mozfile == 1.2 01:46:58 INFO - mozhttpd == 0.7 01:46:58 INFO - mozinfo == 0.9 01:46:58 INFO - mozleak == 0.1 01:46:58 INFO - mozlog == 3.4 01:46:58 INFO - moznetwork == 0.27 01:46:58 INFO - mozprocess == 0.25 01:46:58 INFO - mozprofile == 0.28 01:46:58 INFO - mozrunner == 6.13 01:46:58 INFO - mozscreenshot == 0.1 01:46:58 INFO - mozsystemmonitor == 0.3 01:46:58 INFO - moztest == 0.8 01:46:58 INFO - mozversion == 1.4 01:46:58 INFO - psutil == 3.1.1 01:46:58 INFO - requests == 1.2.3 01:46:58 INFO - wsgiref == 0.1.2 01:46:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:58 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 0x10531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, '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 0x12ef3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ef840>, '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': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', '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:46:58 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:46:58 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:46:58 INFO - Using env: {'DISPLAY': ':0', 01:46:58 INFO - 'HOME': '/home/cltbld', 01:46:58 INFO - 'LANG': 'en_US.UTF-8', 01:46:58 INFO - 'LANGUAGE': 'en_US:en', 01:46:58 INFO - 'LOGNAME': 'cltbld', 01:46:58 INFO - 'MAIL': '/var/mail/cltbld', 01:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:58 INFO - 'MOZ_NO_REMOTE': '1', 01:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:58 INFO - 'NO_EM_RESTART': '1', 01:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:58 INFO - 'PWD': '/builds/slave/test', 01:46:58 INFO - 'SHELL': '/bin/bash', 01:46:58 INFO - 'SHLVL': '1', 01:46:58 INFO - 'TERM': 'linux', 01:46:58 INFO - 'TMOUT': '86400', 01:46:58 INFO - 'USER': 'cltbld', 01:46:58 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', 01:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:58 INFO - '_': '/tools/buildbot/bin/python'} 01:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 INFO - Cleaning up... 01:46:58 INFO - Return code: 0 01:46:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f1310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, '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 0x12ef3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ef840>, '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': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', '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:46:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:46:58 INFO - Using env: {'DISPLAY': ':0', 01:46:58 INFO - 'HOME': '/home/cltbld', 01:46:58 INFO - 'LANG': 'en_US.UTF-8', 01:46:58 INFO - 'LANGUAGE': 'en_US:en', 01:46:58 INFO - 'LOGNAME': 'cltbld', 01:46:58 INFO - 'MAIL': '/var/mail/cltbld', 01:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:58 INFO - 'MOZ_NO_REMOTE': '1', 01:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:58 INFO - 'NO_EM_RESTART': '1', 01:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:58 INFO - 'PWD': '/builds/slave/test', 01:46:58 INFO - 'SHELL': '/bin/bash', 01:46:58 INFO - 'SHLVL': '1', 01:46:58 INFO - 'TERM': 'linux', 01:46:58 INFO - 'TMOUT': '86400', 01:46:58 INFO - 'USER': 'cltbld', 01:46:58 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', 01:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:58 INFO - '_': '/tools/buildbot/bin/python'} 01:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:46:58 INFO - Cleaning up... 01:46:58 INFO - Return code: 0 01:46:58 INFO - Running post-action listener: _resource_record_post_action 01:46:58 INFO - Running post-action listener: _start_resource_monitoring 01:46:58 INFO - Starting resource monitoring. 01:46:58 INFO - [mozharness: 2017-05-05 08:46:58.786918Z] Finished create-virtualenv step (success) 01:46:58 INFO - [mozharness: 2017-05-05 08:46:58.787503Z] Running install step. 01:46:58 INFO - Running pre-action listener: _resource_record_pre_action 01:46:58 INFO - Running main action method: install 01:46:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:46:58 INFO - Reading from file tmpfile_stdout 01:46:58 INFO - Detecting whether we're running mozinstall >=1.0... 01:46:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:46:59 INFO - Reading from file tmpfile_stdout 01:46:59 INFO - Output received: 01:46:59 INFO - Usage: mozinstall [options] installer 01:46:59 INFO - Options: 01:46:59 INFO - -h, --help show this help message and exit 01:46:59 INFO - -d DEST, --destination=DEST 01:46:59 INFO - Directory to install application into. [default: 01:46:59 INFO - "/builds/slave/test"] 01:46:59 INFO - --app=APP Application being installed. [default: firefox] 01:46:59 INFO - mkdir: /builds/slave/test/build/application 01:46:59 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:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:47:15 INFO - Reading from file tmpfile_stdout 01:47:15 INFO - Output received: 01:47:15 INFO - /builds/slave/test/build/application/firefox/firefox 01:47:15 INFO - Running post-action listener: _resource_record_post_action 01:47:15 INFO - [mozharness: 2017-05-05 08:47:15.605712Z] Finished install step (success) 01:47:15 INFO - [mozharness: 2017-05-05 08:47:15.605990Z] Running run-tests step. 01:47:15 INFO - Running pre-action listener: _resource_record_pre_action 01:47:15 INFO - Running main action method: run_tests 01:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:47:15 INFO - Python 2.7.3 01:47:15 INFO - Return code: 0 01:47:15 INFO - grabbing minidump binary from tooltool 01:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:47:15 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 0x12ee400>, '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 0x12ef3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ef840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:47:15 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:47:15 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:47:15 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:47:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:47:15 INFO - Return code: 0 01:47:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:47:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:47:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:47:15 INFO - ENV: RUST_BACKTRACE is now 1 01:47:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:47:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:47:15 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/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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:47:15 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/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-025 --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:47:15 INFO - Using env: {'DISPLAY': ':0', 01:47:15 INFO - 'HOME': '/home/cltbld', 01:47:15 INFO - 'LANG': 'en_US.UTF-8', 01:47:15 INFO - 'LANGUAGE': 'en_US:en', 01:47:15 INFO - 'LOGNAME': 'cltbld', 01:47:15 INFO - 'MAIL': '/var/mail/cltbld', 01:47:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:47:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:15 INFO - 'MOZ_NO_REMOTE': '1', 01:47:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:15 INFO - 'NO_EM_RESTART': '1', 01:47:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:15 INFO - 'PWD': '/builds/slave/test', 01:47:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:47:15 INFO - 'RUST_BACKTRACE': '1', 01:47:15 INFO - 'SHELL': '/bin/bash', 01:47:15 INFO - 'SHLVL': '1', 01:47:15 INFO - 'TERM': 'linux', 01:47:15 INFO - 'TMOUT': '86400', 01:47:15 INFO - 'USER': 'cltbld', 01:47:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878', 01:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:15 INFO - '_': '/tools/buildbot/bin/python'} 01:47:15 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/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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:47:15 INFO - mozversion application_buildid: 20170505074938 01:47:15 INFO - mozversion application_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 01:47:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:47:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:47:15 INFO - mozversion application_name: Firefox 01:47:15 INFO - mozversion application_remotingname: firefox-dev 01:47:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:47:15 INFO - mozversion application_vendor: Mozilla 01:47:15 INFO - mozversion application_version: 54.0a2 01:47:15 INFO - mozversion platform_buildid: 20170505074938 01:47:15 INFO - mozversion platform_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 01:47:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:47:15 INFO - mozversion platform_version: 54.0a2 01:47:15 INFO - using testdate: 1493974035 01:47:15 INFO - actual date: 1493974035 01:47:15 INFO - starting webserver on 'localhost:46404' 01:47:15 INFO - SUITE-START | Running 2 tests 01:47:15 INFO - TEST-START | dromaeo_css 01:47:15 INFO - operating with platform_type : linux_ 01:47:15 INFO - Initialising browser for dromaeo_css test... 01:47:15 INFO - TEST-INFO | started process 13500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdRJc3n/profile http://localhost:46404/getInfo.html) 01:47:20 INFO - PROCESS | 13500 | __metrics Screen width/height:1600/1200 01:47:20 INFO - PROCESS | 13500 | colorDepth:24 01:47:20 INFO - PROCESS | 13500 | Browser inner width/height: 1024/697 01:47:20 INFO - PROCESS | 13500 | __metrics 01:47:20 INFO - PROCESS | 13500 | 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:47:20 INFO - PROCESS | 13500 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:47:21 INFO - TEST-INFO | 13500: exit 0 01:47:21 INFO - Browser initialized. 01:47:21 INFO - Running cycle 1/1 for dromaeo_css test... 01:47:21 INFO - TEST-INFO | started process 13591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdRJc3n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:47:33 INFO - PROCESS | 13591 | RSS: Main: 139857920 01:47:33 INFO - PROCESS | 13591 | 01:50:35 INFO - PROCESS | 13591 | Cycle 1(1): loaded http://localhost:46404/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46404/tests/dromaeo/cssquery-ext.html) 01:50:36 INFO - PROCESS | 13591 | RSS: Main: 274259968 01:50:36 INFO - PROCESS | 13591 | 01:52:24 INFO - PROCESS | 13591 | ************************* 01:52:24 INFO - PROCESS | 13591 | A coding exception was thrown and uncaught in a Task. 01:52:24 INFO - PROCESS | 13591 | 01:52:24 ERROR - PROCESS | 13591 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:52:24 INFO - PROCESS | 13591 | Full stack: 01:52:24 INFO - PROCESS | 13591 | ************************* 01:52:24 INFO - PROCESS | 13591 | ************************* 01:52:24 INFO - PROCESS | 13591 | A coding exception was thrown and uncaught in a Task. 01:52:24 INFO - PROCESS | 13591 | 01:52:24 ERROR - PROCESS | 13591 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:52:24 INFO - PROCESS | 13591 | Full stack: 01:52:24 INFO - PROCESS | 13591 | ************************* 01:52:24 INFO - PROCESS | 13591 | ************************* 01:52:24 INFO - PROCESS | 13591 | A coding exception was thrown and uncaught in a Task. 01:52:24 INFO - PROCESS | 13591 | 01:52:24 ERROR - PROCESS | 13591 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:52:24 INFO - PROCESS | 13591 | Full stack: 01:52:24 INFO - PROCESS | 13591 | ************************* 01:52:24 INFO - PROCESS | 13591 | ************************* 01:52:24 INFO - PROCESS | 13591 | A coding exception was thrown and uncaught in a Task. 01:52:24 INFO - PROCESS | 13591 | 01:52:24 ERROR - PROCESS | 13591 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:52:24 INFO - PROCESS | 13591 | Full stack: 01:52:24 INFO - PROCESS | 13591 | ************************* 01:53:38 INFO - PROCESS | 13591 | Cycle 1(1): loaded http://localhost:46404/tests/dromaeo/cssquery-ext.html (next: http://localhost:46404/tests/dromaeo/cssquery-jquery.html) 01:53:39 INFO - PROCESS | 13591 | RSS: Main: 221933568 01:53:39 INFO - PROCESS | 13591 | 01:56:41 INFO - PROCESS | 13591 | Cycle 1(1): loaded http://localhost:46404/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46404/tests/dromaeo/cssquery-mootools.html) 01:56:41 INFO - PROCESS | 13591 | RSS: Main: 199618560 01:56:41 INFO - PROCESS | 13591 | 01:59:43 INFO - PROCESS | 13591 | Cycle 1(1): loaded http://localhost:46404/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46404/tests/dromaeo/cssquery-prototype.html) 01:59:44 INFO - PROCESS | 13591 | RSS: Main: 171048960 01:59:44 INFO - PROCESS | 13591 | 02:02:47 INFO - PROCESS | 13591 | Cycle 1(1): loaded http://localhost:46404/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46404/tests/dromaeo/cssquery-yui.html) 02:02:47 INFO - PROCESS | 13591 | RSS: Main: 178069504 02:02:47 INFO - PROCESS | 13591 | 02:05:50 INFO - PROCESS | 13591 | Cycle 1(1): loaded http://localhost:46404/tests/dromaeo/cssquery-yui.html (next: http://localhost:46404/tests/dromaeo/cssquery-dojo.html) 02:05:50 INFO - PROCESS | 13591 | RSS: Main: 259616768 02:05:50 INFO - PROCESS | 13591 | 02:05:50 INFO - PROCESS | 13591 | __start_tp_report 02:05:50 INFO - PROCESS | 13591 | _x_x_mozilla_page_load 02:05:50 INFO - PROCESS | 13591 | _x_x_mozilla_page_load_details 02:05:50 INFO - PROCESS | 13591 | |i|pagename|runs| 02:05:50 INFO - PROCESS | 13591 | |0;dojo.html;3403.693667569918;3412.829358532073;3437.776544524606;3438.759286849918;3494.8602055917763;5670.234518340023;5755.079187330028;5769.596128271022;5773.855653608652;5781.797637082703;5755.165501002352;5787.47912687858;5788.82633520994;5794.942050579493;5798.043322851735;5153.896922061566;5184.585233181355;5206.531412172903;5207.401148867891;5244.449332820056;4970.726610036447;4975.427825800043;5249.606279529032;5256.421793602701;5260.605454590902;5100.795968161269;5118.155504341779;5191;5191.169412893938;5216.035033518792;5217.843464696065;5218.973905130488;5228.895422091537;5232.790688372461;5248.895022099575;4960.776765045582;5090.363704536933;5157.968406318714;5196.92204616931;5207.323048003773;5525.972370138124;5591.30108736408;5671.347795003586;5695.886082278373;5697.373288938214;6154.599951003215;6188.257409110891;6197.504199664016;6202.72087756052;6211.968940155315;6223.159873417076;6225.367251881034;6249.2813326467585;6251.843703907393;6258.718357673915;5592;5624.3250809902665;5774.855628609276;5822.446867547576;5828.213191219216;6274.780382686584;6275.02737075754;6276.435120839055;6283.37166283368;6293.402126797947;5975.043992961106;6028.0355143176885;6030.6080104793045;6033.5173186145;6041.335453100155;5917.763289468373;5966.522678185822;6119.938800612026;6144.723487443076;6148.385161483816;6117.431594453911;6135.723892424851;6139.263288405331;6140.907886381708;6146.569740118149;5917.733701983421;5954.315253745788;5965.403459654;6055.636661800306;6125.309396713653;4629.25931850909;4688.226442636995;4707.388039554904;4716.858494245178;4717.410323709536;4185.853495127717;4194.3918131870705;4200.1179752252365;4212.368144778307;4246.341817018367;5725.484706376446;5779.971100144472;5881.5000724938;5920.644761314335;5975.103734439869;6213.689315534205;6221.875562488724;6225.252969643671;6226.439620434183;6228.47058000066;5963.970180149158;5972.402759723993;5972.432618901197;5989.490893274121;6004.159417681528;5025.170846810235;5051.595872330278;5178;5202.4277329493725;5245.763940622681;6490.967545162244;6506.446952008943;6513.804585862432;6515.8696826063215;6517.641529715816;6186.969065154645;6199.783007594712;6257.217847769029;6258.7809426671665;6259.906101408392;6148.415900489446;6201.410865967726;6323.841903952438;6509.674516274073;6511.902321465276;6087.634741915499;6099;6113.23584551931;6129.816105516842;6129.938700612936;6202.7208775606105;6229.719662615103;6231.1276421300145;6234.096056071753;6243.157173781481;5744.798932037359;5847.239858818326;6002.969985150046;6007.459328660441;6041.758329666764;5955.315138759098;6001.4298641628975;6043.12374705674;6044.546659000681;6059.182010428536;6023.6385816851125;6028.638281703112;6039.728212230372;6044.093385992136;6044.486218671286;5816.534677225727;5850;5859.5019423347785;5993.220881285405;6026.0659597762415;5824.912626310524;5864.970675146597;5941.821745347646;5947.464728174485;5985.551083668829 02:05:50 INFO - PROCESS | 13591 | |1;ext.html;781.9921800781995;835.5154010673809;853.914608539146;916.1891725822645;927.3415874728942;32000.199995000108;42864.78567607162;43866.342004869955;43968.56031439685;43993.12013759723;45426.31860522086;45567.088658226814;45579.772101139446;45626;45652;7725.420593455485;7893.921060789405;9057.00372958974;9178.586963586622;9189.954050229773;10580.78838423231;10805.081568066724;10810.081143102845;10827.025567698905;11054.834177487344;10840.457977101152;10919.454027298643;10923.945380273088;10928.726781830439;10929;10787.137029037658;10809.729756756105;10811.027007569277;10813.83779243312;10837.83743243852;10747.301425407324;10796.352218866814;10807.513661885234;10811.83782243267;10817.891821081766;40935.7953210232;41023.384649230284;41136.79431602853;41203;41241.58758412408;4156.958430415687;4169.10364271683;4202.411662367271;4274.102438487921;4312.029793296515;29775.851120744475;30181.245468863235;30212.24469388261;30728.078157655305;31622.525662115087;3973.543042550115;4062.634362907323;4069.104796944667;4090.059286364123;4168.124693814302;239380;239936;240777;242180.99999999822;242803;53325;53827;53942.46057539453;54032.459675402744;54183;56375.71812140913;56531.15203271954;56595;56602.15096773551;56658.716706416206;16523;16837.410690626013;16843.74734378985;16866.156692165343;16866.409675661293;12151.210171338835;12323.322217277957;12421.813672794735;14936.850631493764;14951;13249.801252981213;13450.192988420726;13457.932710336581;13527.66180845467;13592.25242611646;5287.814926477555;5353.785848566092;5421.674699518042;5455.236266922634;5513.917291240635;982.7543114221445;1002.1832206751474;1005.4269066631949;1021.2442792333619;1023.9283250172416;27127.728722712916;28179.295517612223;28592.285192870346;28665.856670716512;28942.13173604795;1056.8309070548676;1062.8193207154802;1077.1275267033727;1081.34578579958;1084.6691759013577;14010.159390436607;15120.168390738396;15141;15206.923965380101;15319.157446340558;318776;319907;320479;321138;321621;56049.71975140098;56069.43930560724;56151.438485615436;56359.71820140873;56506.43493565094;1467.7912430419385;1498.0711958585746;1524.1388615432245;1528.1366028194257;1551.6819052094293;25830.483390332465;27176;27622.447551049267;27704.445911082068;27834.44331113407;43017.139657206055;43102;43107.78446107749;43130.78434607932;43229.351559726;288386;288848;288940;289397;291115;29241;29760.10719678413;34887.825560872036;35308.47037294391;35884.461733074546;43153.56846431496;43406;43693.78153109214;44460.22159113599;44568.55431445644;33056.83471582723;33658.66341336555;33664.326713466085;33892;33945.830270849474;33493.83253083817;33511.16222094467;33526.32947340991;33693.83153084219;34573.48139777855;38564.22871542609;39119;39167.41248881212;39244.215115696956;39446.40830387604;32033.839830800698;32257.51613725843;32315.838420807744;32479.18802029968;32826.67173328236;25169.87415062913;25663;25677.61483577785;25946.481070378108;26446.735532645198 02:05:50 INFO - PROCESS | 13591 | |2;jquery.html;446.97094688845243;461.1860066981778;465.17663735188717;471.65333479892297;482.7031375703942;19776.90111549442;20998.580028399443;21106.15575376985;21250.362489125313;21429.571408571857;20878.373648790523;21374.786252137474;21501.892490537564;21835.563288734214;22437.43906402341;6472.7087281072345;6763.086983257246;6826.283240259776;7204.783856484288;7470.58911759853;7313.926860731378;7526.322630963212;7566.659500322498;7569.772906812805;7577.545347279153;7436.888446673304;7454.5899975501325;7499.925000750004;7505.474616776828;7514.248575142469;7243.420526357879;7461.253874612523;7469.551826890377;7501.399888008947;7520.059992500937;7181.245969173266;7295.708171673126;7332.19345871959;7334.3032411920785;7396.630168491554;24911.377215569573;25089.749102508922;25101.121460748967;25424.98300067995;25426;3009.365883617382;3117.173948903542;3199.2001999500126;3264.9183770405693;3284.720798732111;15290;16199.1090490023;16418.753718694228;16602.1698915055;16816.74774878378;2291.6906217660735;2330.7086614173227;2375.2992867104244;2389.0802041214083;2416.1181168873236;85362.57318713429;96011.51994239984;99665;99751.01244937797;117853.41073294665;20652;20811.68782468264;21558.029888655048;21638.891805541185;22238.777612223996;41846.790766045975;42372.57627423748;42558.36162457566;42662;42795.35806962898;11664.825027624593;11770;11817.88182118185;11900.821487677691;12024.75950481003;9376.249900007982;9457.668981585612;9466.242700583936;9607.711768646952;9666.903330966741;11103.278286911325;11221.5312631221;11367.1812509998;11431.428428578538;11569.710757230969;4243.448351714257;4259.765712885759;4328;4375.146846364928;4439.66702497314;929.163752622645;938.0385105267155;951.3007939164709;972.1056627902346;982.577491678585;20115.59768804645;21378.89310553437;21506;21517.46206344854;21806.781932180475;968.5593055159885;968.8595153702673;970.5632465390603;981.097390400833;988.1748739802202;10757.83863242052;11572.611286645488;11620.128490363257;11657.300561966309;11728.589499367481;675732;675799;684795;685523;773093;76997;105059;112371.43814280877;113208.43395782968;116124;1137.1641843245209;1170.8419363386004;1176.2472017908544;1183.976320473603;1188.6493484421944;18109.728354074436;18336.724949125506;18441.262349506407;18516.16677249554;19026.334078307194;49893.75053124711;50016.749916250184;50553.74723126508;51232.48767512277;51635.22547161871;62555.37444625496;63524.68237658782;63672.68163659337;65273;66002.66998664977;11896.405179741152;11914.821277680669;12177.269363837844;12310.537892421373;12326.075544334031;12691.428885699981;12924.870751292743;12985.740285194432;13063.542776002794;13088.73822523525;11348.602798901999;11517;11544.365059921785;11659.300441973508;11690.532378704756;10558;11480.138989575647;11661.833816618271;11814.822777658514;12238.143329966817;12627.11610187278;12821.166624169398;12934.417951192407;13024.153430027396;13257.337133143497;12548.247105173354;12681;12764;13025.023123265604;13111.868881311446;12382.318972456602;12390.690232744253;12504.249745015328;12538;12568.30874301922 02:05:50 INFO - PROCESS | 13591 | |3;mootools.html;1562.6640272341458;1582.9920850395747;1603.3185895994204;1614.6528496373278;1622.3997121065208;10705.625303114382;11402.942985285063;11410.08719302456;11421.657350279494;11424.71438214045;11013.229073964825;11247.943760281207;11280.548778048867;11299.096072314216;11302.321860688344;2492.0530198524625;2518.7229404765462;2524.810639202058;2531.493701259755;2531.658226139475;2316.525112351964;2417.8791060446997;2452.3623857796924;2453.264020793764;2459.2622213335926;2405.4467472481338;2421.382547450398;2436.7319594844553;2437.8659173745436;2442.682451281331;2327.243645815117;2363.420961864346;2368.5026144509675;2369;2393.6050551658955;2387.7612238776155;2394.5210957808335;2410.770976757205;2411.409204744831;2420.8668523231217;11111.277766945122;11242.49408776607;11249.493772780163;11252.156088293328;11272.830907536394;5925.822225333204;6073.665948372838;6073.939260607426;6074.179985701918;6079.817605471843;3498.038039539147;3544.3442963051916;3552.5381700379044;3637.763545369569;3670.7063434925144;1393.5679939218874;1418.1420240754298;1421.8080559124592;1423.3808293392408;1496.6034000989746;16669.08320042397;17132.486025419257;17378.65242695139;17448.651026979518;17543.561410964827;4913.754312284443;4970.105381031449;4970.304157417964;4992.2511623256805;5121.28302037715;12779.105462617714;12801.103922725506;12811.615651530468;12818.166819156724;12851.100422970303;6020.157177995085;6033.78881739137;6046.788362407295;6054.122152287893;6054.334023257438;5373.623846330719;5540.418256083134;5577.776888924479;5594.328680558359;5626.043572592669;4008.051364177279;4108.4864391951005;4126.546079931205;4147.315692910696;4157.376393540993;1094.4363652718855;1102.7739313440725;1108.534415545473;1110.5557776889148;1126.318577260762;1058.1059005140644;1069.4706120470416;1070.7430216747925;1073.3667136389568;1084.6258040975852;7248.347648711536;7278.526895751759;7353.485256032133;7374.557526548424;7467.215942326086;1021.4024795494719;1035.2701345551368;1038.901304376098;1063.8138325792954;1083.312096818526;4875.293082503017;4895.04546613407;4930.1865192243595;4939.677781940802;5277.788888444496;14824.925875370554;15243.542693719206;15249.085054896741;15269.236538173269;15282.617934551725;12521.686957826127;14842.257887105601;14849.554513364616;14958.925205374122;15004.324805383783;8474.74575762728;9373.343865929319;10678.252522323362;10823.404712740874;10886.07468365182;7225.710971561079;7284.927150728425;7334.193238743841;7596.658150383357;7648.464607477646;13156.671083222996;13169.802452963022;13365.599032029055;13605.795913061114;13672.726545469233;13291.534796282083;13307.26810025458;13316.40076196554;13347.66630834237;13382.063255572406;9630;9743.707688769347;9782.217422606032;9810.215182785503;9865.950670246602;10650.8402373966;10715.732106697395;10789.838152427878;10825.621103261348;10837.187210959051;8940.284777217938;9043.23132533742;9128;9300.953495232481;9411.341206115507;8601.311895048506;9104.271658267455;9259.305552083486;9309.162175404246;9761.170300524534;8211.425200235926;8589.055203927437;8602.39783215169;8665.046844847187;8844.380893337404;6097.96334623124;6130.141780150693;6130.938690613037;6269.341719119427;6289.591176573508;6333.778317758856;6479.1901012373455;6483.286838447672;6619.371159739817;6653.234877989094 02:05:50 INFO - PROCESS | 13591 | |4;prototype.html;417.4802371048046;444.3224083273008;447.2106731618692;448.4103404023709;453.68922288232585;5163.974180129104;5240.37115546135;5267.710275934827;5297.44376840432;5316.4911158635305;4974.2538619207135;5155.762616971928;5179.8446046618565;5210.2445145453985;5225.738713064351;4284.314509678452;4303.35449682547;4306.61240488356;4308.18144552534;4327.285997810358;4285.9571404286025;4286.542575524321;4293.35599660052;4293.656507479394;4334.219840428722;4325.286327755916;4336.073150623332;4345.3047512398025;4363.52001279859;4376.89057773555;4172.624463798257;4293.205756934977;4320.524742278347;4329.220740266751;4344.73931564104;4061.360115924643;4065.410515475269;4070.9185816283803;4080.5307389650275;4100.138970816132;5041.218611115283;5050.949490505084;5066.594672426197;5120.92318615221;5183.403908550489;5000.299958005882;5096.388433388017;5103.897922041539;5117.46266642001;5139.434662187194;5487.286652735159;5490.121580547093;5498.945010549924;5502.532284755801;5516.282883225195;4570.7029043112425;4574.817007319703;4585.770711464447;4620.445546534437;4637.860864174047;5408.972955135238;5497.422770609069;5560.4161563036105;5583.8604034899045;5671.376148623648;4657.580817726421;4680.251159814414;4687.718736875799;4715.434147902205;4739.056986635463;4787.497312782178;4793.664443488922;4796.784144713496;4801.351817504662;4821.783019764119;4748.715077095385;4861.149298872683;5047.772850221675;5057.544820966131;5084.593232541388;5448.809291674773;5472.20653005312;5484.451554844483;5507.586930980193;5552.583556233218;1657.1548510259854;1659.7800616546829;1665.84174503422;1668.215938508899;1670.5322509697305;1209.9334536600572;1265.1839563481503;1274.1463219642862;1285.6978610026636;1299.5516546791341;5120;5356.973215133899;5372.946270537323;5390.622656414013;5413.431589683105;5602.495775380154;5626.2685850839125;5626.606137570331;5630.746616402272;5676.914846277309;5404.135338345845;5432.320959880015;5435.320584926884;5484.396716361277;5491.697956612425;2910.2538476913683;2910.4179164167253;2966.5908693370475;2993.625796775403;3004.602859670264;5844.1818145459665;5865.736041878125;5891.941080589225;5913.793017244376;5956.404359564009;5646.830595082154;5674.985380190055;5683.295011496534;5692.800751973744;5745.626534275259;5515.706158792976;5798.6810725410505;5816.476517113396;5834.737436815353;5838.63535268217;5606.523445507014;5628.690422026828;5633.38032816398;5640.887182256414;5677.3471050829685;5288.629795914403;5480.479354461319;5590.44095590454;5591.651506367254;5627.606067575231;5577.972110139423;5687.544996400361;5710.8001219957105;5857.238558987305;5878.002957988609;4679.298105284234;4739.431268247832;4739.549742774431;4745.240761478147;4748.07702880334;5400.648957817729;5574.216250799705;5689.231953686365;5763.193152958673;5773.3072031356505;5465.590080744039;5509.118541033416;5578.63738856973;5580.274564306615;5601.243832082617;5585.69278689676;5600.4959553640365;5603.719814009201;5607.439256074523;5615.241942337732;5305.65513241638;5550.555955523468;5583.497485226349;5609.382967873449;5629.183768353648;5462.9726851365485;5485.259489968803;5535.6955367455175;5547.2233887256625;5569.637973531708;5176.689398636094;5459.481349271813;5476.67139971603;5503.972480137573;5532.723363831873 02:05:50 INFO - PROCESS | 13591 | |5;yui.html;814.7067055859885;883.2933653077537;887.9600417981194;913.3195769151982;927.4064598656861;16438.424655137074;17390.565235869093;17396.913015434937;17410.47768566945;17414.12929353532;16772.329106835743;17227.82772172281;17281.567960800956;17348;17365.7395139073;870.0733718589713;886.4902680958443;891.4606662968907;913.9314551408638;919.7424721078108;886.352962337494;888.4802390601474;888.8266787976347;889.1419779912384;889.253027456936;946.9857952130724;953.6280850468323;955.8327292723781;955.9904400956005;957.0764212534903;944.6599224279323;947.0245646983584;947.5167664491124;947.663579429303;947.8862536495595;692.5533031194901;692.6952141057968;697.4281089506607;697.5779653309776;698.3993765361785;16195.514134575982;16383.672326553522;16444.260008299654;17043.233054512577;17098.401555945606;15589.376424942988;15765.684686306324;15826;15918.840811591852;16018.519444416686;12837.1014029018;13188.736225275537;13296.534621288209;13476.056676032682;13534.390952407068;3879.670228030621;3925.7840818755244;3958.3072962231495;4040.0303927057294;4143.150654115899;85861.57069214676;86112.56943715242;87047;88660.99999999936;89363.10636893613;11941.402929853473;12298.508059677513;12355.135140540257;12591.559295424617;12617.684557886127;21397.78602213989;22111.557768844534;23189.88405057964;23457.296281111594;23545.058197672242;8812.955935220283;8874.822503549893;9083.68207112748;9178.449293042439;9257.074292570689;4937.185364414903;5193.610479214074;5217.3999990000875;5277.393099793496;5364.4099149094345;3773.9245215095543;3849.3840985442193;3902.765834049966;3903.5510916244993;3930.3514920038447;642.2934771751037;644.9774257901045;651.3226244705548;659.7558903205845;660.5607271164718;799.7400844725488;809.3242142810701;819.9098099209082;832.7085520067927;837.6272558711437;11121.944390277997;11384.715382115513;11478.311301321948;11714.531418743325;11942.164048516694;813.8616435205911;816.9787765293383;825.6490991328661;826.8511667899716;827.0736774812249;5286.233496143038;5316.6012549058205;5321.414644389114;5362.91955620666;5363.410024897258;81745.18254817494;85029;85464;86791;87258.12741872628;45935;50126.49620511391;66382.66808665925;74543;76449.61775191089;61267;62283.065754013725;62304.376956230764;63001.369986300466;63853.36146638474;10972.286801357886;11361.488733006869;11433.085353171893;11574.305541667527;11886.524539018343;42273.365899512144;43342.133157336044;43346.566534334255;43371.56628433801;44231;51137.48862511476;51376;51669.22496162485;52028.739856300475;52725.209121862434;13188.538401155913;13262.734745304846;13298.867011329763;13355.666108347368;13521.86478135206;16272.593185170466;16568.17159142014;16588.917055414644;17620.471385858444;17639.911800440917;15098.849011510183;15194.544163675107;15719.292631831824;15855.920720396323;15881.285342159861;14334;14690;14754.409823606935;14777.187254701095;14917.254137292875;13989.370478328703;14025.114416192;14078.788818167532;14103.929480352532;14126.717465650834;10289.639862605072;10398.480075996322;10588.205884558534;10836.783264334827;10915.126789856633;12564.183328083645;12575.119741617998;12644;12713.93643031779;12845.871541284841 02:05:50 INFO - PROCESS | 13591 | __end_tp_report 02:05:50 INFO - PROCESS | 13591 | __start_cc_report 02:05:50 INFO - PROCESS | 13591 | _x_x_mozilla_cycle_collect,1280 02:05:50 INFO - PROCESS | 13591 | __end_cc_report 02:05:50 INFO - PROCESS | 13591 | __startTimestamp1493975150530__endTimestamp 02:05:50 INFO - PROCESS | 13591 | 02:05:50 INFO - PROCESS | 13591 | ------- Summary: start ------- 02:05:50 INFO - PROCESS | 13591 | Number of tests: 6 02:05:50 INFO - PROCESS | 13591 | 02:05:50 INFO - PROCESS | 13591 | [#0] dojo.html Cycles:165 Average:5710.84 Median:5963.97 stddev:656.50 (11.0%) stddev-sans-first:633.08 02:05:50 INFO - PROCESS | 13591 | Values: 3403.7 3412.8 3437.8 3438.8 3494.9 5670.2 5755.1 5769.6 5773.9 5781.8 5755.2 5787.5 5788.8 5794.9 5798.0 5153.9 5184.6 5206.5 5207.4 5244.4 4970.7 4975.4 5249.6 5256.4 5260.6 5100.8 5118.2 5191.0 5191.2 5216.0 5217.8 5219.0 5228.9 5232.8 5248.9 4960.8 5090.4 5158.0 5196.9 5207.3 5526.0 5591.3 5671.3 5695.9 5697.4 6154.6 6188.3 6197.5 6202.7 6212.0 6223.2 6225.4 6249.3 6251.8 6258.7 5592.0 5624.3 5774.9 5822.4 5828.2 6274.8 6275.0 6276.4 6283.4 6293.4 5975.0 6028.0 6030.6 6033.5 6041.3 5917.8 5966.5 6119.9 6144.7 6148.4 6117.4 6135.7 6139.3 6140.9 6146.6 5917.7 5954.3 5965.4 6055.6 6125.3 4629.3 4688.2 4707.4 4716.9 4717.4 4185.9 4194.4 4200.1 4212.4 4246.3 5725.5 5780.0 5881.5 5920.6 5975.1 6213.7 6221.9 6225.3 6226.4 6228.5 5964.0 5972.4 5972.4 5989.5 6004.2 5025.2 5051.6 5178.0 5202.4 5245.8 6491.0 6506.4 6513.8 6515.9 6517.6 6187.0 6199.8 6257.2 6258.8 6259.9 6148.4 6201.4 6323.8 6509.7 6511.9 6087.6 6099.0 6113.2 6129.8 6129.9 6202.7 6229.7 6231.1 6234.1 6243.2 5744.8 5847.2 6003.0 6007.5 6041.8 5955.3 6001.4 6043.1 6044.5 6059.2 6023.6 6028.6 6039.7 6044.1 6044.5 5816.5 5850.0 5859.5 5993.2 6026.1 5824.9 5865.0 5941.8 5947.5 5985.6 02:05:50 INFO - PROCESS | 13591 | 02:05:50 INFO - PROCESS | 13591 | [#1] ext.html Cycles:180 Average:45687.74 Median:320808.50 stddev:74447.25 (23.2%) stddev-sans-first:74579.74 02:05:50 INFO - PROCESS | 13591 | Values: 782.0 835.5 853.9 916.2 927.3 32000.2 42864.8 43866.3 43968.6 43993.1 45426.3 45567.1 45579.8 45626.0 45652.0 7725.4 7893.9 9057.0 9178.6 9190.0 10580.8 10805.1 10810.1 10827.0 11054.8 10840.5 10919.5 10923.9 10928.7 10929.0 10787.1 10809.7 10811.0 10813.8 10837.8 10747.3 10796.4 10807.5 10811.8 10817.9 40935.8 41023.4 41136.8 41203.0 41241.6 4157.0 4169.1 4202.4 4274.1 4312.0 29775.9 30181.2 30212.2 30728.1 31622.5 3973.5 4062.6 4069.1 4090.1 4168.1 239380.0 239936.0 240777.0 242181.0 242803.0 53325.0 53827.0 53942.5 54032.5 54183.0 56375.7 56531.2 56595.0 56602.2 56658.7 16523.0 16837.4 16843.7 16866.2 16866.4 12151.2 12323.3 12421.8 14936.9 14951.0 13249.8 13450.2 13457.9 13527.7 13592.3 5287.8 5353.8 5421.7 5455.2 5513.9 982.8 1002.2 1005.4 1021.2 1023.9 27127.7 28179.3 28592.3 28665.9 28942.1 1056.8 1062.8 1077.1 1081.3 1084.7 14010.2 15120.2 15141.0 15206.9 15319.2 318776.0 319907.0 320479.0 321138.0 321621.0 56049.7 56069.4 56151.4 56359.7 56506.4 1467.8 1498.1 1524.1 1528.1 1551.7 25830.5 27176.0 27622.4 27704.4 27834.4 43017.1 43102.0 43107.8 43130.8 43229.4 288386.0 288848.0 288940.0 289397.0 291115.0 29241.0 29760.1 34887.8 35308.5 35884.5 43153.6 43406.0 43693.8 44460.2 44568.6 33056.8 33658.7 33664.3 33892.0 33945.8 33493.8 33511.2 33526.3 33693.8 34573.5 38564.2 39119.0 39167.4 39244.2 39446.4 32033.8 32257.5 32315.8 32479.2 32826.7 25169.9 25663.0 25677.6 25946.5 26446.7 02:05:50 INFO - PROCESS | 13591 | 02:05:50 INFO - PROCESS | 13591 | [#2] jquery.html Cycles:180 Average:38516.20 Median:2311.20 stddev:114728.36 (4964.0%) stddev-sans-first:115014.60 02:05:50 INFO - PROCESS | 13591 | Values: 447.0 461.2 465.2 471.7 482.7 19776.9 20998.6 21106.2 21250.4 21429.6 20878.4 21374.8 21501.9 21835.6 22437.4 6472.7 6763.1 6826.3 7204.8 7470.6 7313.9 7526.3 7566.7 7569.8 7577.5 7436.9 7454.6 7499.9 7505.5 7514.2 7243.4 7461.3 7469.6 7501.4 7520.1 7181.2 7295.7 7332.2 7334.3 7396.6 24911.4 25089.7 25101.1 25425.0 25426.0 3009.4 3117.2 3199.2 3264.9 3284.7 15290.0 16199.1 16418.8 16602.2 16816.7 2291.7 2330.7 2375.3 2389.1 2416.1 85362.6 96011.5 99665.0 99751.0 117853.4 20652.0 20811.7 21558.0 21638.9 22238.8 41846.8 42372.6 42558.4 42662.0 42795.4 11664.8 11770.0 11817.9 11900.8 12024.8 9376.2 9457.7 9466.2 9607.7 9666.9 11103.3 11221.5 11367.2 11431.4 11569.7 4243.4 4259.8 4328.0 4375.1 4439.7 929.2 938.0 951.3 972.1 982.6 20115.6 21378.9 21506.0 21517.5 21806.8 968.6 968.9 970.6 981.1 988.2 10757.8 11572.6 11620.1 11657.3 11728.6 675732.0 675799.0 684795.0 685523.0 773093.0 76997.0 105059.0 112371.4 113208.4 116124.0 1137.2 1170.8 1176.2 1184.0 1188.6 18109.7 18336.7 18441.3 18516.2 19026.3 49893.8 50016.7 50553.7 51232.5 51635.2 62555.4 63524.7 63672.7 65273.0 66002.7 11896.4 11914.8 12177.3 12310.5 12326.1 12691.4 12924.9 12985.7 13063.5 13088.7 11348.6 11517.0 11544.4 11659.3 11690.5 10558.0 11480.1 11661.8 11814.8 12238.1 12627.1 12821.2 12934.4 13024.2 13257.3 12548.2 12681.0 12764.0 13025.0 13111.9 12382.3 12390.7 12504.2 12538.0 12568.3 02:05:50 INFO - PROCESS | 13591 | 02:05:50 INFO - PROCESS | 13591 | [#3] mootools.html Cycles:180 Average:7188.58 Median:2421.12 stddev:4556.34 (188.2%) stddev-sans-first:4549.51 02:05:50 INFO - PROCESS | 13591 | Values: 1562.7 1583.0 1603.3 1614.7 1622.4 10705.6 11402.9 11410.1 11421.7 11424.7 11013.2 11247.9 11280.5 11299.1 11302.3 2492.1 2518.7 2524.8 2531.5 2531.7 2316.5 2417.9 2452.4 2453.3 2459.3 2405.4 2421.4 2436.7 2437.9 2442.7 2327.2 2363.4 2368.5 2369.0 2393.6 2387.8 2394.5 2410.8 2411.4 2420.9 11111.3 11242.5 11249.5 11252.2 11272.8 5925.8 6073.7 6073.9 6074.2 6079.8 3498.0 3544.3 3552.5 3637.8 3670.7 1393.6 1418.1 1421.8 1423.4 1496.6 16669.1 17132.5 17378.7 17448.7 17543.6 4913.8 4970.1 4970.3 4992.3 5121.3 12779.1 12801.1 12811.6 12818.2 12851.1 6020.2 6033.8 6046.8 6054.1 6054.3 5373.6 5540.4 5577.8 5594.3 5626.0 4008.1 4108.5 4126.5 4147.3 4157.4 1094.4 1102.8 1108.5 1110.6 1126.3 1058.1 1069.5 1070.7 1073.4 1084.6 7248.3 7278.5 7353.5 7374.6 7467.2 1021.4 1035.3 1038.9 1063.8 1083.3 4875.3 4895.0 4930.2 4939.7 5277.8 14824.9 15243.5 15249.1 15269.2 15282.6 12521.7 14842.3 14849.6 14958.9 15004.3 8474.7 9373.3 10678.3 10823.4 10886.1 7225.7 7284.9 7334.2 7596.7 7648.5 13156.7 13169.8 13365.6 13605.8 13672.7 13291.5 13307.3 13316.4 13347.7 13382.1 9630.0 9743.7 9782.2 9810.2 9866.0 10650.8 10715.7 10789.8 10825.6 10837.2 8940.3 9043.2 9128.0 9301.0 9411.3 8601.3 9104.3 9259.3 9309.2 9761.2 8211.4 8589.1 8602.4 8665.0 8844.4 6098.0 6130.1 6130.9 6269.3 6289.6 6333.8 6479.2 6483.3 6619.4 6653.2 02:05:50 INFO - PROCESS | 13591 | 02:05:50 INFO - PROCESS | 13591 | [#4] prototype.html Cycles:180 Average:4791.43 Median:5293.04 stddev:1275.32 (24.1%) stddev-sans-first:1235.92 02:05:50 INFO - PROCESS | 13591 | Values: 417.5 444.3 447.2 448.4 453.7 5164.0 5240.4 5267.7 5297.4 5316.5 4974.3 5155.8 5179.8 5210.2 5225.7 4284.3 4303.4 4306.6 4308.2 4327.3 4286.0 4286.5 4293.4 4293.7 4334.2 4325.3 4336.1 4345.3 4363.5 4376.9 4172.6 4293.2 4320.5 4329.2 4344.7 4061.4 4065.4 4070.9 4080.5 4100.1 5041.2 5050.9 5066.6 5120.9 5183.4 5000.3 5096.4 5103.9 5117.5 5139.4 5487.3 5490.1 5498.9 5502.5 5516.3 4570.7 4574.8 4585.8 4620.4 4637.9 5409.0 5497.4 5560.4 5583.9 5671.4 4657.6 4680.3 4687.7 4715.4 4739.1 4787.5 4793.7 4796.8 4801.4 4821.8 4748.7 4861.1 5047.8 5057.5 5084.6 5448.8 5472.2 5484.5 5507.6 5552.6 1657.2 1659.8 1665.8 1668.2 1670.5 1209.9 1265.2 1274.1 1285.7 1299.6 5120.0 5357.0 5372.9 5390.6 5413.4 5602.5 5626.3 5626.6 5630.7 5676.9 5404.1 5432.3 5435.3 5484.4 5491.7 2910.3 2910.4 2966.6 2993.6 3004.6 5844.2 5865.7 5891.9 5913.8 5956.4 5646.8 5675.0 5683.3 5692.8 5745.6 5515.7 5798.7 5816.5 5834.7 5838.6 5606.5 5628.7 5633.4 5640.9 5677.3 5288.6 5480.5 5590.4 5591.7 5627.6 5578.0 5687.5 5710.8 5857.2 5878.0 4679.3 4739.4 4739.5 4745.2 4748.1 5400.6 5574.2 5689.2 5763.2 5773.3 5465.6 5509.1 5578.6 5580.3 5601.2 5585.7 5600.5 5603.7 5607.4 5615.2 5305.7 5550.6 5583.5 5609.4 5629.2 5463.0 5485.3 5535.7 5547.2 5569.6 5176.7 5459.5 5476.7 5504.0 5532.7 02:05:50 INFO - PROCESS | 13591 | 02:05:50 INFO - PROCESS | 13591 | [#5] yui.html Cycles:180 Average:18445.61 Median:42807.75 stddev:23050.54 (53.8%) stddev-sans-first:23077.18 02:05:50 INFO - PROCESS | 13591 | Values: 814.7 883.3 888.0 913.3 927.4 16438.4 17390.6 17396.9 17410.5 17414.1 16772.3 17227.8 17281.6 17348.0 17365.7 870.1 886.5 891.5 913.9 919.7 886.4 888.5 888.8 889.1 889.3 947.0 953.6 955.8 956.0 957.1 944.7 947.0 947.5 947.7 947.9 692.6 692.7 697.4 697.6 698.4 16195.5 16383.7 16444.3 17043.2 17098.4 15589.4 15765.7 15826.0 15918.8 16018.5 12837.1 13188.7 13296.5 13476.1 13534.4 3879.7 3925.8 3958.3 4040.0 4143.2 85861.6 86112.6 87047.0 88661.0 89363.1 11941.4 12298.5 12355.1 12591.6 12617.7 21397.8 22111.6 23189.9 23457.3 23545.1 8813.0 8874.8 9083.7 9178.4 9257.1 4937.2 5193.6 5217.4 5277.4 5364.4 3773.9 3849.4 3902.8 3903.6 3930.4 642.3 645.0 651.3 659.8 660.6 799.7 809.3 819.9 832.7 837.6 11121.9 11384.7 11478.3 11714.5 11942.2 813.9 817.0 825.6 826.9 827.1 5286.2 5316.6 5321.4 5362.9 5363.4 81745.2 85029.0 85464.0 86791.0 87258.1 45935.0 50126.5 66382.7 74543.0 76449.6 61267.0 62283.1 62304.4 63001.4 63853.4 10972.3 11361.5 11433.1 11574.3 11886.5 42273.4 43342.1 43346.6 43371.6 44231.0 51137.5 51376.0 51669.2 52028.7 52725.2 13188.5 13262.7 13298.9 13355.7 13521.9 16272.6 16568.2 16588.9 17620.5 17639.9 15098.8 15194.5 15719.3 15855.9 15881.3 14334.0 14690.0 14754.4 14777.2 14917.3 13989.4 14025.1 14078.8 14103.9 14126.7 10289.6 10398.5 10588.2 10836.8 10915.1 12564.2 12575.1 12644.0 12713.9 12845.9 02:05:50 INFO - PROCESS | 13591 | -------- Summary: end -------- 02:05:50 INFO - PROCESS | 13591 | 02:05:51 INFO - TEST-INFO | 13591: exit 0 02:05:51 INFO - TEST-OK | dromaeo_css | took 1115501ms 02:05:51 INFO - TEST-START | kraken 02:05:51 INFO - operating with platform_type : linux_ 02:05:51 INFO - Initialising browser for kraken test... 02:05:51 INFO - TEST-INFO | started process 13917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBrA0gp/profile http://localhost:46404/getInfo.html) 02:05:55 INFO - PROCESS | 13917 | __metrics Screen width/height:1600/1200 02:05:55 INFO - PROCESS | 13917 | colorDepth:24 02:05:55 INFO - PROCESS | 13917 | Browser inner width/height: 1024/697 02:05:55 INFO - PROCESS | 13917 | __metrics 02:05:56 INFO - PROCESS | 13917 | 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" 02:05:56 INFO - PROCESS | 13917 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:05:57 INFO - TEST-INFO | 13917: exit 0 02:05:57 INFO - Browser initialized. 02:05:57 INFO - Running cycle 1/1 for kraken test... 02:05:57 INFO - TEST-INFO | started process 14008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBrA0gp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:06:09 INFO - PROCESS | 14008 | RSS: Main: 140070912 02:06:09 INFO - PROCESS | 14008 | 02:06:11 INFO - PROCESS | 14008 | Cycle 1(1): loaded http://localhost:46404/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46404/tests/kraken/driver.html?testName=audio-beat-detection) 02:06:12 INFO - PROCESS | 14008 | RSS: Main: 183181312 02:06:12 INFO - PROCESS | 14008 | 02:06:15 INFO - PROCESS | 14008 | Cycle 1(1): loaded http://localhost:46404/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46404/tests/kraken/driver.html?testName=audio-dft) 02:06:15 INFO - PROCESS | 14008 | RSS: Main: 174473216 02:06:15 INFO - PROCESS | 14008 | 02:06:18 INFO - PROCESS | 14008 | Cycle 1(1): loaded http://localhost:46404/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46404/tests/kraken/driver.html?testName=audio-fft) 02:06:19 INFO - PROCESS | 14008 | RSS: Main: 266264576 02:06:19 INFO - PROCESS | 14008 | 02:06:21 INFO - PROCESS | 14008 | Cycle 1(1): loaded http://localhost:46404/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46404/tests/kraken/driver.html?testName=audio-oscillator) 02:06:21 INFO - PROCESS | 14008 | RSS: Main: 172216320 02:06:21 INFO - PROCESS | 14008 | 02:06:23 INFO - PROCESS | 14008 | Cycle 1(1): loaded http://localhost:46404/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46404/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:06:24 INFO - PROCESS | 14008 | RSS: Main: 174940160 02:06:24 INFO - PROCESS | 14008 | 02:06:27 INFO - PROCESS | 14008 | Cycle 1(1): loaded http://localhost:46404/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46404/tests/kraken/driver.html?testName=imaging-darkroom) 02:06:27 INFO - PROCESS | 14008 | RSS: Main: 213192704 02:06:27 INFO - PROCESS | 14008 | 02:06:31 INFO - PROCESS | 14008 | Cycle 1(1): loaded http://localhost:46404/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46404/tests/kraken/driver.html?testName=imaging-desaturate) 02:06:31 INFO - PROCESS | 14008 | RSS: Main: 211902464 02:06:31 INFO - PROCESS | 14008 | 02:06:34 INFO - PROCESS | 14008 | Cycle 1(1): loaded http://localhost:46404/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46404/tests/kraken/driver.html?testName=json-parse-financial) 02:06:35 INFO - PROCESS | 14008 | RSS: Main: 210821120 02:06:35 INFO - PROCESS | 14008 | 02:06:36 INFO - PROCESS | 14008 | Cycle 1(1): loaded http://localhost:46404/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46404/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:06:37 INFO - PROCESS | 14008 | RSS: Main: 173219840 02:06:37 INFO - PROCESS | 14008 | 02:06:39 INFO - PROCESS | 14008 | Cycle 1(1): loaded http://localhost:46404/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46404/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:06:39 INFO - PROCESS | 14008 | RSS: Main: 178765824 02:06:39 INFO - PROCESS | 14008 | 02:06:41 INFO - PROCESS | 14008 | Cycle 1(1): loaded http://localhost:46404/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46404/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:06:42 INFO - PROCESS | 14008 | RSS: Main: 189853696 02:06:42 INFO - PROCESS | 14008 | 02:06:44 INFO - PROCESS | 14008 | Cycle 1(1): loaded http://localhost:46404/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:06:45 INFO - PROCESS | 14008 | RSS: Main: 199380992 02:06:45 INFO - PROCESS | 14008 | 02:06:48 INFO - PROCESS | 14008 | Cycle 1(1): loaded http://localhost:46404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:06:48 INFO - PROCESS | 14008 | RSS: Main: 195354624 02:06:48 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | Cycle 1(1): loaded http://localhost:46404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46404/tests/kraken/driver.html?testName=ai-astar) 02:06:50 INFO - PROCESS | 14008 | RSS: Main: 246857728 02:06:50 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | __start_tp_report 02:06:50 INFO - PROCESS | 14008 | _x_x_mozilla_page_load 02:06:50 INFO - PROCESS | 14008 | _x_x_mozilla_page_load_details 02:06:50 INFO - PROCESS | 14008 | |i|pagename|runs| 02:06:50 INFO - PROCESS | 14008 | |0;ai-astar;102;110;112;111;113;113;112;112;111;111 02:06:50 INFO - PROCESS | 14008 | |1;audio-beat-detection;145;114;116;141;115;115;115;115;140;118 02:06:50 INFO - PROCESS | 14008 | |2;audio-dft;161;162;163;161;163;165;162;164;164;161 02:06:50 INFO - PROCESS | 14008 | |3;audio-fft;74;75;76;115;76;78;77;77;90;75 02:06:50 INFO - PROCESS | 14008 | |4;audio-oscillator;83;82;104;82;82;82;92;82;81;99 02:06:50 INFO - PROCESS | 14008 | |5;imaging-gaussian-blur;114;113;113;113;113;114;113;113;113;113 02:06:50 INFO - PROCESS | 14008 | |6;imaging-darkroom;148;148;148;148;148;147;147;147;147;146 02:06:50 INFO - PROCESS | 14008 | |7;imaging-desaturate;94;94;95;94;94;94;94;94;94;94 02:06:50 INFO - PROCESS | 14008 | |8;json-parse-financial;56;56;58;55;55;56;54;55;55;54 02:06:50 INFO - PROCESS | 14008 | |9;json-stringify-tinderbox;53;53;52;52;52;52;52;52;52;52 02:06:50 INFO - PROCESS | 14008 | |10;stanford-crypto-aes;76;77;80;80;85;79;77;76;84;81 02:06:50 INFO - PROCESS | 14008 | |11;stanford-crypto-ccm;127;125;128;121;120;129;121;118;172;119 02:06:50 INFO - PROCESS | 14008 | |12;stanford-crypto-pbkdf2;158;161;163;161;158;165;162;157;159;165 02:06:50 INFO - PROCESS | 14008 | |13;stanford-crypto-sha256-iterative;60;61;60;63;60;62;60;62;60;58 02:06:50 INFO - PROCESS | 14008 | __end_tp_report 02:06:50 INFO - PROCESS | 14008 | __start_cc_report 02:06:50 INFO - PROCESS | 14008 | _x_x_mozilla_cycle_collect,1699 02:06:50 INFO - PROCESS | 14008 | __end_cc_report 02:06:50 INFO - PROCESS | 14008 | __startTimestamp1493975210680__endTimestamp 02:06:50 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | ------- Summary: start ------- 02:06:50 INFO - PROCESS | 14008 | Number of tests: 14 02:06:50 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.20 (2.9%) stddev-sans-first:1.00 02:06:50 INFO - PROCESS | 14008 | Values: 102.0 110.0 112.0 111.0 113.0 113.0 112.0 112.0 111.0 111.0 02:06:50 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | [#1] audio-beat-detection Cycles:10 Average:123.40 Median:117.00 stddev:12.94 (11.1%) stddev-sans-first:11.11 02:06:50 INFO - PROCESS | 14008 | Values: 145.0 114.0 116.0 141.0 115.0 115.0 115.0 115.0 140.0 118.0 02:06:50 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.43 (0.9%) stddev-sans-first:1.39 02:06:50 INFO - PROCESS | 14008 | Values: 161.0 162.0 163.0 161.0 163.0 165.0 162.0 164.0 164.0 161.0 02:06:50 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.50 stddev:12.68 (16.6%) stddev-sans-first:13.18 02:06:50 INFO - PROCESS | 14008 | Values: 74.0 75.0 76.0 115.0 76.0 78.0 77.0 77.0 90.0 75.0 02:06:50 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | [#4] audio-oscillator Cycles:10 Average:86.90 Median:82.00 stddev:8.40 (10.2%) stddev-sans-first:8.79 02:06:50 INFO - PROCESS | 14008 | Values: 83.0 82.0 104.0 82.0 82.0 82.0 92.0 82.0 81.0 99.0 02:06:50 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 02:06:50 INFO - PROCESS | 14008 | Values: 114.0 113.0 113.0 113.0 113.0 114.0 113.0 113.0 113.0 113.0 02:06:50 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 02:06:50 INFO - PROCESS | 14008 | Values: 148.0 148.0 148.0 148.0 148.0 147.0 147.0 147.0 147.0 146.0 02:06:50 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:06:50 INFO - PROCESS | 14008 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 02:06:50 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:1.17 (2.1%) stddev-sans-first:1.22 02:06:50 INFO - PROCESS | 14008 | Values: 56.0 56.0 58.0 55.0 55.0 56.0 54.0 55.0 55.0 54.0 02:06:50 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | [#9] json-stringify-tinderbox Cycles:10 Average:52.20 Median:52.00 stddev:0.42 (0.8%) stddev-sans-first:0.33 02:06:50 INFO - PROCESS | 14008 | Values: 53.0 53.0 52.0 52.0 52.0 52.0 52.0 52.0 52.0 52.0 02:06:50 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:80.00 stddev:3.17 (4.0%) stddev-sans-first:3.10 02:06:50 INFO - PROCESS | 14008 | Values: 76.0 77.0 80.0 80.0 85.0 79.0 77.0 76.0 84.0 81.0 02:06:50 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:126.00 stddev:15.95 (12.7%) stddev-sans-first:16.91 02:06:50 INFO - PROCESS | 14008 | Values: 127.0 125.0 128.0 121.0 120.0 129.0 121.0 118.0 172.0 119.0 02:06:50 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.50 stddev:2.88 (1.8%) stddev-sans-first:2.86 02:06:50 INFO - PROCESS | 14008 | Values: 158.0 161.0 163.0 161.0 158.0 165.0 162.0 157.0 159.0 165.0 02:06:50 INFO - PROCESS | 14008 | 02:06:50 INFO - PROCESS | 14008 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.60 Median:60.50 stddev:1.43 (2.4%) stddev-sans-first:1.50 02:06:50 INFO - PROCESS | 14008 | Values: 60.0 61.0 60.0 63.0 60.0 62.0 60.0 62.0 60.0 58.0 02:06:50 INFO - PROCESS | 14008 | -------- Summary: end -------- 02:06:50 INFO - PROCESS | 14008 | 02:06:51 INFO - TEST-INFO | 14008: exit 0 02:06:51 INFO - TEST-OK | kraken | took 60403ms 02:06:51 INFO - SUITE-END | took 1175s 02:06:51 INFO - Completed test suite (00:19:35) 02:06:51 INFO - javascript benchmark 02:06:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7894.154649797662, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3403.693667569918, 3412.829358532073, 3437.776544524606, 3438.759286849918, 3494.8602055917763, 5670.234518340023, 5755.079187330028, 5769.596128271022, 5773.855653608652, 5781.797637082703, 5755.165501002352, 5787.47912687858, 5788.82633520994, 5794.942050579493, 5798.043322851735, 5153.896922061566, 5184.585233181355, 5206.531412172903, 5207.401148867891, 5244.449332820056, 4970.726610036447, 4975.427825800043, 5249.606279529032, 5256.421793602701, 5260.605454590902, 5100.795968161269, 5118.155504341779, 5191.0, 5191.169412893938, 5216.035033518792, 5217.843464696065, 5218.973905130488, 5228.895422091537, 5232.790688372461, 5248.895022099575, 4960.776765045582, 5090.363704536933, 5157.968406318714, 5196.92204616931, 5207.323048003773, 5525.972370138124, 5591.30108736408, 5671.347795003586, 5695.886082278373, 5697.373288938214, 6154.599951003215, 6188.257409110891, 6197.504199664016, 6202.72087756052, 6211.968940155315, 6223.159873417076, 6225.367251881034, 6249.2813326467585, 6251.843703907393, 6258.718357673915, 5592.0, 5624.3250809902665, 5774.855628609276, 5822.446867547576, 5828.213191219216, 6274.780382686584, 6275.02737075754, 6276.435120839055, 6283.37166283368, 6293.402126797947, 5975.043992961106, 6028.0355143176885, 6030.6080104793045, 6033.5173186145, 6041.335453100155, 5917.763289468373, 5966.522678185822, 6119.938800612026, 6144.723487443076, 6148.385161483816, 6117.431594453911, 6135.723892424851, 6139.263288405331, 6140.907886381708, 6146.569740118149, 5917.733701983421, 5954.315253745788, 5965.403459654, 6055.636661800306, 6125.309396713653, 4629.25931850909, 4688.226442636995, 4707.388039554904, 4716.858494245178, 4717.410323709536, 4185.853495127717, 4194.3918131870705, 4200.1179752252365, 4212.368144778307, 4246.341817018367, 5725.484706376446, 5779.971100144472, 5881.5000724938, 5920.644761314335, 5975.103734439869, 6213.689315534205, 6221.875562488724, 6225.252969643671, 6226.439620434183, 6228.47058000066, 5963.970180149158, 5972.402759723993, 5972.432618901197, 5989.490893274121, 6004.159417681528, 5025.170846810235, 5051.595872330278, 5178.0, 5202.4277329493725, 5245.763940622681, 6490.967545162244, 6506.446952008943, 6513.804585862432, 6515.8696826063215, 6517.641529715816, 6186.969065154645, 6199.783007594712, 6257.217847769029, 6258.7809426671665, 6259.906101408392, 6148.415900489446, 6201.410865967726, 6323.841903952438, 6509.674516274073, 6511.902321465276, 6087.634741915499, 6099.0, 6113.23584551931, 6129.816105516842, 6129.938700612936, 6202.7208775606105, 6229.719662615103, 6231.1276421300145, 6234.096056071753, 6243.157173781481, 5744.798932037359, 5847.239858818326, 6002.969985150046, 6007.459328660441, 6041.758329666764, 5955.315138759098, 6001.4298641628975, 6043.12374705674, 6044.546659000681, 6059.182010428536, 6023.6385816851125, 6028.638281703112, 6039.728212230372, 6044.093385992136, 6044.486218671286, 5816.534677225727, 5850.0, 5859.5019423347785, 5993.220881285405, 6026.0659597762415, 5824.912626310524, 5864.970675146597, 5941.821745347646, 5947.464728174485, 5985.551083668829], "value": 5667.158916971197, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.9921800781995, 835.5154010673809, 853.914608539146, 916.1891725822645, 927.3415874728942, 32000.199995000108, 42864.78567607162, 43866.342004869955, 43968.56031439685, 43993.12013759723, 45426.31860522086, 45567.088658226814, 45579.772101139446, 45626.0, 45652.0, 7725.420593455485, 7893.921060789405, 9057.00372958974, 9178.586963586622, 9189.954050229773, 10580.78838423231, 10805.081568066724, 10810.081143102845, 10827.025567698905, 11054.834177487344, 10840.457977101152, 10919.454027298643, 10923.945380273088, 10928.726781830439, 10929.0, 10787.137029037658, 10809.729756756105, 10811.027007569277, 10813.83779243312, 10837.83743243852, 10747.301425407324, 10796.352218866814, 10807.513661885234, 10811.83782243267, 10817.891821081766, 40935.7953210232, 41023.384649230284, 41136.79431602853, 41203.0, 41241.58758412408, 4156.958430415687, 4169.10364271683, 4202.411662367271, 4274.102438487921, 4312.029793296515, 29775.851120744475, 30181.245468863235, 30212.24469388261, 30728.078157655305, 31622.525662115087, 3973.543042550115, 4062.634362907323, 4069.104796944667, 4090.059286364123, 4168.124693814302, 239380.0, 239936.0, 240777.0, 242180.99999999822, 242803.0, 53325.0, 53827.0, 53942.46057539453, 54032.459675402744, 54183.0, 56375.71812140913, 56531.15203271954, 56595.0, 56602.15096773551, 56658.716706416206, 16523.0, 16837.410690626013, 16843.74734378985, 16866.156692165343, 16866.409675661293, 12151.210171338835, 12323.322217277957, 12421.813672794735, 14936.850631493764, 14951.0, 13249.801252981213, 13450.192988420726, 13457.932710336581, 13527.66180845467, 13592.25242611646, 5287.814926477555, 5353.785848566092, 5421.674699518042, 5455.236266922634, 5513.917291240635, 982.7543114221445, 1002.1832206751474, 1005.4269066631949, 1021.2442792333619, 1023.9283250172416, 27127.728722712916, 28179.295517612223, 28592.285192870346, 28665.856670716512, 28942.13173604795, 1056.8309070548676, 1062.8193207154802, 1077.1275267033727, 1081.34578579958, 1084.6691759013577, 14010.159390436607, 15120.168390738396, 15141.0, 15206.923965380101, 15319.157446340558, 318776.0, 319907.0, 320479.0, 321138.0, 321621.0, 56049.71975140098, 56069.43930560724, 56151.438485615436, 56359.71820140873, 56506.43493565094, 1467.7912430419385, 1498.0711958585746, 1524.1388615432245, 1528.1366028194257, 1551.6819052094293, 25830.483390332465, 27176.0, 27622.447551049267, 27704.445911082068, 27834.44331113407, 43017.139657206055, 43102.0, 43107.78446107749, 43130.78434607932, 43229.351559726, 288386.0, 288848.0, 288940.0, 289397.0, 291115.0, 29241.0, 29760.10719678413, 34887.825560872036, 35308.47037294391, 35884.461733074546, 43153.56846431496, 43406.0, 43693.78153109214, 44460.22159113599, 44568.55431445644, 33056.83471582723, 33658.66341336555, 33664.326713466085, 33892.0, 33945.830270849474, 33493.83253083817, 33511.16222094467, 33526.32947340991, 33693.83153084219, 34573.48139777855, 38564.22871542609, 39119.0, 39167.41248881212, 39244.215115696956, 39446.40830387604, 32033.839830800698, 32257.51613725843, 32315.838420807744, 32479.18802029968, 32826.67173328236, 25169.87415062913, 25663.0, 25677.61483577785, 25946.481070378108, 26446.735532645198], "value": 19025.039326717862, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.97094688845243, 461.1860066981778, 465.17663735188717, 471.65333479892297, 482.7031375703942, 19776.90111549442, 20998.580028399443, 21106.15575376985, 21250.362489125313, 21429.571408571857, 20878.373648790523, 21374.786252137474, 21501.892490537564, 21835.563288734214, 22437.43906402341, 6472.7087281072345, 6763.086983257246, 6826.283240259776, 7204.783856484288, 7470.58911759853, 7313.926860731378, 7526.322630963212, 7566.659500322498, 7569.772906812805, 7577.545347279153, 7436.888446673304, 7454.5899975501325, 7499.925000750004, 7505.474616776828, 7514.248575142469, 7243.420526357879, 7461.253874612523, 7469.551826890377, 7501.399888008947, 7520.059992500937, 7181.245969173266, 7295.708171673126, 7332.19345871959, 7334.3032411920785, 7396.630168491554, 24911.377215569573, 25089.749102508922, 25101.121460748967, 25424.98300067995, 25426.0, 3009.365883617382, 3117.173948903542, 3199.2001999500126, 3264.9183770405693, 3284.720798732111, 15290.0, 16199.1090490023, 16418.753718694228, 16602.1698915055, 16816.74774878378, 2291.6906217660735, 2330.7086614173227, 2375.2992867104244, 2389.0802041214083, 2416.1181168873236, 85362.57318713429, 96011.51994239984, 99665.0, 99751.01244937797, 117853.41073294665, 20652.0, 20811.68782468264, 21558.029888655048, 21638.891805541185, 22238.777612223996, 41846.790766045975, 42372.57627423748, 42558.36162457566, 42662.0, 42795.35806962898, 11664.825027624593, 11770.0, 11817.88182118185, 11900.821487677691, 12024.75950481003, 9376.249900007982, 9457.668981585612, 9466.242700583936, 9607.711768646952, 9666.903330966741, 11103.278286911325, 11221.5312631221, 11367.1812509998, 11431.428428578538, 11569.710757230969, 4243.448351714257, 4259.765712885759, 4328.0, 4375.146846364928, 4439.66702497314, 929.163752622645, 938.0385105267155, 951.3007939164709, 972.1056627902346, 982.577491678585, 20115.59768804645, 21378.89310553437, 21506.0, 21517.46206344854, 21806.781932180475, 968.5593055159885, 968.8595153702673, 970.5632465390603, 981.097390400833, 988.1748739802202, 10757.83863242052, 11572.611286645488, 11620.128490363257, 11657.300561966309, 11728.589499367481, 675732.0, 675799.0, 684795.0, 685523.0, 773093.0, 76997.0, 105059.0, 112371.43814280877, 113208.43395782968, 116124.0, 1137.1641843245209, 1170.8419363386004, 1176.2472017908544, 1183.976320473603, 1188.6493484421944, 18109.728354074436, 18336.724949125506, 18441.262349506407, 18516.16677249554, 19026.334078307194, 49893.75053124711, 50016.749916250184, 50553.74723126508, 51232.48767512277, 51635.22547161871, 62555.37444625496, 63524.68237658782, 63672.68163659337, 65273.0, 66002.66998664977, 11896.405179741152, 11914.821277680669, 12177.269363837844, 12310.537892421373, 12326.075544334031, 12691.428885699981, 12924.870751292743, 12985.740285194432, 13063.542776002794, 13088.73822523525, 11348.602798901999, 11517.0, 11544.365059921785, 11659.300441973508, 11690.532378704756, 10558.0, 11480.138989575647, 11661.833816618271, 11814.822777658514, 12238.143329966817, 12627.11610187278, 12821.166624169398, 12934.417951192407, 13024.153430027396, 13257.337133143497, 12548.247105173354, 12681.0, 12764.0, 13025.023123265604, 13111.868881311446, 12382.318972456602, 12390.690232744253, 12504.249745015328, 12538.0, 12568.30874301922], "value": 11767.213843911952, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1562.6640272341458, 1582.9920850395747, 1603.3185895994204, 1614.6528496373278, 1622.3997121065208, 10705.625303114382, 11402.942985285063, 11410.08719302456, 11421.657350279494, 11424.71438214045, 11013.229073964825, 11247.943760281207, 11280.548778048867, 11299.096072314216, 11302.321860688344, 2492.0530198524625, 2518.7229404765462, 2524.810639202058, 2531.493701259755, 2531.658226139475, 2316.525112351964, 2417.8791060446997, 2452.3623857796924, 2453.264020793764, 2459.2622213335926, 2405.4467472481338, 2421.382547450398, 2436.7319594844553, 2437.8659173745436, 2442.682451281331, 2327.243645815117, 2363.420961864346, 2368.5026144509675, 2369.0, 2393.6050551658955, 2387.7612238776155, 2394.5210957808335, 2410.770976757205, 2411.409204744831, 2420.8668523231217, 11111.277766945122, 11242.49408776607, 11249.493772780163, 11252.156088293328, 11272.830907536394, 5925.822225333204, 6073.665948372838, 6073.939260607426, 6074.179985701918, 6079.817605471843, 3498.038039539147, 3544.3442963051916, 3552.5381700379044, 3637.763545369569, 3670.7063434925144, 1393.5679939218874, 1418.1420240754298, 1421.8080559124592, 1423.3808293392408, 1496.6034000989746, 16669.08320042397, 17132.486025419257, 17378.65242695139, 17448.651026979518, 17543.561410964827, 4913.754312284443, 4970.105381031449, 4970.304157417964, 4992.2511623256805, 5121.28302037715, 12779.105462617714, 12801.103922725506, 12811.615651530468, 12818.166819156724, 12851.100422970303, 6020.157177995085, 6033.78881739137, 6046.788362407295, 6054.122152287893, 6054.334023257438, 5373.623846330719, 5540.418256083134, 5577.776888924479, 5594.328680558359, 5626.043572592669, 4008.051364177279, 4108.4864391951005, 4126.546079931205, 4147.315692910696, 4157.376393540993, 1094.4363652718855, 1102.7739313440725, 1108.534415545473, 1110.5557776889148, 1126.318577260762, 1058.1059005140644, 1069.4706120470416, 1070.7430216747925, 1073.3667136389568, 1084.6258040975852, 7248.347648711536, 7278.526895751759, 7353.485256032133, 7374.557526548424, 7467.215942326086, 1021.4024795494719, 1035.2701345551368, 1038.901304376098, 1063.8138325792954, 1083.312096818526, 4875.293082503017, 4895.04546613407, 4930.1865192243595, 4939.677781940802, 5277.788888444496, 14824.925875370554, 15243.542693719206, 15249.085054896741, 15269.236538173269, 15282.617934551725, 12521.686957826127, 14842.257887105601, 14849.554513364616, 14958.925205374122, 15004.324805383783, 8474.74575762728, 9373.343865929319, 10678.252522323362, 10823.404712740874, 10886.07468365182, 7225.710971561079, 7284.927150728425, 7334.193238743841, 7596.658150383357, 7648.464607477646, 13156.671083222996, 13169.802452963022, 13365.599032029055, 13605.795913061114, 13672.726545469233, 13291.534796282083, 13307.26810025458, 13316.40076196554, 13347.66630834237, 13382.063255572406, 9630.0, 9743.707688769347, 9782.217422606032, 9810.215182785503, 9865.950670246602, 10650.8402373966, 10715.732106697395, 10789.838152427878, 10825.621103261348, 10837.187210959051, 8940.284777217938, 9043.23132533742, 9128.0, 9300.953495232481, 9411.341206115507, 8601.311895048506, 9104.271658267455, 9259.305552083486, 9309.162175404246, 9761.170300524534, 8211.425200235926, 8589.055203927437, 8602.39783215169, 8665.046844847187, 8844.380893337404, 6097.96334623124, 6130.141780150693, 6130.938690613037, 6269.341719119427, 6289.591176573508, 6333.778317758856, 6479.1901012373455, 6483.286838447672, 6619.371159739817, 6653.234877989094], "value": 5468.954580765285, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.4802371048046, 444.3224083273008, 447.2106731618692, 448.4103404023709, 453.68922288232585, 5163.974180129104, 5240.37115546135, 5267.710275934827, 5297.44376840432, 5316.4911158635305, 4974.2538619207135, 5155.762616971928, 5179.8446046618565, 5210.2445145453985, 5225.738713064351, 4284.314509678452, 4303.35449682547, 4306.61240488356, 4308.18144552534, 4327.285997810358, 4285.9571404286025, 4286.542575524321, 4293.35599660052, 4293.656507479394, 4334.219840428722, 4325.286327755916, 4336.073150623332, 4345.3047512398025, 4363.52001279859, 4376.89057773555, 4172.624463798257, 4293.205756934977, 4320.524742278347, 4329.220740266751, 4344.73931564104, 4061.360115924643, 4065.410515475269, 4070.9185816283803, 4080.5307389650275, 4100.138970816132, 5041.218611115283, 5050.949490505084, 5066.594672426197, 5120.92318615221, 5183.403908550489, 5000.299958005882, 5096.388433388017, 5103.897922041539, 5117.46266642001, 5139.434662187194, 5487.286652735159, 5490.121580547093, 5498.945010549924, 5502.532284755801, 5516.282883225195, 4570.7029043112425, 4574.817007319703, 4585.770711464447, 4620.445546534437, 4637.860864174047, 5408.972955135238, 5497.422770609069, 5560.4161563036105, 5583.8604034899045, 5671.376148623648, 4657.580817726421, 4680.251159814414, 4687.718736875799, 4715.434147902205, 4739.056986635463, 4787.497312782178, 4793.664443488922, 4796.784144713496, 4801.351817504662, 4821.783019764119, 4748.715077095385, 4861.149298872683, 5047.772850221675, 5057.544820966131, 5084.593232541388, 5448.809291674773, 5472.20653005312, 5484.451554844483, 5507.586930980193, 5552.583556233218, 1657.1548510259854, 1659.7800616546829, 1665.84174503422, 1668.215938508899, 1670.5322509697305, 1209.9334536600572, 1265.1839563481503, 1274.1463219642862, 1285.6978610026636, 1299.5516546791341, 5120.0, 5356.973215133899, 5372.946270537323, 5390.622656414013, 5413.431589683105, 5602.495775380154, 5626.2685850839125, 5626.606137570331, 5630.746616402272, 5676.914846277309, 5404.135338345845, 5432.320959880015, 5435.320584926884, 5484.396716361277, 5491.697956612425, 2910.2538476913683, 2910.4179164167253, 2966.5908693370475, 2993.625796775403, 3004.602859670264, 5844.1818145459665, 5865.736041878125, 5891.941080589225, 5913.793017244376, 5956.404359564009, 5646.830595082154, 5674.985380190055, 5683.295011496534, 5692.800751973744, 5745.626534275259, 5515.706158792976, 5798.6810725410505, 5816.476517113396, 5834.737436815353, 5838.63535268217, 5606.523445507014, 5628.690422026828, 5633.38032816398, 5640.887182256414, 5677.3471050829685, 5288.629795914403, 5480.479354461319, 5590.44095590454, 5591.651506367254, 5627.606067575231, 5577.972110139423, 5687.544996400361, 5710.8001219957105, 5857.238558987305, 5878.002957988609, 4679.298105284234, 4739.431268247832, 4739.549742774431, 4745.240761478147, 4748.07702880334, 5400.648957817729, 5574.216250799705, 5689.231953686365, 5763.193152958673, 5773.3072031356505, 5465.590080744039, 5509.118541033416, 5578.63738856973, 5580.274564306615, 5601.243832082617, 5585.69278689676, 5600.4959553640365, 5603.719814009201, 5607.439256074523, 5615.241942337732, 5305.65513241638, 5550.555955523468, 5583.497485226349, 5609.382967873449, 5629.183768353648, 5462.9726851365485, 5485.259489968803, 5535.6955367455175, 5547.2233887256625, 5569.637973531708, 5176.689398636094, 5459.481349271813, 5476.67139971603, 5503.972480137573, 5532.723363831873], "value": 4427.431631071603, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.7067055859885, 883.2933653077537, 887.9600417981194, 913.3195769151982, 927.4064598656861, 16438.424655137074, 17390.565235869093, 17396.913015434937, 17410.47768566945, 17414.12929353532, 16772.329106835743, 17227.82772172281, 17281.567960800956, 17348.0, 17365.7395139073, 870.0733718589713, 886.4902680958443, 891.4606662968907, 913.9314551408638, 919.7424721078108, 886.352962337494, 888.4802390601474, 888.8266787976347, 889.1419779912384, 889.253027456936, 946.9857952130724, 953.6280850468323, 955.8327292723781, 955.9904400956005, 957.0764212534903, 944.6599224279323, 947.0245646983584, 947.5167664491124, 947.663579429303, 947.8862536495595, 692.5533031194901, 692.6952141057968, 697.4281089506607, 697.5779653309776, 698.3993765361785, 16195.514134575982, 16383.672326553522, 16444.260008299654, 17043.233054512577, 17098.401555945606, 15589.376424942988, 15765.684686306324, 15826.0, 15918.840811591852, 16018.519444416686, 12837.1014029018, 13188.736225275537, 13296.534621288209, 13476.056676032682, 13534.390952407068, 3879.670228030621, 3925.7840818755244, 3958.3072962231495, 4040.0303927057294, 4143.150654115899, 85861.57069214676, 86112.56943715242, 87047.0, 88660.99999999936, 89363.10636893613, 11941.402929853473, 12298.508059677513, 12355.135140540257, 12591.559295424617, 12617.684557886127, 21397.78602213989, 22111.557768844534, 23189.88405057964, 23457.296281111594, 23545.058197672242, 8812.955935220283, 8874.822503549893, 9083.68207112748, 9178.449293042439, 9257.074292570689, 4937.185364414903, 5193.610479214074, 5217.3999990000875, 5277.393099793496, 5364.4099149094345, 3773.9245215095543, 3849.3840985442193, 3902.765834049966, 3903.5510916244993, 3930.3514920038447, 642.2934771751037, 644.9774257901045, 651.3226244705548, 659.7558903205845, 660.5607271164718, 799.7400844725488, 809.3242142810701, 819.9098099209082, 832.7085520067927, 837.6272558711437, 11121.944390277997, 11384.715382115513, 11478.311301321948, 11714.531418743325, 11942.164048516694, 813.8616435205911, 816.9787765293383, 825.6490991328661, 826.8511667899716, 827.0736774812249, 5286.233496143038, 5316.6012549058205, 5321.414644389114, 5362.91955620666, 5363.410024897258, 81745.18254817494, 85029.0, 85464.0, 86791.0, 87258.12741872628, 45935.0, 50126.49620511391, 66382.66808665925, 74543.0, 76449.61775191089, 61267.0, 62283.065754013725, 62304.376956230764, 63001.369986300466, 63853.36146638474, 10972.286801357886, 11361.488733006869, 11433.085353171893, 11574.305541667527, 11886.524539018343, 42273.365899512144, 43342.133157336044, 43346.566534334255, 43371.56628433801, 44231.0, 51137.48862511476, 51376.0, 51669.22496162485, 52028.739856300475, 52725.209121862434, 13188.538401155913, 13262.734745304846, 13298.867011329763, 13355.666108347368, 13521.86478135206, 16272.593185170466, 16568.17159142014, 16588.917055414644, 17620.471385858444, 17639.911800440917, 15098.849011510183, 15194.544163675107, 15719.292631831824, 15855.920720396323, 15881.285342159861, 14334.0, 14690.0, 14754.409823606935, 14777.187254701095, 14917.254137292875, 13989.370478328703, 14025.114416192, 14078.788818167532, 14103.929480352532, 14126.717465650834, 10289.639862605072, 10398.480075996322, 10588.205884558534, 10836.783264334827, 10915.126789856633, 12564.183328083645, 12575.119741617998, 12644.0, 12713.93643031779, 12845.871541284841], "value": 7877.240314849341, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1456.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 112.0, 111.0, 113.0, 113.0, 112.0, 112.0, 111.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 114.0, 116.0, 141.0, 115.0, 115.0, 115.0, 115.0, 140.0, 118.0], "value": 123.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 161.0, 163.0, 165.0, 162.0, 164.0, 164.0, 161.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 115.0, 76.0, 78.0, 77.0, 77.0, 90.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 104.0, 82.0, 82.0, 82.0, 92.0, 82.0, 81.0, 99.0], "value": 86.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 58.0, 55.0, 55.0, 56.0, 54.0, 55.0, 55.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 80.0, 80.0, 85.0, 79.0, 77.0, 76.0, 84.0, 81.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 125.0, 128.0, 121.0, 120.0, 129.0, 121.0, 118.0, 172.0, 119.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 163.0, 161.0, 158.0, 165.0, 162.0, 157.0, 159.0, 165.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 63.0, 60.0, 62.0, 60.0, 62.0, 60.0, 58.0], "value": 60.6, "unit": "score"}]}]} 02:06:51 INFO - Return code: 0 02:06:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:06:52 ERROR - # TBPL SUCCESS # 02:06:52 INFO - Running post-action listener: _resource_record_post_action 02:06:52 INFO - [mozharness: 2017-05-05 09:06:52.012379Z] Finished run-tests step (success) 02:06:52 INFO - Running post-run listener: _resource_record_post_run 02:06:52 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 274432; Write bytes: 364974080; Read time: 184; Write time: 285092 02:06:52 INFO - TinderboxPrint: CPU usage
13.1% 02:06:52 INFO - TinderboxPrint: I/O read bytes / time
274,432 / 184 02:06:52 INFO - TinderboxPrint: I/O write bytes / time
364,974,080 / 285,092 02:06:52 INFO - TinderboxPrint: CPU idle
8,268.7 (86.8%) 02:06:52 INFO - TinderboxPrint: CPU user
1,203.6 (12.6%) 02:06:52 INFO - TinderboxPrint: Swap in / out
0 / 0 02:06:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110288896; Read time: 44; Write time: 110964 02:06:52 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 270336; Write bytes: 254685184; Read time: 140; Write time: 174128 02:06:52 INFO - Running post-run listener: _upload_blobber_files 02:06:52 INFO - Blob upload gear active. 02:06:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:06:52 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:06:52 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:06:52 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:06:53 INFO - (blobuploader) - INFO - Open directory for files ... 02:06:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:06:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:06:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:06:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:06:53 INFO - (blobuploader) - INFO - Done attempting. 02:06:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:06:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:06:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:06:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:06:57 INFO - (blobuploader) - INFO - Done attempting. 02:06:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:06:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:06:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:06:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:06:57 INFO - (blobuploader) - INFO - Done attempting. 02:06:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:06:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:06:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:06:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:06:58 INFO - (blobuploader) - INFO - Done attempting. 02:06:58 INFO - (blobuploader) - INFO - Iteration through files over. 02:06:58 INFO - Return code: 0 02:06:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:06:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:06:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/eac796531dd2259efcfd52f16be14ae67361417c7da1adb992154b6c905f2e6ca4983e76af29034c4c23d93e5559a7a8817fecae2b50185b1c5efb1b7b82d4c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0ce81ca0e0d24038ca6e268b483adb9e89fda5c0d0d533d9da434d41af28a46a1959743245d01db7e63f2a2e3ce51149313b0a2134207e84410242f5fec1e82d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6f5e5fb25ae15692cac727dc0fce637b8358158c9714dd2c6b67e58ac787db1669d13ec720422009a28df3e337450cbcff6b2c803fe5e4c94810738d98957d70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/e1c79d999fbc082650e2c0b4738c795a8f2f86c41c27a9a1688ebff487d627bab8ddb1eaf28988c329dac917cb86d0d6a85561217bfb005a8948312c7582b6bc"} 02:06:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:06:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:06:58 INFO - Contents: 02:06:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/eac796531dd2259efcfd52f16be14ae67361417c7da1adb992154b6c905f2e6ca4983e76af29034c4c23d93e5559a7a8817fecae2b50185b1c5efb1b7b82d4c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0ce81ca0e0d24038ca6e268b483adb9e89fda5c0d0d533d9da434d41af28a46a1959743245d01db7e63f2a2e3ce51149313b0a2134207e84410242f5fec1e82d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6f5e5fb25ae15692cac727dc0fce637b8358158c9714dd2c6b67e58ac787db1669d13ec720422009a28df3e337450cbcff6b2c803fe5e4c94810738d98957d70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/e1c79d999fbc082650e2c0b4738c795a8f2f86c41c27a9a1688ebff487d627bab8ddb1eaf28988c329dac917cb86d0d6a85561217bfb005a8948312c7582b6bc"} 02:06:58 INFO - Running post-run listener: copy_logs_to_upload_dir 02:06:58 INFO - Copying logs to upload dir... 02:06:58 INFO - mkdir: /builds/slave/test/build/upload/logs 02:06:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.031594 ========= master_lag: -0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-05 02:06:57.727850) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 02:06:57.736868) ========= 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=232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878 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/eac796531dd2259efcfd52f16be14ae67361417c7da1adb992154b6c905f2e6ca4983e76af29034c4c23d93e5559a7a8817fecae2b50185b1c5efb1b7b82d4c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0ce81ca0e0d24038ca6e268b483adb9e89fda5c0d0d533d9da434d41af28a46a1959743245d01db7e63f2a2e3ce51149313b0a2134207e84410242f5fec1e82d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6f5e5fb25ae15692cac727dc0fce637b8358158c9714dd2c6b67e58ac787db1669d13ec720422009a28df3e337450cbcff6b2c803fe5e4c94810738d98957d70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/e1c79d999fbc082650e2c0b4738c795a8f2f86c41c27a9a1688ebff487d627bab8ddb1eaf28988c329dac917cb86d0d6a85561217bfb005a8948312c7582b6bc"} build_url:https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/Lgk3gZt8T02vdt9-KMA-Jw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/eac796531dd2259efcfd52f16be14ae67361417c7da1adb992154b6c905f2e6ca4983e76af29034c4c23d93e5559a7a8817fecae2b50185b1c5efb1b7b82d4c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0ce81ca0e0d24038ca6e268b483adb9e89fda5c0d0d533d9da434d41af28a46a1959743245d01db7e63f2a2e3ce51149313b0a2134207e84410242f5fec1e82d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/6f5e5fb25ae15692cac727dc0fce637b8358158c9714dd2c6b67e58ac787db1669d13ec720422009a28df3e337450cbcff6b2c803fe5e4c94810738d98957d70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/e1c79d999fbc082650e2c0b4738c795a8f2f86c41c27a9a1688ebff487d627bab8ddb1eaf28988c329dac917cb86d0d6a85561217bfb005a8948312c7582b6bc"}' ========= master_lag: 0.14 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 02:06:57.885780) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 02:06:57.886174) ========= 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=232498196343f89f466a4a9a000001c8-1493955084.639787-1019850878 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 02:06:57.907895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 02:06:57.908224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 02:06:57.908554) ========= ========= Total master_lag: 0.12 =========