builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1478082795.38 results: success (0) buildid: 20161102004003 builduid: c7698b38ab63453181bebe72eba8f1d9 revision: 3c4ab75a8bcb551b4fb73f31b7a4269f05e1a0dc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 03:33:15.379818) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 03:33:15.380271) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 03:33:15.380572) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 03:33:15.399645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 03:33:15.400464) ========= 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=1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-02 03:33:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-11-02 03:33:15 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.069596 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 03:33:15.483905) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 03:33:15.484207) ========= 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=1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014418 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 03:33:15.532906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 03:33:15.533239) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c4ab75a8bcb551b4fb73f31b7a4269f05e1a0dc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c4ab75a8bcb551b4fb73f31b7a4269f05e1a0dc --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=1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-02 03:33:15,911 truncating revision to first 12 chars 2016-11-02 03:33:15,911 Setting DEBUG logging. 2016-11-02 03:33:15,911 attempt 1/10 2016-11-02 03:33:15,911 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3c4ab75a8bcb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-02 03:33:16,216 unpacking tar archive at: mozilla-aurora-3c4ab75a8bcb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695661 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 03:33:16.242288) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 03:33:16.242592) ========= script_repo_revision: 3c4ab75a8bcb551b4fb73f31b7a4269f05e1a0dc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 03:33:16.243002) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 03:33:16.243270) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 03:33:16.252972) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-02 03:33:16.253627) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:33:16 INFO - MultiFileLogger online at 20161102 03:33:16 in /builds/slave/test 03:33:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:33:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:33:16 INFO - {'append_to_log': False, 03:33:16 INFO - 'base_work_dir': '/builds/slave/test', 03:33:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:33:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:33:16 INFO - 'branch': 'Mozilla-Aurora', 03:33:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:33:16 INFO - 'config_files': ('talos/linux_config.py',), 03:33:16 INFO - 'default_actions': ('clobber', 03:33:16 INFO - 'read-buildbot-config', 03:33:16 INFO - 'download-and-extract', 03:33:16 INFO - 'populate-webroot', 03:33:16 INFO - 'create-virtualenv', 03:33:16 INFO - 'install', 03:33:16 INFO - 'run-tests'), 03:33:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:33:16 INFO - 'download_minidump_stackwalk': True, 03:33:16 INFO - 'download_symbols': 'ondemand', 03:33:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:33:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:33:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:33:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:33:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:33:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:33:16 INFO - 'installer_path': 'installer.exe', 03:33:16 INFO - 'log_level': 'info', 03:33:16 INFO - 'log_name': 'talos', 03:33:16 INFO - 'log_to_console': True, 03:33:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:33:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:33:16 INFO - 'opt_config_files': (), 03:33:16 INFO - 'pip_index': False, 03:33:16 INFO - 'sps_profile': False, 03:33:16 INFO - 'sps_profile_interval': 0, 03:33:16 INFO - 'suite': 'dromaeojs', 03:33:16 INFO - 'system_bits': '32', 03:33:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:33:16 INFO - 'title': 'talos-linux64-ix-027', 03:33:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:33:16 INFO - 'use_talos_json': True, 03:33:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:33:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:33:16 INFO - 'work_dir': 'build'} 03:33:16 INFO - [mozharness: 2016-11-02 10:33:16.730295Z] Running clobber step. 03:33:16 INFO - Running pre-action listener: _resource_record_pre_action 03:33:16 INFO - Running main action method: clobber 03:33:16 INFO - rmtree: /builds/slave/test/build 03:33:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:33:17 INFO - Running post-action listener: _resource_record_post_action 03:33:17 INFO - [mozharness: 2016-11-02 10:33:17.192860Z] Finished clobber step (success) 03:33:17 INFO - [mozharness: 2016-11-02 10:33:17.192961Z] Running read-buildbot-config step. 03:33:17 INFO - Running pre-action listener: _resource_record_pre_action 03:33:17 INFO - Running main action method: read_buildbot_config 03:33:17 INFO - Using buildbot properties: 03:33:17 INFO - { 03:33:17 INFO - "project": "", 03:33:17 INFO - "product": "firefox", 03:33:17 INFO - "script_repo_revision": "production", 03:33:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:33:17 INFO - "repository": "", 03:33:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:33:17 INFO - "buildid": "20161102004003", 03:33:17 INFO - "stage_platform": "linux64-pgo", 03:33:17 INFO - "basedir": "/builds/slave/test", 03:33:17 INFO - "nightly_build": "True", 03:33:17 INFO - "buildnumber": 567, 03:33:17 INFO - "slavename": "talos-linux64-ix-027", 03:33:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:33:17 INFO - "platform": "ubuntu64_hw", 03:33:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:33:17 INFO - "branch": "mozilla-aurora", 03:33:17 INFO - "repo_path": "releases/mozilla-aurora", 03:33:17 INFO - "revision": "3c4ab75a8bcb551b4fb73f31b7a4269f05e1a0dc", 03:33:17 INFO - "pgo_build": "True", 03:33:17 INFO - "builduid": "c7698b38ab63453181bebe72eba8f1d9", 03:33:17 INFO - "slavebuilddir": "test" 03:33:17 INFO - } 03:33:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 03:33:17 INFO - Running post-action listener: _resource_record_post_action 03:33:17 INFO - [mozharness: 2016-11-02 10:33:17.195486Z] Finished read-buildbot-config step (success) 03:33:17 INFO - [mozharness: 2016-11-02 10:33:17.195575Z] Running download-and-extract step. 03:33:17 INFO - Running pre-action listener: _resource_record_pre_action 03:33:17 INFO - Running main action method: download_and_extract 03:33:17 INFO - mkdir: /builds/slave/test/build/tests 03:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:17 INFO - trying https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:33:17 INFO - Downloading https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:33:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:33:17 INFO - Downloaded 1361 bytes. 03:33:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:33:17 INFO - Using the following test package requirements: 03:33:17 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:33:17 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:33:17 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:33:17 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:17 INFO - u'jsshell-linux-x86_64.zip'], 03:33:17 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:33:17 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:33:17 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:33:17 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:33:17 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:33:17 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:33:17 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:33:17 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:33:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:33:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:33:17 INFO - Fetch https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:33:18 INFO - Expected file size: 21895931 03:33:22 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:33:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:33:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:33:22 INFO - Fetch https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:33:23 INFO - Expected file size: 21895931 03:33:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 03:33:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:33:28 INFO - Fetch https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:33:28 INFO - Expected file size: 14414089 03:33:29 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')]} 03:33:29 INFO - trying https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:33:29 INFO - Downloading https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:33:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:33:31 INFO - Downloaded 63982787 bytes. 03:33:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:33:31 INFO - mkdir: /builds/slave/test/properties 03:33:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:33:31 INFO - Writing to file /builds/slave/test/properties/build_url 03:33:31 INFO - Contents: 03:33:31 INFO - build_url:https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:33:32 INFO - Running post-action listener: _resource_record_post_action 03:33:32 INFO - Running post-action listener: set_extra_try_arguments 03:33:32 INFO - [mozharness: 2016-11-02 10:33:32.437509Z] Finished download-and-extract step (success) 03:33:32 INFO - [mozharness: 2016-11-02 10:33:32.437740Z] Running populate-webroot step. 03:33:32 INFO - Running pre-action listener: _resource_record_pre_action 03:33:32 INFO - Running main action method: populate_webroot 03:33:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:33:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:33:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:33:32 INFO - '--tppagecycles', 03:33:32 INFO - '7'], 03:33:32 INFO - 'tests': ['tsvgm']}}, 03:33:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:33:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:33:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:33:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:33:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:33:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:33:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:32 INFO - 'talos_options': ['--disable-e10s'], 03:33:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:32 INFO - 'talos_options': ['--disable-e10s'], 03:33:32 INFO - 'tests': ['damp', 'tps']}, 03:33:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:32 INFO - 'tests': ['damp', 'tps']}, 03:33:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:33:32 INFO - 'tests': ['dromaeo_dom']}, 03:33:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:33:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:33:32 INFO - 'tests': ['basic_compositor_video']}, 03:33:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:33:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:33:32 INFO - 'tests': ['a11yr', 03:33:32 INFO - 'ts_paint', 03:33:32 INFO - 'tpaint', 03:33:32 INFO - 'sessionrestore', 03:33:32 INFO - 'sessionrestore_no_auto_restore', 03:33:32 INFO - 'tabpaint']}, 03:33:32 INFO - 'other-e10s': {'tests': ['a11yr', 03:33:32 INFO - 'ts_paint', 03:33:32 INFO - 'tpaint', 03:33:32 INFO - 'sessionrestore', 03:33:32 INFO - 'sessionrestore_no_auto_restore', 03:33:32 INFO - 'tabpaint']}, 03:33:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:33:32 INFO - 'ts_paint', 03:33:32 INFO - 'tpaint', 03:33:32 INFO - 'sessionrestore', 03:33:32 INFO - 'sessionrestore_no_auto_restore', 03:33:32 INFO - 'tabpaint']}, 03:33:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:33:32 INFO - 'ts_paint', 03:33:32 INFO - 'tpaint', 03:33:32 INFO - 'sessionrestore', 03:33:32 INFO - 'sessionrestore_no_auto_restore', 03:33:32 INFO - 'tabpaint']}, 03:33:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:33:32 INFO - 'tests': ['a11yr', 03:33:32 INFO - 'ts_paint', 03:33:32 INFO - 'tpaint', 03:33:32 INFO - 'sessionrestore', 03:33:32 INFO - 'sessionrestore_no_auto_restore', 03:33:32 INFO - 'tabpaint']}, 03:33:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:33:32 INFO - 'tests': ['a11yr', 03:33:32 INFO - 'ts_paint', 03:33:32 INFO - 'tpaint', 03:33:32 INFO - 'sessionrestore', 03:33:32 INFO - 'sessionrestore_no_auto_restore', 03:33:32 INFO - 'tabpaint']}, 03:33:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:33:32 INFO - 'tests': ['tsvgx', 03:33:32 INFO - 'tsvgr_opacity', 03:33:32 INFO - 'tart', 03:33:32 INFO - 'tscrollx', 03:33:32 INFO - 'cart']}, 03:33:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:33:32 INFO - 'tsvgr_opacity', 03:33:32 INFO - 'tart', 03:33:32 INFO - 'tscrollx', 03:33:32 INFO - 'cart']}, 03:33:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:32 INFO - 'talos_options': ['--disable-e10s'], 03:33:32 INFO - 'tests': ['tp5o']}, 03:33:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:32 INFO - 'tests': ['tp5o']}, 03:33:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:32 INFO - 'talos_options': ['--disable-e10s', 03:33:32 INFO - '--xperf_path', 03:33:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:32 INFO - 'tests': ['tp5n']}, 03:33:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:33:32 INFO - 'talos_options': ['--xperf_path', 03:33:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:32 INFO - 'tests': ['tp5n']}}, 03:33:32 INFO - 'talos.zip': {'path': '', 03:33:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:33:32 INFO - Running post-action listener: _resource_record_post_action 03:33:32 INFO - [mozharness: 2016-11-02 10:33:32.458533Z] Finished populate-webroot step (success) 03:33:32 INFO - [mozharness: 2016-11-02 10:33:32.458622Z] Running create-virtualenv step. 03:33:32 INFO - Running pre-action listener: _resource_record_pre_action 03:33:32 INFO - Running main action method: create_virtualenv 03:33:32 INFO - Creating virtualenv /builds/slave/test/build/venv 03:33:32 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 03:33:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:33:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:33:32 INFO - Using real prefix '/usr' 03:33:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:33:33 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:35 INFO - Installing pip.................done. 03:33:35 INFO - Return code: 0 03:33:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:35 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 0x7f3567111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aaf60>, '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 0x21abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ac1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', '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 03:33:35 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 03:33:35 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 03:33:35 INFO - Using env: {'DISPLAY': ':0', 03:33:35 INFO - 'HOME': '/home/cltbld', 03:33:35 INFO - 'LANG': 'en_US.UTF-8', 03:33:35 INFO - 'LANGUAGE': 'en_US:en', 03:33:35 INFO - 'LOGNAME': 'cltbld', 03:33:35 INFO - 'MAIL': '/var/mail/cltbld', 03:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:35 INFO - 'MOZ_NO_REMOTE': '1', 03:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:35 INFO - 'NO_EM_RESTART': '1', 03:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:35 INFO - 'PWD': '/builds/slave/test', 03:33:35 INFO - 'SHELL': '/bin/bash', 03:33:35 INFO - 'SHLVL': '1', 03:33:35 INFO - 'TERM': 'linux', 03:33:35 INFO - 'TMOUT': '86400', 03:33:35 INFO - 'USER': 'cltbld', 03:33:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', 03:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:35 INFO - '_': '/tools/buildbot/bin/python'} 03:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:35 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 03:33:35 INFO - Cleaning up... 03:33:35 INFO - Return code: 0 03:33:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:35 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 0x7f3567111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aaf60>, '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 0x21abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ac1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', '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 03:33:35 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 03:33:35 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 03:33:35 INFO - Using env: {'DISPLAY': ':0', 03:33:35 INFO - 'HOME': '/home/cltbld', 03:33:35 INFO - 'LANG': 'en_US.UTF-8', 03:33:35 INFO - 'LANGUAGE': 'en_US:en', 03:33:35 INFO - 'LOGNAME': 'cltbld', 03:33:35 INFO - 'MAIL': '/var/mail/cltbld', 03:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:35 INFO - 'MOZ_NO_REMOTE': '1', 03:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:35 INFO - 'NO_EM_RESTART': '1', 03:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:35 INFO - 'PWD': '/builds/slave/test', 03:33:35 INFO - 'SHELL': '/bin/bash', 03:33:35 INFO - 'SHLVL': '1', 03:33:35 INFO - 'TERM': 'linux', 03:33:35 INFO - 'TMOUT': '86400', 03:33:35 INFO - 'USER': 'cltbld', 03:33:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', 03:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:35 INFO - '_': '/tools/buildbot/bin/python'} 03:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:35 INFO - Downloading/unpacking psutil>=3.1.1 03:33:35 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 03:33:35 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 03:33:35 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 03:33:35 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 03:33:35 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 03:33:35 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 03:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:37 INFO - Installing collected packages: psutil 03:33:37 INFO - Running setup.py install for psutil 03:33:37 INFO - building 'psutil._psutil_linux' extension 03:33:37 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 03:33:37 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 03:33:37 INFO - building 'psutil._psutil_posix' extension 03:33:37 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 03:33:37 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 03:33:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:37 INFO - Successfully installed psutil 03:33:37 INFO - Cleaning up... 03:33:38 INFO - Return code: 0 03:33:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:38 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 0x7f3567111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aaf60>, '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 0x21abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ac1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', '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 03:33:38 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 03:33:38 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 03:33:38 INFO - Using env: {'DISPLAY': ':0', 03:33:38 INFO - 'HOME': '/home/cltbld', 03:33:38 INFO - 'LANG': 'en_US.UTF-8', 03:33:38 INFO - 'LANGUAGE': 'en_US:en', 03:33:38 INFO - 'LOGNAME': 'cltbld', 03:33:38 INFO - 'MAIL': '/var/mail/cltbld', 03:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:38 INFO - 'MOZ_NO_REMOTE': '1', 03:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:38 INFO - 'NO_EM_RESTART': '1', 03:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:38 INFO - 'PWD': '/builds/slave/test', 03:33:38 INFO - 'SHELL': '/bin/bash', 03:33:38 INFO - 'SHLVL': '1', 03:33:38 INFO - 'TERM': 'linux', 03:33:38 INFO - 'TMOUT': '86400', 03:33:38 INFO - 'USER': 'cltbld', 03:33:38 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', 03:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:38 INFO - '_': '/tools/buildbot/bin/python'} 03:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:33:38 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 03:33:38 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 03:33:38 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 03:33:38 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 03:33:38 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 03:33:38 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 03:33:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:33:40 INFO - Installing collected packages: mozsystemmonitor 03:33:40 INFO - Running setup.py install for mozsystemmonitor 03:33:40 INFO - Successfully installed mozsystemmonitor 03:33:40 INFO - Cleaning up... 03:33:40 INFO - Return code: 0 03:33:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:33:40 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')]} 03:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:40 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')]} 03:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:40 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 0x7f3567111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aaf60>, '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 0x21abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ac1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', '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 03:33:40 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 03:33:40 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 03:33:40 INFO - Using env: {'DISPLAY': ':0', 03:33:40 INFO - 'HOME': '/home/cltbld', 03:33:40 INFO - 'LANG': 'en_US.UTF-8', 03:33:40 INFO - 'LANGUAGE': 'en_US:en', 03:33:40 INFO - 'LOGNAME': 'cltbld', 03:33:40 INFO - 'MAIL': '/var/mail/cltbld', 03:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:40 INFO - 'MOZ_NO_REMOTE': '1', 03:33:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:40 INFO - 'NO_EM_RESTART': '1', 03:33:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:40 INFO - 'PWD': '/builds/slave/test', 03:33:40 INFO - 'SHELL': '/bin/bash', 03:33:40 INFO - 'SHLVL': '1', 03:33:40 INFO - 'TERM': 'linux', 03:33:40 INFO - 'TMOUT': '86400', 03:33:40 INFO - 'USER': 'cltbld', 03:33:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', 03:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:40 INFO - '_': '/tools/buildbot/bin/python'} 03:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:40 INFO - Downloading/unpacking jsonschema==2.5.1 03:33:40 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 03:33:40 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 03:33:40 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 03:33:40 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 03:33:40 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 03:33:40 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 03:33:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:33:42 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 03:33:42 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 03:33:42 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 03:33:42 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 03:33:42 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 03:33:42 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 03:33:42 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:42 INFO - warning: no files found matching '*.txt' 03:33:42 INFO - no previously-included directories found matching 'build' 03:33:42 INFO - no previously-included directories found matching 'dist' 03:33:42 INFO - no previously-included directories found matching '.git*' 03:33:42 INFO - Installing collected packages: jsonschema, functools32 03:33:43 INFO - Running setup.py install for functools32 03:33:43 INFO - warning: no files found matching '*.txt' 03:33:43 INFO - no previously-included directories found matching 'build' 03:33:43 INFO - no previously-included directories found matching 'dist' 03:33:43 INFO - no previously-included directories found matching '.git*' 03:33:43 INFO - Successfully installed jsonschema functools32 03:33:43 INFO - Cleaning up... 03:33:43 INFO - Return code: 0 03:33:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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', '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 0x7f3567111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aaf60>, '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 0x21abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ac1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', '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 03:33: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:33: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 functools32==3.2.3-2 03:33:43 INFO - Using env: {'DISPLAY': ':0', 03:33:43 INFO - 'HOME': '/home/cltbld', 03:33:43 INFO - 'LANG': 'en_US.UTF-8', 03:33:43 INFO - 'LANGUAGE': 'en_US:en', 03:33:43 INFO - 'LOGNAME': 'cltbld', 03:33:43 INFO - 'MAIL': '/var/mail/cltbld', 03:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:43 INFO - 'MOZ_NO_REMOTE': '1', 03:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:43 INFO - 'NO_EM_RESTART': '1', 03:33:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:43 INFO - 'PWD': '/builds/slave/test', 03:33:43 INFO - 'SHELL': '/bin/bash', 03:33:43 INFO - 'SHLVL': '1', 03:33:43 INFO - 'TERM': 'linux', 03:33:43 INFO - 'TMOUT': '86400', 03:33:43 INFO - 'USER': 'cltbld', 03:33:43 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', 03:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:43 INFO - '_': '/tools/buildbot/bin/python'} 03:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:33:43 INFO - Cleaning up... 03:33:43 INFO - Return code: 0 03:33:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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', '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 0x7f3567111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aaf60>, '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 0x21abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ac1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', '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 03:33: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:33: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 blobuploader==1.2.4 03:33:43 INFO - Using env: {'DISPLAY': ':0', 03:33:43 INFO - 'HOME': '/home/cltbld', 03:33:43 INFO - 'LANG': 'en_US.UTF-8', 03:33:43 INFO - 'LANGUAGE': 'en_US:en', 03:33:43 INFO - 'LOGNAME': 'cltbld', 03:33:43 INFO - 'MAIL': '/var/mail/cltbld', 03:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:43 INFO - 'MOZ_NO_REMOTE': '1', 03:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:43 INFO - 'NO_EM_RESTART': '1', 03:33:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:43 INFO - 'PWD': '/builds/slave/test', 03:33:43 INFO - 'SHELL': '/bin/bash', 03:33:43 INFO - 'SHLVL': '1', 03:33:43 INFO - 'TERM': 'linux', 03:33:43 INFO - 'TMOUT': '86400', 03:33:43 INFO - 'USER': 'cltbld', 03:33:43 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', 03:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:43 INFO - '_': '/tools/buildbot/bin/python'} 03:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:43 INFO - Downloading/unpacking blobuploader==1.2.4 03:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:45 INFO - Downloading blobuploader-1.2.4.tar.gz 03:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:33:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:33:45 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 03:33:45 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 03:33:45 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 03:33:45 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 03:33:45 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 03:33:45 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 03:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:33:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:46 INFO - Downloading docopt-0.6.1.tar.gz 03:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:33:46 INFO - Installing collected packages: blobuploader, requests, docopt 03:33:46 INFO - Running setup.py install for blobuploader 03:33:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:33:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:33:46 INFO - Running setup.py install for requests 03:33:46 INFO - Running setup.py install for docopt 03:33:46 INFO - Successfully installed blobuploader requests docopt 03:33:46 INFO - Cleaning up... 03:33:46 INFO - Return code: 0 03:33:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:46 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')]} 03:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:46 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')]} 03:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:46 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 0x7f3567111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aaf60>, '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 0x21abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ac1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', '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 03:33:46 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 03:33:46 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 03:33:46 INFO - Using env: {'DISPLAY': ':0', 03:33:46 INFO - 'HOME': '/home/cltbld', 03:33:46 INFO - 'LANG': 'en_US.UTF-8', 03:33:46 INFO - 'LANGUAGE': 'en_US:en', 03:33:46 INFO - 'LOGNAME': 'cltbld', 03:33:46 INFO - 'MAIL': '/var/mail/cltbld', 03:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:46 INFO - 'MOZ_NO_REMOTE': '1', 03:33:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:46 INFO - 'NO_EM_RESTART': '1', 03:33:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:46 INFO - 'PWD': '/builds/slave/test', 03:33:46 INFO - 'SHELL': '/bin/bash', 03:33:46 INFO - 'SHLVL': '1', 03:33:46 INFO - 'TERM': 'linux', 03:33:46 INFO - 'TMOUT': '86400', 03:33:46 INFO - 'USER': 'cltbld', 03:33:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', 03:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:46 INFO - '_': '/tools/buildbot/bin/python'} 03:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:47 INFO - Running setup.py (path:/tmp/pip-20Kpja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:47 INFO - Running setup.py (path:/tmp/pip-F0MJ_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:47 INFO - Running setup.py (path:/tmp/pip-1yl4me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:47 INFO - Running setup.py (path:/tmp/pip-pA_3oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:47 INFO - Running setup.py (path:/tmp/pip-Z_RXMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:47 INFO - Running setup.py (path:/tmp/pip-h69Beh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:47 INFO - Running setup.py (path:/tmp/pip-CGcQzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:47 INFO - Running setup.py (path:/tmp/pip-4uscf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:47 INFO - Running setup.py (path:/tmp/pip-aNkdw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:47 INFO - Running setup.py (path:/tmp/pip-pUY7M9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:47 INFO - Running setup.py (path:/tmp/pip-SZo1nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:47 INFO - Running setup.py (path:/tmp/pip-PmTqYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:48 INFO - Running setup.py (path:/tmp/pip-DTkEAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:48 INFO - Running setup.py (path:/tmp/pip-wEvH0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:48 INFO - Running setup.py (path:/tmp/pip-akHQej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:48 INFO - Running setup.py (path:/tmp/pip-dbKLrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:48 INFO - Running setup.py (path:/tmp/pip-l7zjXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:33:48 INFO - Running setup.py install for manifestparser 03:33:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:33:48 INFO - Running setup.py install for mozcrash 03:33:48 INFO - Running setup.py install for mozdebug 03:33:48 INFO - Running setup.py install for mozdevice 03:33:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:33:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:33:48 INFO - Running setup.py install for mozfile 03:33:48 INFO - Running setup.py install for mozhttpd 03:33:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Running setup.py install for mozinfo 03:33:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Running setup.py install for mozInstall 03:33:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Running setup.py install for mozleak 03:33:49 INFO - Running setup.py install for mozlog 03:33:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Running setup.py install for moznetwork 03:33:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Running setup.py install for mozprocess 03:33:49 INFO - Running setup.py install for mozprofile 03:33:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Running setup.py install for mozrunner 03:33:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:33:49 INFO - Running setup.py install for mozscreenshot 03:33:49 INFO - Running setup.py install for moztest 03:33:50 INFO - Running setup.py install for mozversion 03:33:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:33:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:33:50 INFO - Cleaning up... 03:33:50 INFO - Return code: 0 03:33:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:50 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 0x7f3567111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aaf60>, '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 0x21abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ac1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', '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 03:33:50 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 03:33:50 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 03:33:50 INFO - Using env: {'DISPLAY': ':0', 03:33:50 INFO - 'HOME': '/home/cltbld', 03:33:50 INFO - 'LANG': 'en_US.UTF-8', 03:33:50 INFO - 'LANGUAGE': 'en_US:en', 03:33:50 INFO - 'LOGNAME': 'cltbld', 03:33:50 INFO - 'MAIL': '/var/mail/cltbld', 03:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:50 INFO - 'MOZ_NO_REMOTE': '1', 03:33:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:50 INFO - 'NO_EM_RESTART': '1', 03:33:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:50 INFO - 'PWD': '/builds/slave/test', 03:33:50 INFO - 'SHELL': '/bin/bash', 03:33:50 INFO - 'SHLVL': '1', 03:33:50 INFO - 'TERM': 'linux', 03:33:50 INFO - 'TMOUT': '86400', 03:33:50 INFO - 'USER': 'cltbld', 03:33:50 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', 03:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:50 INFO - '_': '/tools/buildbot/bin/python'} 03:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:50 INFO - Running setup.py (path:/tmp/pip-fC4xlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:50 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)) 03:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:50 INFO - Running setup.py (path:/tmp/pip-43fBf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 03:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:50 INFO - Running setup.py (path:/tmp/pip-pFhL24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:50 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)) 03:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:50 INFO - Running setup.py (path:/tmp/pip-k2ct7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 03:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:50 INFO - Running setup.py (path:/tmp/pip-Tv0hiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:50 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)) 03:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:50 INFO - Running setup.py (path:/tmp/pip-gVP1zT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:50 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)) 03:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:50 INFO - Running setup.py (path:/tmp/pip-Frfohx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:50 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)) 03:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:50 INFO - Running setup.py (path:/tmp/pip-W28JWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:50 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)) 03:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:50 INFO - Running setup.py (path:/tmp/pip-_k6NGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:51 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)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:51 INFO - Running setup.py (path:/tmp/pip-SmBGUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:51 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)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:51 INFO - Running setup.py (path:/tmp/pip-7utqMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:51 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)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:51 INFO - Running setup.py (path:/tmp/pip-_zaSfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:51 INFO - Running setup.py (path:/tmp/pip-gi1tWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:51 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)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:51 INFO - Running setup.py (path:/tmp/pip-5OueGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:51 INFO - Running setup.py (path:/tmp/pip-dwiMHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:51 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)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:51 INFO - Running setup.py (path:/tmp/pip-hn90zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 03:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:51 INFO - Running setup.py (path:/tmp/pip-M3ZJDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:51 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)) 03:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:51 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)) 03:33:51 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:33:51 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:33:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:53 INFO - Downloading blessings-1.6.tar.gz 03:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:33:53 INFO - Installing collected packages: blessings 03:33:53 INFO - Running setup.py install for blessings 03:33:53 INFO - Successfully installed blessings 03:33:53 INFO - Cleaning up... 03:33:53 INFO - Return code: 0 03:33:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:33:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:54 INFO - Reading from file tmpfile_stdout 03:33:54 INFO - Current package versions: 03:33:54 INFO - argparse == 1.2.1 03:33:54 INFO - blessings == 1.6 03:33:54 INFO - blobuploader == 1.2.4 03:33:54 INFO - docopt == 0.6.1 03:33:54 INFO - functools32 == 3.2.3-2 03:33:54 INFO - jsonschema == 2.5.1 03:33:54 INFO - manifestparser == 1.1 03:33:54 INFO - mozInstall == 1.12 03:33:54 INFO - mozcrash == 0.17 03:33:54 INFO - mozdebug == 0.1 03:33:54 INFO - mozdevice == 0.48 03:33:54 INFO - mozfile == 1.2 03:33:54 INFO - mozhttpd == 0.7 03:33:54 INFO - mozinfo == 0.9 03:33:54 INFO - mozleak == 0.1 03:33:54 INFO - mozlog == 3.4 03:33:54 INFO - moznetwork == 0.27 03:33:54 INFO - mozprocess == 0.23 03:33:54 INFO - mozprofile == 0.28 03:33:54 INFO - mozrunner == 6.12 03:33:54 INFO - mozscreenshot == 0.1 03:33:54 INFO - mozsystemmonitor == 0.3 03:33:54 INFO - moztest == 0.7 03:33:54 INFO - mozversion == 1.4 03:33:54 INFO - psutil == 3.1.1 03:33:54 INFO - requests == 1.2.3 03:33:54 INFO - wsgiref == 0.1.2 03:33:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:54 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 0x7f3567111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aaf60>, '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 0x21abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ac1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', '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 03:33:54 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 03:33:54 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 03:33:54 INFO - Using env: {'DISPLAY': ':0', 03:33:54 INFO - 'HOME': '/home/cltbld', 03:33:54 INFO - 'LANG': 'en_US.UTF-8', 03:33:54 INFO - 'LANGUAGE': 'en_US:en', 03:33:54 INFO - 'LOGNAME': 'cltbld', 03:33:54 INFO - 'MAIL': '/var/mail/cltbld', 03:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:54 INFO - 'MOZ_NO_REMOTE': '1', 03:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:54 INFO - 'NO_EM_RESTART': '1', 03:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:54 INFO - 'PWD': '/builds/slave/test', 03:33:54 INFO - 'SHELL': '/bin/bash', 03:33:54 INFO - 'SHLVL': '1', 03:33:54 INFO - 'TERM': 'linux', 03:33:54 INFO - 'TMOUT': '86400', 03:33:54 INFO - 'USER': 'cltbld', 03:33:54 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', 03:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:54 INFO - '_': '/tools/buildbot/bin/python'} 03:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:54 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)) 03:33:54 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)) 03:33:54 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)) 03:33:54 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)) 03:33:54 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)) 03:33:54 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)) 03:33:54 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)) 03:33:54 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)) 03:33:54 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)) 03:33:54 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)) 03:33:54 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)) 03:33:54 INFO - Cleaning up... 03:33:54 INFO - Return code: 0 03:33:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:54 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 0x7f3567111f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21adca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aaf60>, '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 0x21abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ac1d0>, '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': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', '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 03:33:54 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 03:33:54 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 03:33:54 INFO - Using env: {'DISPLAY': ':0', 03:33:54 INFO - 'HOME': '/home/cltbld', 03:33:54 INFO - 'LANG': 'en_US.UTF-8', 03:33:54 INFO - 'LANGUAGE': 'en_US:en', 03:33:54 INFO - 'LOGNAME': 'cltbld', 03:33:54 INFO - 'MAIL': '/var/mail/cltbld', 03:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:54 INFO - 'MOZ_NO_REMOTE': '1', 03:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:54 INFO - 'NO_EM_RESTART': '1', 03:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:54 INFO - 'PWD': '/builds/slave/test', 03:33:54 INFO - 'SHELL': '/bin/bash', 03:33:54 INFO - 'SHLVL': '1', 03:33:54 INFO - 'TERM': 'linux', 03:33:54 INFO - 'TMOUT': '86400', 03:33:54 INFO - 'USER': 'cltbld', 03:33:54 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', 03:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:54 INFO - '_': '/tools/buildbot/bin/python'} 03:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:33:54 INFO - Cleaning up... 03:33:54 INFO - Return code: 0 03:33:54 INFO - Running post-action listener: _resource_record_post_action 03:33:54 INFO - Running post-action listener: _start_resource_monitoring 03:33:54 INFO - Starting resource monitoring. 03:33:54 INFO - [mozharness: 2016-11-02 10:33:54.585087Z] Finished create-virtualenv step (success) 03:33:54 INFO - [mozharness: 2016-11-02 10:33:54.585615Z] Running install step. 03:33:54 INFO - Running pre-action listener: _resource_record_pre_action 03:33:54 INFO - Running main action method: install 03:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:54 INFO - Reading from file tmpfile_stdout 03:33:54 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:54 INFO - Reading from file tmpfile_stdout 03:33:54 INFO - Output received: 03:33:54 INFO - Usage: mozinstall [options] installer 03:33:54 INFO - Options: 03:33:54 INFO - -h, --help show this help message and exit 03:33:54 INFO - -d DEST, --destination=DEST 03:33:54 INFO - Directory to install application into. [default: 03:33:54 INFO - "/builds/slave/test"] 03:33:54 INFO - --app=APP Application being installed. [default: firefox] 03:33:54 INFO - mkdir: /builds/slave/test/build/application 03:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:34:10 INFO - Reading from file tmpfile_stdout 03:34:10 INFO - Output received: 03:34:10 INFO - /builds/slave/test/build/application/firefox/firefox 03:34:10 INFO - Running post-action listener: _resource_record_post_action 03:34:10 INFO - [mozharness: 2016-11-02 10:34:10.829826Z] Finished install step (success) 03:34:10 INFO - [mozharness: 2016-11-02 10:34:10.830070Z] Running run-tests step. 03:34:10 INFO - Running pre-action listener: _resource_record_pre_action 03:34:10 INFO - Running main action method: run_tests 03:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:34:10 INFO - Python 2.7.3 03:34:10 INFO - Return code: 0 03:34:10 INFO - grabbing minidump binary from tooltool 03:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:10 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 0x21aaf60>, '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 0x21abd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ac1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:34:10 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 03:34:10 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 03:34:10 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 03:34:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:34:10 INFO - Return code: 0 03:34:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:34:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:34:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:34:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:34:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 03:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 03:34:10 INFO - Using env: {'DISPLAY': ':0', 03:34:10 INFO - 'HOME': '/home/cltbld', 03:34:10 INFO - 'LANG': 'en_US.UTF-8', 03:34:10 INFO - 'LANGUAGE': 'en_US:en', 03:34:10 INFO - 'LOGNAME': 'cltbld', 03:34:10 INFO - 'MAIL': '/var/mail/cltbld', 03:34:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:34:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:10 INFO - 'MOZ_NO_REMOTE': '1', 03:34:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:10 INFO - 'NO_EM_RESTART': '1', 03:34:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:10 INFO - 'PWD': '/builds/slave/test', 03:34:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:34:10 INFO - 'SHELL': '/bin/bash', 03:34:10 INFO - 'SHLVL': '1', 03:34:10 INFO - 'TERM': 'linux', 03:34:10 INFO - 'TMOUT': '86400', 03:34:10 INFO - 'USER': 'cltbld', 03:34:10 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063', 03:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:10 INFO - '_': '/tools/buildbot/bin/python'} 03:34:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 03:34:11 INFO - mozversion application_buildid: 20161102004003 03:34:11 INFO - mozversion application_changeset: 3c4ab75a8bcb551b4fb73f31b7a4269f05e1a0dc 03:34:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:34:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:34:11 INFO - mozversion application_name: Firefox 03:34:11 INFO - mozversion application_remotingname: firefox-dev 03:34:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:34:11 INFO - mozversion application_vendor: Mozilla 03:34:11 INFO - mozversion application_version: 51.0a2 03:34:11 INFO - mozversion platform_buildid: 20161102004003 03:34:11 INFO - mozversion platform_changeset: 3c4ab75a8bcb551b4fb73f31b7a4269f05e1a0dc 03:34:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:34:11 INFO - mozversion platform_version: 51.0a2 03:34:11 INFO - using testdate: 1478082851 03:34:11 INFO - actual date: 1478082851 03:34:11 INFO - starting webserver on 'localhost:34453' 03:34:11 INFO - SUITE-START | Running 2 tests 03:34:11 INFO - TEST-START | dromaeo_css 03:34:11 INFO - operating with platform_type : linux_ 03:34:11 INFO - Initialising browser for dromaeo_css test... 03:34:11 INFO - TEST-INFO | started process 3253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy14vZt/profile http://localhost:34453/getInfo.html) 03:34:15 INFO - PROCESS | 3253 | __metrics Screen width/height:1600/1200 03:34:15 INFO - PROCESS | 3253 | colorDepth:24 03:34:15 INFO - PROCESS | 3253 | Browser inner width/height: 1024/697 03:34:15 INFO - PROCESS | 3253 | __metrics 03:34:15 INFO - PROCESS | 3253 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:34:15 INFO - PROCESS | 3253 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:34:16 INFO - PROCESS | 3253 | console.error: PushService: 03:34:16 INFO - PROCESS | 3253 | stateChangeProcessEnqueue: Error transitioning state 03:34:16 INFO - PROCESS | 3253 | UnknownError 03:34:16 INFO - TEST-INFO | 3253: exit 0 03:34:16 INFO - Browser initialized. 03:34:16 INFO - Running cycle 1/1 for dromaeo_css test... 03:34:16 INFO - TEST-INFO | started process 3344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy14vZt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:28 INFO - PROCESS | 3344 | RSS: Main: 144584704 03:34:28 INFO - PROCESS | 3344 | 03:35:19 INFO - PROCESS | 3344 | 1478082919969 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:37:29 INFO - PROCESS | 3344 | Cycle 1(1): loaded http://localhost:34453/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34453/tests/dromaeo/cssquery-ext.html) 03:37:30 INFO - PROCESS | 3344 | RSS: Main: 242044928 03:37:30 INFO - PROCESS | 3344 | 03:40:32 INFO - PROCESS | 3344 | Cycle 1(1): loaded http://localhost:34453/tests/dromaeo/cssquery-ext.html (next: http://localhost:34453/tests/dromaeo/cssquery-jquery.html) 03:40:33 INFO - PROCESS | 3344 | RSS: Main: 232861696 03:40:33 INFO - PROCESS | 3344 | 03:43:35 INFO - PROCESS | 3344 | Cycle 1(1): loaded http://localhost:34453/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34453/tests/dromaeo/cssquery-mootools.html) 03:43:35 INFO - PROCESS | 3344 | RSS: Main: 214282240 03:43:35 INFO - PROCESS | 3344 | 03:46:37 INFO - PROCESS | 3344 | Cycle 1(1): loaded http://localhost:34453/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34453/tests/dromaeo/cssquery-prototype.html) 03:46:38 INFO - PROCESS | 3344 | RSS: Main: 230330368 03:46:38 INFO - PROCESS | 3344 | 03:49:40 INFO - PROCESS | 3344 | Cycle 1(1): loaded http://localhost:34453/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34453/tests/dromaeo/cssquery-yui.html) 03:49:41 INFO - PROCESS | 3344 | RSS: Main: 177119232 03:49:41 INFO - PROCESS | 3344 | 03:52:44 INFO - PROCESS | 3344 | Cycle 1(1): loaded http://localhost:34453/tests/dromaeo/cssquery-yui.html (next: http://localhost:34453/tests/dromaeo/cssquery-dojo.html) 03:52:44 INFO - PROCESS | 3344 | RSS: Main: 265261056 03:52:44 INFO - PROCESS | 3344 | 03:52:44 INFO - PROCESS | 3344 | __start_tp_report 03:52:44 INFO - PROCESS | 3344 | _x_x_mozilla_page_load 03:52:44 INFO - PROCESS | 3344 | _x_x_mozilla_page_load_details 03:52:44 INFO - PROCESS | 3344 | |i|pagename|runs| 03:52:44 INFO - PROCESS | 3344 | |0;dojo.html;3150.2911844834916;3199.664035276296;3210.0851257391632;3230.3377807549455;3247.935041299174;5622.971885140573;5684.062129748591;5696.715164241792;5711.628744131628;5726.3700992890745;5635.098384258519;5654.208410822488;5672.950504156734;5723.456271654186;5726.770929162829;5089.491050894918;5117.411497677777;5145;5146.922796158061;5194.58443324535;5032.6477146599755;5243.632945693803;5244.344456942882;5248.947510524903;5266.841994740144;5030.396352437712;5116.334876466054;5141.228815677659;5151.278820965068;5184.326037615105;5148.485151484841;5176.7929282828645;5179.249008893727;5230.450802665703;5260.92108618371;5104.64267501275;5145.25393817898;5220.738963051832;5230.320058392423;5264.15773476242;5435.945640543583;5483.396826349099;5485.917711234335;5538.75075621598;5556.91664625031;5965.791197308116;5974.731137098797;5986.940130598726;6056.031035034417;6057.061155520902;6076.240469941257;6094.542909281821;6116.785912493086;6117.265928088658;6124.877502449971;5449;5468.425815289377;5556.833295001197;5595.972020139873;5623;6134.355892631299;6168.722407491674;6175.536834737323;6176.197094377702;6180.5673602848265;5945.494632956161;5946.137810017523;5947.1079338099635;5952.375000624958;5960.970195148997;5814.244148260699;5871.4715675589405;5938.079597662369;5996.790112346047;5997.880042399215;6004.789832355847;6012.699365031818;6020.247469066367;6021.729022194012;6039.63762174271;5971.4924231439945;6027.78902738402;6036.426539478743;6036.879262414727;6056.727447264883;4483.686141970031;4516.096780643885;4577.8397756078375;4609.078184363141;4643.2802915548145;4102.097538541516;4114.259433302034;4135.875923722293;4138.52406973196;4164.104717485695;5706.629069110578;5718.513926316226;5720.742566584514;5724.398938111438;5726.169705392695;5855.912161317584;5910.379410161957;6001.339852616209;6042.519582702266;6060.212172417646;5676.971615141898;5749.798757043567;5758.971205144031;5780.768769249267;5796.333421656479;5252.369715634149;5267.604929630293;5268.841934741964;5270.051390749702;5273.419923808378;6068;6114.6942652868065;6245.250569931546;6289.905651415233;6302.054691796267;6079.3312735598165;6123.099607468126;6126.30393285589;6128.050152226412;6134.803982731443;6299.149614802126;6305.747770089329;6306.653134077486;6307.05394190875;6308.905366419599;5720.513756330592;5987.311459182076;5987.401259873977;5989.670568118795;5995;5830.183774271521;5943.940560594338;5998.940010599838;6032.909506357496;6051.33435322123;5899.852503687443;5913.645181289136;5944.910826337522;5947.434993675594;5950.523958083257;5941.524678025661;5941.732622031933;5946;5948.345681975065;5950.464458198783;5609.747561359667;5728.627639203439;5795.33353664334;5837.328707198557;5847.8245652630485;5966.105084237399;5971.820845374646;5971.91042134377;5977.820665380045;5991.67045812467;5604.719764011702;5817.0983497557945;5830.679312637845;5830.795922142875;5834.416558344132 03:52:44 INFO - PROCESS | 3344 | |1;ext.html;599.8920194365013;615.7783198048703;663.5521023309265;665.9034440006197;679.0493309366889;34346;34962.82518587407;44715.32927006093;44765.77617111918;44951.55048449514;46614.533854661444;46957;47041;47062.29406558904;47065.52934470654;9238.30712696547;9389.76525586859;9399.718008459757;9402.247820174369;9408.764780880465;8627.137286271354;8811.383203175781;8828.779280518007;9260;11005.229633925628;11136.053435457996;11430.08559315257;11449.599264025761;11498.310101393901;11506.71233219172;11177.273477223995;11209.719757006058;11222.607208747655;11237.101031917427;11237.494312755864;8502.234798868132;8734.650613975433;10675.41285229312;11077.003069723683;11151.553937842476;42496.15007699829;45607;45652.315215271796;45666;45670.54329456696;3634.3821550336506;3708.295423869456;3797.639224273717;4153.169366126786;4171.707980441371;33747.32505349879;34423;34424.48363274553;34516;34555.654443455496;4543.204939135638;4597.448306203243;4656.557627025427;4688.64835137366;4712.151812673717;361473;362374.7525049511;362861;363051.9999999974;363555;62626.686866565375;62758;63036.36963630397;63255.367446325865;63480;67187.66406167937;67245.32754672489;67327;67414.32585674178;67429.32570674329;18908.149133289036;19540;19691.11389987454;19691.704624430644;19701.507462313555;15450.690986180214;15597.532074037797;15603.297851596706;15604.453844115402;15608.14155221451;16493.752593711102;16919.154042297836;18000.279988800303;18413.81586184148;18592.81407185911;6265;6322.703845711618;6464.191976003;6482.870342593122;6500.772472963424;1030.6186710916859;1046.529061922138;1067.556963860005;1131.9830202546968;1171.3616079236836;33644.83177584096;33881.491777623356;34254.48618270728;34310.31379372399;34445.82777086098;1147.1912301827192;1148.586508856811;1183.4851839449866;1192.9642110736693;1302.1861336664585;17467.82532174662;18275.817241827677;18282.360117395827;18337.266509339745;18489.72265415993;534877;537651;537678;538441;538943;61899.07151392733;62013;62036.68981655063;62129.37870621326;62153.689231554454;1277.6486466221863;1317.3939987605618;1364.6929440875922;1382.9377678004514;1404.206623257856;30596.951587860127;34896.30207395787;35150.472742908365;35695.64304357027;35782.105447364025;52941.7352913233;53503.19745203903;53512;53526.73236633792;53603.73198133984;395347;396488;397446;398440;398543;43864.561354387326;44754;45187;45312.773436133924;45507.54492455033;50353.49646503488;51118.74440627773;51181.48818511916;51471.48528514667;51585.484145158065;43200.56799431965;43248.351274730274;43830.12339753251;45339.31991020203;45555;42474;42910.356344655476;43560.56439435565;43755.34366984434;43991.78004109959;39098;39617.2076558473;44394.55605443904;45230.773846130556;45376;36527.08682282964;38871;39223.60776392314;39702.60297397104;39751.403728944664;29048.857301144075;29453;29794.255143621584;29853.55219671663;30005.099847004625 03:52:44 INFO - PROCESS | 3344 | |2;jquery.html;375.64501546039;387.6472410106805;404.3086322388715;413.5223816491952;423.55526696968195;14016.649583760398;16458.670826583475;20412.79587204131;20450.07974641141;21151.15395384183;19775.70336444951;20122.396328110142;20130.597388052265;20357.898210508964;20443.386698399034;5772.740226689799;5776.220210271623;5785.537157027448;5854.473097421232;6019.819405417845;4266.871993840175;4461.776911154446;5779.248697669318;5858.209141765849;5860.179574859523;4482.789646795363;6171.13604095427;6446.226452825644;6451.225852897635;6581.210254769434;6342.556021078503;6356.841078973016;6388.776392826228;6407.103005579223;6558.8688226235445;5696.971515142439;5699.145128230757;5699.772009119631;5704.914426283609;5709.8287051388525;23412;23918.043278268848;24069.518609627885;24228.515429691484;24458.755412445826;2367.4081479630095;2534.2397280815867;2843.971560284391;3253.9186520336943;3336.566246387954;10827.512761925733;11192.552297908074;11621.825672614917;14749.77875331871;15471.226438678133;1963.2539634938776;2026.8479864010258;2069.3895300886275;2108.293721603249;2193.7696541863033;85329.57335213346;88778.6683199759;90787.54606226926;92217;93460.53269733608;11283.210175287815;11347.886521134847;11450.19848610606;11481.655550333504;11568.76862462746;16216.675666486604;16219.918900405422;16220.432284869972;16221.188940552925;16249.187540622921;8513.82972340562;8571.657133714707;8998.191393424344;9068.81862362749;9080.409773364841;8237.50574965504;8788.956055219684;8857;9001.63993440255;9071.138241867144;4892.902141957141;4987.725675087832;5026.84919452417;5095.87260318495;5112.156494178494;2008.7589489261381;2020.4443777960885;2052.548439343342;2052.7434070741156;2099.3387083068783;975.6877799104218;1011.5903059260864;1057.1965306367063;1061.3419679798574;1088.1566785741113;18657.53356166107;20283.391498255078;20401.489962750755;20432.387028389174;20593.07331170101;1000.4497526360473;1002.3334482569155;1032.566322144701;1057.143713591993;1071.566015763617;10598.735031624272;11238.157138214667;11373.317600943805;11463.484143213574;11504.137189710806;513744;522678;528250;540763;552904;61329.999999999105;64737.35262647313;72847;100450.49774751226;104077;1005.6882366466418;1037.1443559063803;1062.0812996757904;1074.3070719385953;1088.5700148441479;17685.557861053578;17708.468745937644;18169.45491635253;18377.448676539727;18443.907780461548;44026.559734402246;44214.778926105166;44594.554054460335;45405.77297113493;46326.220426774504;59132.70433647804;61789.382106180165;62907;63213;64520.677396612715;8798.47209167452;8847;8968.506732129796;9025.954870225607;9171.794693362197;13646.454141834216;13733;13791.448342066205;13852.653683657585;13983.091099078527;11818.172727908965;12139.453724582238;12150.392480375769;12281.201721888048;12750.48998040068;11572.132090093444;11756.412179391167;12138.33239171854;12177.939110304393;12236.87763122393;12032.578859739868;12155.81766273489;12175.817362739743;12419.254844709347;12469.127161098637;7836.255555722198;8279.54462504568;8343.54110523927;8912.688055918012;9106.271498280254;9031.593578288861;11839.82240266414;12040.518379264731;12161.087918405978;12231 03:52:44 INFO - PROCESS | 3344 | |3;mootools.html;1548.1639914446196;1548.4967385599682;1693.983060169398;1794.928202871885;1818.7908390535092;8130.878036829437;8447.91552084479;8802.427842190253;9415.105564971334;9415.340926135183;8751.124887511261;9053.864192037125;9070.818583628323;9236.67671631493;9243.399179053356;2482.3173627252513;2512.886920088591;2515.1448507507444;2515.434027343851;2516.3960649444093;2131.275366375432;2204.34971683353;2423.5274121546304;2463.1255904154036;2551.362159460135;2471.7404672509397;2492.0654754467073;2509.2723110298084;2509.3475696318997;2520.5337012652717;2391.976080239193;2464.963025554618;2467.3338198686433;2468.827182097254;2470.110760126353;2395.3173345596597;2405.206281926977;2425.50277193175;2438.829281950264;2439.6096624539987;9241.260699144052;9280.860787088199;9296.535173241311;9311.394759340621;9333.160015598562;5400.891982160335;5548.0845660465975;5570.498655121018;5619.466150715716;5623.100303951389;3600.8919732407808;3628.8548458061646;3698.389765688685;3704.3887758519813;3710.18375957289;1137.3573930729194;1179.6048323811533;1195.0618764270093;1200.6518109748163;1225.583301677425;12564.183328083645;12628.494860205581;12638.620841374774;12669.239845609292;12721.681957951032;4750.287456881495;4813.085513752446;4914.0908931847725;4954.157793175169;5058.291839142523;10678.252522323519;10687.412192329497;10702.785944281226;10706.678799636024;10708.411037393018;5559.499645031886;5571.916421253684;5576.302962129734;5577.191307260425;5577.470140336662;5032.924506132411;5090.185570308733;5122.667026643331;5126.512981266774;5148.150555158431;4150.813213405404;4178.477690288714;4250.511191212988;4259.084296876186;4296.484421869333;1271.3071376100047;1316.7300703355788;1318.6703324168957;1322.9404676789568;1362.768329384007;944.2729098594044;1017.9949100254452;1027.1782573940818;1039.0752230514847;1041.6250149946013;6311.495080393649;6481.449076828428;6492.123563318892;6539.705713242915;6621.370969757865;1020.1685626214611;1040.547361897577;1040.927135100551;1043.817331966918;1060.4962642744788;4455.353973673799;4468.106378724203;4545.909081818345;4581.106684196549;4653.418322709661;10957.671269861918;11443.256188347897;11449.942750286194;11486.655400338002;11489;10800.405977671146;11274.323540587427;11294.096472282197;11351.318920864775;11386.373749443694;8423.326133909273;8632.91367086321;8640.135986401436;8652.437591556529;8656.22094011542;6332.240131184288;6414.262359828679;6428.325025872216;6482.773102941374;6532.248791388861;10289.639862604772;10581.31221470602;10588.1000114988;10719.785604287714;10741.355518668592;10918.836217456586;10990.780184396428;11024.007839294502;11040.834387484034;11052.668419947415;8140.511569305861;8157.55133467665;8250.216229458192;8309.293710034473;8324.708635197981;8832.205101540636;8848.734537963614;8924.286057115285;8947.328950328621;8953.910460895308;7910.920890791019;8074.313683336982;8096.51420914747;8140.715074972348;8189.631466583899;7673.654685539276;7856.175101614477;7912.683492660229;7973.760787176394;8103.878441823495;7409.740659076906;7466.552006879605;7510.511816731895;7530.058742657168;7531;5182.300389447527;5187.170052791535;5223.973880130575;5286.788528458972;5554.1391084381985;5491;5639.154126881001;5639.464250896158;5674.404187560247;5703.657780533182 03:52:44 INFO - PROCESS | 3344 | |4;prototype.html;329.7032670596463;340.74614412262866;347.52389226759345;349.8076058168007;351.04690764574184;5589.608727389079;5592.944070559298;5616.466435688613;5680.403557626451;5695.857603559903;5191.092987926763;5331.706756128411;5339.279197308372;5351.822599028217;5543.501084902358;4198.286291330481;4237.364395340708;4269.097014030458;4350.064736081742;4402.647788176938;4348.369486424466;4361.411209486726;4387.648988080962;4387.990762124713;4409.735415875058;4136.524299705542;4312.310030395138;4323.610875021247;4341.066670665807;4386.758728269944;4274.252005898971;4282.415506262702;4283.4431523902;4284.700070995032;4325.675574331937;3793.3930571108767;3793.8103094845146;3804.345109877212;3807.1814559869485;3807.257584770971;5245.8459138989365;5345.7594408251725;5437.918431223496;5444.972775136139;5446.564274858002;4903.651495838637;4958.834673851642;4960.627952903511;4963.329950456714;4970.403551573834;5719.656820590778;5762.481376676077;5798.681072541009;5818.5926985111055;5836.941630583725;4039.9596004039877;4114.382842573608;4135.276326642826;4140.7577726681875;4162.354835000579;5873.618214816066;5908.670549126455;5912.763489460416;5933.851653708649;5971.28344598651;4110.280700877334;4134.834606615762;4146.150039241948;4172.979135104305;4176.227397931392;4053.6959728020515;4197.916041679149;4213.936790948138;4225.64082053029;4230.238557059697;4788.066327066189;4791.616670666338;4794.232922732416;4807;4807.567318941312;5769.8557536061935;5774.711264436845;5830.38780928005;5850.268716410449;5863.70681465925;1390.3812803302433;1458.7228426598913;1470.6764511807598;1478.1722235548127;1482.5626440200167;939.1406862720671;940.6049459227141;946.6592026870321;958.5494817435793;963.5278713430368;4855.902881942341;4858.319835223072;4886.486918873467;4910.551387340743;4912.336834527365;5099.541041306226;5134.460881607452;5158.638895277295;5159.535641792257;5181.274621552986;4845.473675792115;4858.95141048585;4883.633727470454;4908;5228.764705588258;3136.43544162053;3172.255259607207;3173.2066983254185;3175.539546765706;3181.236503239206;6152.323244443108;6161.319825875758;6176.455886028493;6182.814515564541;6200.751969921243;5973.133895585116;6046.365131661112;6084.756609735649;6084.8174554762545;6108.144859719643;6087.96956015226;6115;6116.3577824328695;6141.219046476472;6149.692515374213;5793.768249270151;5859.736311865891;5930.762769489172;5951.940480595139;5994.160817485468;5817.418258174149;5844.883102338014;5849.268841394825;5862.355140934579;5892.263467066617;5979.3123790762875;6129.693515324305;6156.846078848064;6174.44430001302;6177.166082578794;3951.7628942263555;4187.706860519735;4197.727147735387;4207.305794543989;4213.452251207324;5727.336788393417;5773.162891380643;5915.260592425947;5919.378465261258;5946.583739138218;5793.94206057934;5812.360640329645;5814.273215848019;5839.562032847469;5846.210761547137;5589.748461319332;5712.228849105318;5740.311162660508;5741.25363702716;5811.738471768696;5648.265725455664;5669.716514174357;5703.62926409782;5728.312602487728;5745.816589695889;5587.74855131512;5796.59423840344;5816.621919575214;5824.359320474659;5857.882842343044;5591.888162236651;5597.860053498695;5635.577331700057;5643.492085712305;5685.260916080883 03:52:44 INFO - PROCESS | 3344 | |5;yui.html;799.2247519905691;837.9860368953566;845.4462327175698;850.1540966738097;919.7124026363086;14945.626359341022;15018.474353397633;15163.54509364718;15292.541223763277;15333.539993800176;13218.801717974238;15293.92353038236;15394.923025384858;15458;15485.458008969688;853.0914575976597;867.0679020053436;875.8335916175906;876.548577482597;877.0308808766317;869.3653632848025;872.8385248728973;873.8470767615673;874.5015341255487;874.7725591346232;916.0701887584107;917.4403613795579;918.481058202117;921.9539023048854;921.9585118669676;912.434290739739;915.5696822493418;915.624593916491;915.7252824152761;915.7893684452547;673.85848971716;674.2010717299967;674.2246416620876;674.3391476353202;674.6862708840364;14630.341634626468;14746.926265368604;14758.335874885655;14781.556553303311;14791.852081479263;13584.864151358459;13819.585412437644;13875.37560809766;13965.650858728512;13986.440542378292;12077.93961030198;12149.392530373447;12618.621441356681;12794.232346059267;12820.166689165268;3927.3897701942064;4027.335489644205;4044.4539987101657;4084.979575102135;4085.9387109193385;52977.2053419199;54708.72645636746;69942;73441.6327918357;85330;11232.49453774582;11252.549898004152;11472;12882.227066376048;12883.677908052186;22049;22091.447713806963;22306.665400019014;22371.44071398228;22393.552128957657;8817.118288171132;8837.513936733541;8951.104889510996;8978.955105224562;9144.3598948073;4935.111679897653;5077.238414237894;5159.25190847325;5170.663906846043;5305.946940530623;3848.2688289224957;4003.3994900764537;4004.3593025115842;4006.579309172553;4007.0182805212326;657.9309172536815;659.1694464974167;662.7978466567744;676.3608390071336;694.1462001737891;671.583618156746;685.9279775623488;715.9606221657755;792.3574877782545;793.5556088590408;10196.847047294297;10582.417967011734;10766;10830.296030757976;10989.780204395867;788.1645455816853;792.5878543157526;799.3645052183529;809.3606051219589;824.3652387661587;5347.465253474621;5430.348358197041;5471.972640136853;5486.3690675572025;5535.446455354432;76643.61678191573;78227.60886195532;109807.45096274467;121983.39008305079;134770;111924.4403777976;113624;115827.42086289515;115995;118083;72537.91193132107;80324.59837700774;82824.58587707144;85723.57138214394;90854.99999999868;10472.947635261775;10522.75047941611;10582.470876455993;10582.470876455993;10843.186760993114;54209;55538.628728520634;55590.72204638951;55672;56205;77428;78392;81244;81337.59331203306;84637.57681211554;13893.166410015432;13894.553742802207;14207.431702731776;14356.928215358856;14397.64005899861;15601.765973510634;15822.129782862054;15826.60433489172;15937;16162.595935101717;15183.620409489851;15615.921920390325;15622.375104995674;16863.325466981183;16878.83121168822;15131.470398536;15361.645158239691;15362.846371536141;15629.76555351648;15630;14288.42846286137;15135.545933622008;15164.24178791034;15449.150296733338;15572.377104915677;12473.126881118234;12510.18683785551;12517.311547864954;13081.67295817574;13333.333333333489;12023.81964270554;12950.611481655566;12956.740865182832;13010.479580816662;13035.15271507349 03:52:44 INFO - PROCESS | 3344 | __end_tp_report 03:52:44 INFO - PROCESS | 3344 | __start_cc_report 03:52:44 INFO - PROCESS | 3344 | _x_x_mozilla_cycle_collect,870 03:52:44 INFO - PROCESS | 3344 | __end_cc_report 03:52:44 INFO - PROCESS | 3344 | __startTimestamp1478083964253__endTimestamp 03:52:44 INFO - PROCESS | 3344 | 03:52:44 INFO - PROCESS | 3344 | ------- Summary: start ------- 03:52:44 INFO - PROCESS | 3344 | Number of tests: 6 03:52:44 INFO - PROCESS | 3344 | 03:52:44 INFO - PROCESS | 3344 | [#0] dojo.html Cycles:165 Average:5606.84 Median:5830.18 stddev:639.61 (11.0%) stddev-sans-first:611.85 03:52:44 INFO - PROCESS | 3344 | Values: 3150.3 3199.7 3210.1 3230.3 3247.9 5623.0 5684.1 5696.7 5711.6 5726.4 5635.1 5654.2 5673.0 5723.5 5726.8 5089.5 5117.4 5145.0 5146.9 5194.6 5032.6 5243.6 5244.3 5248.9 5266.8 5030.4 5116.3 5141.2 5151.3 5184.3 5148.5 5176.8 5179.2 5230.5 5260.9 5104.6 5145.3 5220.7 5230.3 5264.2 5435.9 5483.4 5485.9 5538.8 5556.9 5965.8 5974.7 5986.9 6056.0 6057.1 6076.2 6094.5 6116.8 6117.3 6124.9 5449.0 5468.4 5556.8 5596.0 5623.0 6134.4 6168.7 6175.5 6176.2 6180.6 5945.5 5946.1 5947.1 5952.4 5961.0 5814.2 5871.5 5938.1 5996.8 5997.9 6004.8 6012.7 6020.2 6021.7 6039.6 5971.5 6027.8 6036.4 6036.9 6056.7 4483.7 4516.1 4577.8 4609.1 4643.3 4102.1 4114.3 4135.9 4138.5 4164.1 5706.6 5718.5 5720.7 5724.4 5726.2 5855.9 5910.4 6001.3 6042.5 6060.2 5677.0 5749.8 5759.0 5780.8 5796.3 5252.4 5267.6 5268.8 5270.1 5273.4 6068.0 6114.7 6245.3 6289.9 6302.1 6079.3 6123.1 6126.3 6128.1 6134.8 6299.1 6305.7 6306.7 6307.1 6308.9 5720.5 5987.3 5987.4 5989.7 5995.0 5830.2 5943.9 5998.9 6032.9 6051.3 5899.9 5913.6 5944.9 5947.4 5950.5 5941.5 5941.7 5946.0 5948.3 5950.5 5609.7 5728.6 5795.3 5837.3 5847.8 5966.1 5971.8 5971.9 5977.8 5991.7 5604.7 5817.1 5830.7 5830.8 5834.4 03:52:44 INFO - PROCESS | 3344 | 03:52:44 INFO - PROCESS | 3344 | [#1] ext.html Cycles:180 Average:61531.53 Median:201348.08 stddev:115936.10 (57.6%) stddev-sans-first:116171.07 03:52:44 INFO - PROCESS | 3344 | Values: 599.9 615.8 663.6 665.9 679.0 34346.0 34962.8 44715.3 44765.8 44951.6 46614.5 46957.0 47041.0 47062.3 47065.5 9238.3 9389.8 9399.7 9402.2 9408.8 8627.1 8811.4 8828.8 9260.0 11005.2 11136.1 11430.1 11449.6 11498.3 11506.7 11177.3 11209.7 11222.6 11237.1 11237.5 8502.2 8734.7 10675.4 11077.0 11151.6 42496.2 45607.0 45652.3 45666.0 45670.5 3634.4 3708.3 3797.6 4153.2 4171.7 33747.3 34423.0 34424.5 34516.0 34555.7 4543.2 4597.4 4656.6 4688.6 4712.2 361473.0 362374.8 362861.0 363052.0 363555.0 62626.7 62758.0 63036.4 63255.4 63480.0 67187.7 67245.3 67327.0 67414.3 67429.3 18908.1 19540.0 19691.1 19691.7 19701.5 15450.7 15597.5 15603.3 15604.5 15608.1 16493.8 16919.2 18000.3 18413.8 18592.8 6265.0 6322.7 6464.2 6482.9 6500.8 1030.6 1046.5 1067.6 1132.0 1171.4 33644.8 33881.5 34254.5 34310.3 34445.8 1147.2 1148.6 1183.5 1193.0 1302.2 17467.8 18275.8 18282.4 18337.3 18489.7 534877.0 537651.0 537678.0 538441.0 538943.0 61899.1 62013.0 62036.7 62129.4 62153.7 1277.6 1317.4 1364.7 1382.9 1404.2 30597.0 34896.3 35150.5 35695.6 35782.1 52941.7 53503.2 53512.0 53526.7 53603.7 395347.0 396488.0 397446.0 398440.0 398543.0 43864.6 44754.0 45187.0 45312.8 45507.5 50353.5 51118.7 51181.5 51471.5 51585.5 43200.6 43248.4 43830.1 45339.3 45555.0 42474.0 42910.4 43560.6 43755.3 43991.8 39098.0 39617.2 44394.6 45230.8 45376.0 36527.1 38871.0 39223.6 39702.6 39751.4 29048.9 29453.0 29794.3 29853.6 30005.1 03:52:44 INFO - PROCESS | 3344 | 03:52:44 INFO - PROCESS | 3344 | [#2] jquery.html Cycles:180 Average:30660.10 Median:12889.70 stddev:87474.18 (678.6%) stddev-sans-first:87690.02 03:52:44 INFO - PROCESS | 3344 | Values: 375.6 387.6 404.3 413.5 423.6 14016.6 16458.7 20412.8 20450.1 21151.2 19775.7 20122.4 20130.6 20357.9 20443.4 5772.7 5776.2 5785.5 5854.5 6019.8 4266.9 4461.8 5779.2 5858.2 5860.2 4482.8 6171.1 6446.2 6451.2 6581.2 6342.6 6356.8 6388.8 6407.1 6558.9 5697.0 5699.1 5699.8 5704.9 5709.8 23412.0 23918.0 24069.5 24228.5 24458.8 2367.4 2534.2 2844.0 3253.9 3336.6 10827.5 11192.6 11621.8 14749.8 15471.2 1963.3 2026.8 2069.4 2108.3 2193.8 85329.6 88778.7 90787.5 92217.0 93460.5 11283.2 11347.9 11450.2 11481.7 11568.8 16216.7 16219.9 16220.4 16221.2 16249.2 8513.8 8571.7 8998.2 9068.8 9080.4 8237.5 8789.0 8857.0 9001.6 9071.1 4892.9 4987.7 5026.8 5095.9 5112.2 2008.8 2020.4 2052.5 2052.7 2099.3 975.7 1011.6 1057.2 1061.3 1088.2 18657.5 20283.4 20401.5 20432.4 20593.1 1000.4 1002.3 1032.6 1057.1 1071.6 10598.7 11238.2 11373.3 11463.5 11504.1 513744.0 522678.0 528250.0 540763.0 552904.0 61330.0 64737.4 72847.0 100450.5 104077.0 1005.7 1037.1 1062.1 1074.3 1088.6 17685.6 17708.5 18169.5 18377.4 18443.9 44026.6 44214.8 44594.6 45405.8 46326.2 59132.7 61789.4 62907.0 63213.0 64520.7 8798.5 8847.0 8968.5 9026.0 9171.8 13646.5 13733.0 13791.4 13852.7 13983.1 11818.2 12139.5 12150.4 12281.2 12750.5 11572.1 11756.4 12138.3 12177.9 12236.9 12032.6 12155.8 12175.8 12419.3 12469.1 7836.3 8279.5 8343.5 8912.7 9106.3 9031.6 11839.8 12040.5 12161.1 12231.0 03:52:44 INFO - PROCESS | 3344 | 03:52:44 INFO - PROCESS | 3344 | [#3] mootools.html Cycles:180 Average:6106.24 Median:4507.01 stddev:3415.77 (75.8%) stddev-sans-first:3408.17 03:52:44 INFO - PROCESS | 3344 | Values: 1548.2 1548.5 1694.0 1794.9 1818.8 8130.9 8447.9 8802.4 9415.1 9415.3 8751.1 9053.9 9070.8 9236.7 9243.4 2482.3 2512.9 2515.1 2515.4 2516.4 2131.3 2204.3 2423.5 2463.1 2551.4 2471.7 2492.1 2509.3 2509.3 2520.5 2392.0 2465.0 2467.3 2468.8 2470.1 2395.3 2405.2 2425.5 2438.8 2439.6 9241.3 9280.9 9296.5 9311.4 9333.2 5400.9 5548.1 5570.5 5619.5 5623.1 3600.9 3628.9 3698.4 3704.4 3710.2 1137.4 1179.6 1195.1 1200.7 1225.6 12564.2 12628.5 12638.6 12669.2 12721.7 4750.3 4813.1 4914.1 4954.2 5058.3 10678.3 10687.4 10702.8 10706.7 10708.4 5559.5 5571.9 5576.3 5577.2 5577.5 5032.9 5090.2 5122.7 5126.5 5148.2 4150.8 4178.5 4250.5 4259.1 4296.5 1271.3 1316.7 1318.7 1322.9 1362.8 944.3 1018.0 1027.2 1039.1 1041.6 6311.5 6481.4 6492.1 6539.7 6621.4 1020.2 1040.5 1040.9 1043.8 1060.5 4455.4 4468.1 4545.9 4581.1 4653.4 10957.7 11443.3 11449.9 11486.7 11489.0 10800.4 11274.3 11294.1 11351.3 11386.4 8423.3 8632.9 8640.1 8652.4 8656.2 6332.2 6414.3 6428.3 6482.8 6532.2 10289.6 10581.3 10588.1 10719.8 10741.4 10918.8 10990.8 11024.0 11040.8 11052.7 8140.5 8157.6 8250.2 8309.3 8324.7 8832.2 8848.7 8924.3 8947.3 8953.9 7910.9 8074.3 8096.5 8140.7 8189.6 7673.7 7856.2 7912.7 7973.8 8103.9 7409.7 7466.6 7510.5 7530.1 7531.0 5182.3 5187.2 5224.0 5286.8 5554.1 5491.0 5639.2 5639.5 5674.4 5703.7 03:52:44 INFO - PROCESS | 3344 | 03:52:44 INFO - PROCESS | 3344 | [#4] prototype.html Cycles:180 Average:4804.04 Median:5394.87 stddev:1416.42 (26.3%) stddev-sans-first:1380.00 03:52:44 INFO - PROCESS | 3344 | Values: 329.7 340.7 347.5 349.8 351.0 5589.6 5592.9 5616.5 5680.4 5695.9 5191.1 5331.7 5339.3 5351.8 5543.5 4198.3 4237.4 4269.1 4350.1 4402.6 4348.4 4361.4 4387.6 4388.0 4409.7 4136.5 4312.3 4323.6 4341.1 4386.8 4274.3 4282.4 4283.4 4284.7 4325.7 3793.4 3793.8 3804.3 3807.2 3807.3 5245.8 5345.8 5437.9 5445.0 5446.6 4903.7 4958.8 4960.6 4963.3 4970.4 5719.7 5762.5 5798.7 5818.6 5836.9 4040.0 4114.4 4135.3 4140.8 4162.4 5873.6 5908.7 5912.8 5933.9 5971.3 4110.3 4134.8 4146.2 4173.0 4176.2 4053.7 4197.9 4213.9 4225.6 4230.2 4788.1 4791.6 4794.2 4807.0 4807.6 5769.9 5774.7 5830.4 5850.3 5863.7 1390.4 1458.7 1470.7 1478.2 1482.6 939.1 940.6 946.7 958.5 963.5 4855.9 4858.3 4886.5 4910.6 4912.3 5099.5 5134.5 5158.6 5159.5 5181.3 4845.5 4859.0 4883.6 4908.0 5228.8 3136.4 3172.3 3173.2 3175.5 3181.2 6152.3 6161.3 6176.5 6182.8 6200.8 5973.1 6046.4 6084.8 6084.8 6108.1 6088.0 6115.0 6116.4 6141.2 6149.7 5793.8 5859.7 5930.8 5951.9 5994.2 5817.4 5844.9 5849.3 5862.4 5892.3 5979.3 6129.7 6156.8 6174.4 6177.2 3951.8 4187.7 4197.7 4207.3 4213.5 5727.3 5773.2 5915.3 5919.4 5946.6 5793.9 5812.4 5814.3 5839.6 5846.2 5589.7 5712.2 5740.3 5741.3 5811.7 5648.3 5669.7 5703.6 5728.3 5745.8 5587.7 5796.6 5816.6 5824.4 5857.9 5591.9 5597.9 5635.6 5643.5 5685.3 03:52:44 INFO - PROCESS | 3344 | 03:52:44 INFO - PROCESS | 3344 | [#5] yui.html Cycles:180 Average:21356.78 Median:4003.88 stddev:30314.22 (757.1%) stddev-sans-first:30359.96 03:52:44 INFO - PROCESS | 3344 | Values: 799.2 838.0 845.4 850.2 919.7 14945.6 15018.5 15163.5 15292.5 15333.5 13218.8 15293.9 15394.9 15458.0 15485.5 853.1 867.1 875.8 876.5 877.0 869.4 872.8 873.8 874.5 874.8 916.1 917.4 918.5 922.0 922.0 912.4 915.6 915.6 915.7 915.8 673.9 674.2 674.2 674.3 674.7 14630.3 14746.9 14758.3 14781.6 14791.9 13584.9 13819.6 13875.4 13965.7 13986.4 12077.9 12149.4 12618.6 12794.2 12820.2 3927.4 4027.3 4044.5 4085.0 4085.9 52977.2 54708.7 69942.0 73441.6 85330.0 11232.5 11252.5 11472.0 12882.2 12883.7 22049.0 22091.4 22306.7 22371.4 22393.6 8817.1 8837.5 8951.1 8979.0 9144.4 4935.1 5077.2 5159.3 5170.7 5305.9 3848.3 4003.4 4004.4 4006.6 4007.0 657.9 659.2 662.8 676.4 694.1 671.6 685.9 716.0 792.4 793.6 10196.8 10582.4 10766.0 10830.3 10989.8 788.2 792.6 799.4 809.4 824.4 5347.5 5430.3 5472.0 5486.4 5535.4 76643.6 78227.6 109807.5 121983.4 134770.0 111924.4 113624.0 115827.4 115995.0 118083.0 72537.9 80324.6 82824.6 85723.6 90855.0 10472.9 10522.8 10582.5 10582.5 10843.2 54209.0 55538.6 55590.7 55672.0 56205.0 77428.0 78392.0 81244.0 81337.6 84637.6 13893.2 13894.6 14207.4 14356.9 14397.6 15601.8 15822.1 15826.6 15937.0 16162.6 15183.6 15615.9 15622.4 16863.3 16878.8 15131.5 15361.6 15362.8 15629.8 15630.0 14288.4 15135.5 15164.2 15449.2 15572.4 12473.1 12510.2 12517.3 13081.7 13333.3 12023.8 12950.6 12956.7 13010.5 13035.2 03:52:44 INFO - PROCESS | 3344 | -------- Summary: end -------- 03:52:44 INFO - PROCESS | 3344 | 03:52:44 INFO - TEST-INFO | 3344: exit 0 03:52:45 INFO - TEST-OK | dromaeo_css | took 1113853ms 03:52:45 INFO - TEST-START | kraken 03:52:45 INFO - operating with platform_type : linux_ 03:52:45 INFO - Initialising browser for kraken test... 03:52:45 INFO - TEST-INFO | started process 3666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4i07dE/profile http://localhost:34453/getInfo.html) 03:52:48 INFO - PROCESS | 3666 | __metrics Screen width/height:1600/1200 03:52:48 INFO - PROCESS | 3666 | colorDepth:24 03:52:48 INFO - PROCESS | 3666 | Browser inner width/height: 1024/697 03:52:48 INFO - PROCESS | 3666 | __metrics 03:52:49 INFO - PROCESS | 3666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:52:49 INFO - PROCESS | 3666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:52:49 INFO - PROCESS | 3666 | console.error: PushService: 03:52:49 INFO - PROCESS | 3666 | stateChangeProcessEnqueue: Error transitioning state 03:52:49 INFO - PROCESS | 3666 | UnknownError 03:52:50 INFO - TEST-INFO | 3666: exit 0 03:52:50 INFO - Browser initialized. 03:52:50 INFO - Running cycle 1/1 for kraken test... 03:52:50 INFO - TEST-INFO | started process 3757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4i07dE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:02 INFO - PROCESS | 3757 | RSS: Main: 144482304 03:53:02 INFO - PROCESS | 3757 | 03:53:04 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:34453/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34453/tests/kraken/driver.html?testName=audio-beat-detection) 03:53:05 INFO - PROCESS | 3757 | RSS: Main: 186671104 03:53:05 INFO - PROCESS | 3757 | 03:53:07 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:34453/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34453/tests/kraken/driver.html?testName=audio-dft) 03:53:08 INFO - PROCESS | 3757 | RSS: Main: 175906816 03:53:08 INFO - PROCESS | 3757 | 03:53:11 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:34453/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34453/tests/kraken/driver.html?testName=audio-fft) 03:53:11 INFO - PROCESS | 3757 | RSS: Main: 267390976 03:53:11 INFO - PROCESS | 3757 | 03:53:13 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:34453/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34453/tests/kraken/driver.html?testName=audio-oscillator) 03:53:14 INFO - PROCESS | 3757 | RSS: Main: 173723648 03:53:14 INFO - PROCESS | 3757 | 03:53:16 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:34453/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34453/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:53:17 INFO - PROCESS | 3757 | RSS: Main: 175243264 03:53:17 INFO - PROCESS | 3757 | 03:53:20 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:34453/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34453/tests/kraken/driver.html?testName=imaging-darkroom) 03:53:20 INFO - PROCESS | 3757 | RSS: Main: 211730432 03:53:20 INFO - PROCESS | 3757 | 03:53:24 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:34453/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34453/tests/kraken/driver.html?testName=imaging-desaturate) 03:53:24 INFO - PROCESS | 3757 | RSS: Main: 210374656 03:53:24 INFO - PROCESS | 3757 | 03:53:27 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:34453/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34453/tests/kraken/driver.html?testName=json-parse-financial) 03:53:28 INFO - PROCESS | 3757 | RSS: Main: 209702912 03:53:28 INFO - PROCESS | 3757 | 03:53:29 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:34453/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34453/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:53:30 INFO - PROCESS | 3757 | RSS: Main: 172265472 03:53:30 INFO - PROCESS | 3757 | 03:53:31 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:34453/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34453/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:53:32 INFO - PROCESS | 3757 | RSS: Main: 179433472 03:53:32 INFO - PROCESS | 3757 | 03:53:34 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:34453/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34453/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:53:35 INFO - PROCESS | 3757 | RSS: Main: 188805120 03:53:35 INFO - PROCESS | 3757 | 03:53:37 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:34453/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34453/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:53:38 INFO - PROCESS | 3757 | RSS: Main: 197181440 03:53:38 INFO - PROCESS | 3757 | 03:53:41 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:34453/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34453/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:53:41 INFO - PROCESS | 3757 | RSS: Main: 193286144 03:53:41 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | Cycle 1(1): loaded http://localhost:34453/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34453/tests/kraken/driver.html?testName=ai-astar) 03:53:43 INFO - PROCESS | 3757 | RSS: Main: 244400128 03:53:43 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | __start_tp_report 03:53:43 INFO - PROCESS | 3757 | _x_x_mozilla_page_load 03:53:43 INFO - PROCESS | 3757 | _x_x_mozilla_page_load_details 03:53:43 INFO - PROCESS | 3757 | |i|pagename|runs| 03:53:43 INFO - PROCESS | 3757 | |0;ai-astar;107;111;111;110;113;111;111;111;110;110 03:53:43 INFO - PROCESS | 3757 | |1;audio-beat-detection;144;115;121;147;120;115;123;115;153;116 03:53:43 INFO - PROCESS | 3757 | |2;audio-dft;161;161;163;161;161;162;162;161;159;160 03:53:43 INFO - PROCESS | 3757 | |3;audio-fft;74;76;74;113;76;74;75;76;96;75 03:53:43 INFO - PROCESS | 3757 | |4;audio-oscillator;81;80;119;81;82;80;105;81;82;113 03:53:43 INFO - PROCESS | 3757 | |5;imaging-gaussian-blur;117;116;117;118;117;117;117;116;117;117 03:53:43 INFO - PROCESS | 3757 | |6;imaging-darkroom;146;145;145;146;146;145;146;146;146;145 03:53:43 INFO - PROCESS | 3757 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;95;95 03:53:43 INFO - PROCESS | 3757 | |8;json-parse-financial;49;48;50;48;49;51;49;48;49;50 03:53:43 INFO - PROCESS | 3757 | |9;json-stringify-tinderbox;59;60;59;59;61;60;60;60;60;60 03:53:43 INFO - PROCESS | 3757 | |10;stanford-crypto-aes;74;74;74;78;83;74;74;93;76;73 03:53:43 INFO - PROCESS | 3757 | |11;stanford-crypto-ccm;132;124;122;130;127;121;123;124;164;121 03:53:43 INFO - PROCESS | 3757 | |12;stanford-crypto-pbkdf2;156;159;161;157;158;156;155;158;154;157 03:53:43 INFO - PROCESS | 3757 | |13;stanford-crypto-sha256-iterative;62;62;64;61;63;64;61;62;61;59 03:53:43 INFO - PROCESS | 3757 | __end_tp_report 03:53:43 INFO - PROCESS | 3757 | __start_cc_report 03:53:43 INFO - PROCESS | 3757 | _x_x_mozilla_cycle_collect,1594 03:53:43 INFO - PROCESS | 3757 | __end_cc_report 03:53:43 INFO - PROCESS | 3757 | __startTimestamp1478084023560__endTimestamp 03:53:43 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | ------- Summary: start ------- 03:53:43 INFO - PROCESS | 3757 | Number of tests: 14 03:53:43 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.51 (1.4%) stddev-sans-first:0.93 03:53:43 INFO - PROCESS | 3757 | Values: 107.0 111.0 111.0 110.0 113.0 111.0 111.0 111.0 110.0 110.0 03:53:43 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:122.00 stddev:14.98 (12.3%) stddev-sans-first:14.55 03:53:43 INFO - PROCESS | 3757 | Values: 144.0 115.0 121.0 147.0 120.0 115.0 123.0 115.0 153.0 116.0 03:53:43 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 03:53:43 INFO - PROCESS | 3757 | Values: 161.0 161.0 163.0 161.0 161.0 162.0 162.0 161.0 159.0 160.0 03:53:43 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.50 stddev:13.09 (17.3%) stddev-sans-first:13.65 03:53:43 INFO - PROCESS | 3757 | Values: 74.0 76.0 74.0 113.0 76.0 74.0 75.0 76.0 96.0 75.0 03:53:43 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:81.00 stddev:15.51 (19.1%) stddev-sans-first:16.07 03:53:43 INFO - PROCESS | 3757 | Values: 81.0 80.0 119.0 81.0 82.0 80.0 105.0 81.0 82.0 113.0 03:53:43 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:53:43 INFO - PROCESS | 3757 | Values: 117.0 116.0 117.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 03:53:43 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:53:43 INFO - PROCESS | 3757 | Values: 146.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 03:53:43 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:53:43 INFO - PROCESS | 3757 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 03:53:43 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | [#8] json-parse-financial Cycles:10 Average:49.10 Median:49.00 stddev:0.99 (2.0%) stddev-sans-first:1.05 03:53:43 INFO - PROCESS | 3757 | Values: 49.0 48.0 50.0 48.0 49.0 51.0 49.0 48.0 49.0 50.0 03:53:43 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 03:53:43 INFO - PROCESS | 3757 | Values: 59.0 60.0 59.0 59.0 61.0 60.0 60.0 60.0 60.0 60.0 03:53:43 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:75.00 stddev:6.27 (8.4%) stddev-sans-first:6.54 03:53:43 INFO - PROCESS | 3757 | Values: 74.0 74.0 74.0 78.0 83.0 74.0 74.0 93.0 76.0 73.0 03:53:43 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:125.50 stddev:12.92 (10.3%) stddev-sans-first:13.65 03:53:43 INFO - PROCESS | 3757 | Values: 132.0 124.0 122.0 130.0 127.0 121.0 123.0 124.0 164.0 121.0 03:53:43 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.10 Median:157.50 stddev:2.02 (1.3%) stddev-sans-first:2.11 03:53:43 INFO - PROCESS | 3757 | Values: 156.0 159.0 161.0 157.0 158.0 156.0 155.0 158.0 154.0 157.0 03:53:43 INFO - PROCESS | 3757 | 03:53:43 INFO - PROCESS | 3757 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.52 (2.5%) stddev-sans-first:1.62 03:53:43 INFO - PROCESS | 3757 | Values: 62.0 62.0 64.0 61.0 63.0 64.0 61.0 62.0 61.0 59.0 03:53:43 INFO - PROCESS | 3757 | -------- Summary: end -------- 03:53:43 INFO - PROCESS | 3757 | 03:53:44 INFO - TEST-INFO | 3757: exit 0 03:53:44 INFO - TEST-OK | kraken | took 59517ms 03:53:44 INFO - SUITE-END | took 1173s 03:53:44 INFO - Completed test suite (00:19:33) 03:53:44 INFO - javascript benchmark 03:53:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3150.2911844834916, 3199.664035276296, 3210.0851257391632, 3230.3377807549455, 3247.935041299174, 5622.971885140573, 5684.062129748591, 5696.715164241792, 5711.628744131628, 5726.3700992890745, 5635.098384258519, 5654.208410822488, 5672.950504156734, 5723.456271654186, 5726.770929162829, 5089.491050894918, 5117.411497677777, 5145.0, 5146.922796158061, 5194.58443324535, 5032.6477146599755, 5243.632945693803, 5244.344456942882, 5248.947510524903, 5266.841994740144, 5030.396352437712, 5116.334876466054, 5141.228815677659, 5151.278820965068, 5184.326037615105, 5148.485151484841, 5176.7929282828645, 5179.249008893727, 5230.450802665703, 5260.92108618371, 5104.64267501275, 5145.25393817898, 5220.738963051832, 5230.320058392423, 5264.15773476242, 5435.945640543583, 5483.396826349099, 5485.917711234335, 5538.75075621598, 5556.91664625031, 5965.791197308116, 5974.731137098797, 5986.940130598726, 6056.031035034417, 6057.061155520902, 6076.240469941257, 6094.542909281821, 6116.785912493086, 6117.265928088658, 6124.877502449971, 5449.0, 5468.425815289377, 5556.833295001197, 5595.972020139873, 5623.0, 6134.355892631299, 6168.722407491674, 6175.536834737323, 6176.197094377702, 6180.5673602848265, 5945.494632956161, 5946.137810017523, 5947.1079338099635, 5952.375000624958, 5960.970195148997, 5814.244148260699, 5871.4715675589405, 5938.079597662369, 5996.790112346047, 5997.880042399215, 6004.789832355847, 6012.699365031818, 6020.247469066367, 6021.729022194012, 6039.63762174271, 5971.4924231439945, 6027.78902738402, 6036.426539478743, 6036.879262414727, 6056.727447264883, 4483.686141970031, 4516.096780643885, 4577.8397756078375, 4609.078184363141, 4643.2802915548145, 4102.097538541516, 4114.259433302034, 4135.875923722293, 4138.52406973196, 4164.104717485695, 5706.629069110578, 5718.513926316226, 5720.742566584514, 5724.398938111438, 5726.169705392695, 5855.912161317584, 5910.379410161957, 6001.339852616209, 6042.519582702266, 6060.212172417646, 5676.971615141898, 5749.798757043567, 5758.971205144031, 5780.768769249267, 5796.333421656479, 5252.369715634149, 5267.604929630293, 5268.841934741964, 5270.051390749702, 5273.419923808378, 6068.0, 6114.6942652868065, 6245.250569931546, 6289.905651415233, 6302.054691796267, 6079.3312735598165, 6123.099607468126, 6126.30393285589, 6128.050152226412, 6134.803982731443, 6299.149614802126, 6305.747770089329, 6306.653134077486, 6307.05394190875, 6308.905366419599, 5720.513756330592, 5987.311459182076, 5987.401259873977, 5989.670568118795, 5995.0, 5830.183774271521, 5943.940560594338, 5998.940010599838, 6032.909506357496, 6051.33435322123, 5899.852503687443, 5913.645181289136, 5944.910826337522, 5947.434993675594, 5950.523958083257, 5941.524678025661, 5941.732622031933, 5946.0, 5948.345681975065, 5950.464458198783, 5609.747561359667, 5728.627639203439, 5795.33353664334, 5837.328707198557, 5847.8245652630485, 5966.105084237399, 5971.820845374646, 5971.91042134377, 5977.820665380045, 5991.67045812467, 5604.719764011702, 5817.0983497557945, 5830.679312637845, 5830.795922142875, 5834.416558344132], "value": 5562.978286165947, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.8920194365013, 615.7783198048703, 663.5521023309265, 665.9034440006197, 679.0493309366889, 34346.0, 34962.82518587407, 44715.32927006093, 44765.77617111918, 44951.55048449514, 46614.533854661444, 46957.0, 47041.0, 47062.29406558904, 47065.52934470654, 9238.30712696547, 9389.76525586859, 9399.718008459757, 9402.247820174369, 9408.764780880465, 8627.137286271354, 8811.383203175781, 8828.779280518007, 9260.0, 11005.229633925628, 11136.053435457996, 11430.08559315257, 11449.599264025761, 11498.310101393901, 11506.71233219172, 11177.273477223995, 11209.719757006058, 11222.607208747655, 11237.101031917427, 11237.494312755864, 8502.234798868132, 8734.650613975433, 10675.41285229312, 11077.003069723683, 11151.553937842476, 42496.15007699829, 45607.0, 45652.315215271796, 45666.0, 45670.54329456696, 3634.3821550336506, 3708.295423869456, 3797.639224273717, 4153.169366126786, 4171.707980441371, 33747.32505349879, 34423.0, 34424.48363274553, 34516.0, 34555.654443455496, 4543.204939135638, 4597.448306203243, 4656.557627025427, 4688.64835137366, 4712.151812673717, 361473.0, 362374.7525049511, 362861.0, 363051.9999999974, 363555.0, 62626.686866565375, 62758.0, 63036.36963630397, 63255.367446325865, 63480.0, 67187.66406167937, 67245.32754672489, 67327.0, 67414.32585674178, 67429.32570674329, 18908.149133289036, 19540.0, 19691.11389987454, 19691.704624430644, 19701.507462313555, 15450.690986180214, 15597.532074037797, 15603.297851596706, 15604.453844115402, 15608.14155221451, 16493.752593711102, 16919.154042297836, 18000.279988800303, 18413.81586184148, 18592.81407185911, 6265.0, 6322.703845711618, 6464.191976003, 6482.870342593122, 6500.772472963424, 1030.6186710916859, 1046.529061922138, 1067.556963860005, 1131.9830202546968, 1171.3616079236836, 33644.83177584096, 33881.491777623356, 34254.48618270728, 34310.31379372399, 34445.82777086098, 1147.1912301827192, 1148.586508856811, 1183.4851839449866, 1192.9642110736693, 1302.1861336664585, 17467.82532174662, 18275.817241827677, 18282.360117395827, 18337.266509339745, 18489.72265415993, 534877.0, 537651.0, 537678.0, 538441.0, 538943.0, 61899.07151392733, 62013.0, 62036.68981655063, 62129.37870621326, 62153.689231554454, 1277.6486466221863, 1317.3939987605618, 1364.6929440875922, 1382.9377678004514, 1404.206623257856, 30596.951587860127, 34896.30207395787, 35150.472742908365, 35695.64304357027, 35782.105447364025, 52941.7352913233, 53503.19745203903, 53512.0, 53526.73236633792, 53603.73198133984, 395347.0, 396488.0, 397446.0, 398440.0, 398543.0, 43864.561354387326, 44754.0, 45187.0, 45312.773436133924, 45507.54492455033, 50353.49646503488, 51118.74440627773, 51181.48818511916, 51471.48528514667, 51585.484145158065, 43200.56799431965, 43248.351274730274, 43830.12339753251, 45339.31991020203, 45555.0, 42474.0, 42910.356344655476, 43560.56439435565, 43755.34366984434, 43991.78004109959, 39098.0, 39617.2076558473, 44394.55605443904, 45230.773846130556, 45376.0, 36527.08682282964, 38871.0, 39223.60776392314, 39702.60297397104, 39751.403728944664, 29048.857301144075, 29453.0, 29794.255143621584, 29853.55219671663, 30005.099847004625], "value": 21641.864212228033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.64501546039, 387.6472410106805, 404.3086322388715, 413.5223816491952, 423.55526696968195, 14016.649583760398, 16458.670826583475, 20412.79587204131, 20450.07974641141, 21151.15395384183, 19775.70336444951, 20122.396328110142, 20130.597388052265, 20357.898210508964, 20443.386698399034, 5772.740226689799, 5776.220210271623, 5785.537157027448, 5854.473097421232, 6019.819405417845, 4266.871993840175, 4461.776911154446, 5779.248697669318, 5858.209141765849, 5860.179574859523, 4482.789646795363, 6171.13604095427, 6446.226452825644, 6451.225852897635, 6581.210254769434, 6342.556021078503, 6356.841078973016, 6388.776392826228, 6407.103005579223, 6558.8688226235445, 5696.971515142439, 5699.145128230757, 5699.772009119631, 5704.914426283609, 5709.8287051388525, 23412.0, 23918.043278268848, 24069.518609627885, 24228.515429691484, 24458.755412445826, 2367.4081479630095, 2534.2397280815867, 2843.971560284391, 3253.9186520336943, 3336.566246387954, 10827.512761925733, 11192.552297908074, 11621.825672614917, 14749.77875331871, 15471.226438678133, 1963.2539634938776, 2026.8479864010258, 2069.3895300886275, 2108.293721603249, 2193.7696541863033, 85329.57335213346, 88778.6683199759, 90787.54606226926, 92217.0, 93460.53269733608, 11283.210175287815, 11347.886521134847, 11450.19848610606, 11481.655550333504, 11568.76862462746, 16216.675666486604, 16219.918900405422, 16220.432284869972, 16221.188940552925, 16249.187540622921, 8513.82972340562, 8571.657133714707, 8998.191393424344, 9068.81862362749, 9080.409773364841, 8237.50574965504, 8788.956055219684, 8857.0, 9001.63993440255, 9071.138241867144, 4892.902141957141, 4987.725675087832, 5026.84919452417, 5095.87260318495, 5112.156494178494, 2008.7589489261381, 2020.4443777960885, 2052.548439343342, 2052.7434070741156, 2099.3387083068783, 975.6877799104218, 1011.5903059260864, 1057.1965306367063, 1061.3419679798574, 1088.1566785741113, 18657.53356166107, 20283.391498255078, 20401.489962750755, 20432.387028389174, 20593.07331170101, 1000.4497526360473, 1002.3334482569155, 1032.566322144701, 1057.143713591993, 1071.566015763617, 10598.735031624272, 11238.157138214667, 11373.317600943805, 11463.484143213574, 11504.137189710806, 513744.0, 522678.0, 528250.0, 540763.0, 552904.0, 61329.999999999105, 64737.35262647313, 72847.0, 100450.49774751226, 104077.0, 1005.6882366466418, 1037.1443559063803, 1062.0812996757904, 1074.3070719385953, 1088.5700148441479, 17685.557861053578, 17708.468745937644, 18169.45491635253, 18377.448676539727, 18443.907780461548, 44026.559734402246, 44214.778926105166, 44594.554054460335, 45405.77297113493, 46326.220426774504, 59132.70433647804, 61789.382106180165, 62907.0, 63213.0, 64520.677396612715, 8798.47209167452, 8847.0, 8968.506732129796, 9025.954870225607, 9171.794693362197, 13646.454141834216, 13733.0, 13791.448342066205, 13852.653683657585, 13983.091099078527, 11818.172727908965, 12139.453724582238, 12150.392480375769, 12281.201721888048, 12750.48998040068, 11572.132090093444, 11756.412179391167, 12138.33239171854, 12177.939110304393, 12236.87763122393, 12032.578859739868, 12155.81766273489, 12175.817362739743, 12419.254844709347, 12469.127161098637, 7836.255555722198, 8279.54462504568, 8343.54110523927, 8912.688055918012, 9106.271498280254, 9031.593578288861, 11839.82240266414, 12040.518379264731, 12161.087918405978, 12231.0], "value": 9667.043718114872, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1548.1639914446196, 1548.4967385599682, 1693.983060169398, 1794.928202871885, 1818.7908390535092, 8130.878036829437, 8447.91552084479, 8802.427842190253, 9415.105564971334, 9415.340926135183, 8751.124887511261, 9053.864192037125, 9070.818583628323, 9236.67671631493, 9243.399179053356, 2482.3173627252513, 2512.886920088591, 2515.1448507507444, 2515.434027343851, 2516.3960649444093, 2131.275366375432, 2204.34971683353, 2423.5274121546304, 2463.1255904154036, 2551.362159460135, 2471.7404672509397, 2492.0654754467073, 2509.2723110298084, 2509.3475696318997, 2520.5337012652717, 2391.976080239193, 2464.963025554618, 2467.3338198686433, 2468.827182097254, 2470.110760126353, 2395.3173345596597, 2405.206281926977, 2425.50277193175, 2438.829281950264, 2439.6096624539987, 9241.260699144052, 9280.860787088199, 9296.535173241311, 9311.394759340621, 9333.160015598562, 5400.891982160335, 5548.0845660465975, 5570.498655121018, 5619.466150715716, 5623.100303951389, 3600.8919732407808, 3628.8548458061646, 3698.389765688685, 3704.3887758519813, 3710.18375957289, 1137.3573930729194, 1179.6048323811533, 1195.0618764270093, 1200.6518109748163, 1225.583301677425, 12564.183328083645, 12628.494860205581, 12638.620841374774, 12669.239845609292, 12721.681957951032, 4750.287456881495, 4813.085513752446, 4914.0908931847725, 4954.157793175169, 5058.291839142523, 10678.252522323519, 10687.412192329497, 10702.785944281226, 10706.678799636024, 10708.411037393018, 5559.499645031886, 5571.916421253684, 5576.302962129734, 5577.191307260425, 5577.470140336662, 5032.924506132411, 5090.185570308733, 5122.667026643331, 5126.512981266774, 5148.150555158431, 4150.813213405404, 4178.477690288714, 4250.511191212988, 4259.084296876186, 4296.484421869333, 1271.3071376100047, 1316.7300703355788, 1318.6703324168957, 1322.9404676789568, 1362.768329384007, 944.2729098594044, 1017.9949100254452, 1027.1782573940818, 1039.0752230514847, 1041.6250149946013, 6311.495080393649, 6481.449076828428, 6492.123563318892, 6539.705713242915, 6621.370969757865, 1020.1685626214611, 1040.547361897577, 1040.927135100551, 1043.817331966918, 1060.4962642744788, 4455.353973673799, 4468.106378724203, 4545.909081818345, 4581.106684196549, 4653.418322709661, 10957.671269861918, 11443.256188347897, 11449.942750286194, 11486.655400338002, 11489.0, 10800.405977671146, 11274.323540587427, 11294.096472282197, 11351.318920864775, 11386.373749443694, 8423.326133909273, 8632.91367086321, 8640.135986401436, 8652.437591556529, 8656.22094011542, 6332.240131184288, 6414.262359828679, 6428.325025872216, 6482.773102941374, 6532.248791388861, 10289.639862604772, 10581.31221470602, 10588.1000114988, 10719.785604287714, 10741.355518668592, 10918.836217456586, 10990.780184396428, 11024.007839294502, 11040.834387484034, 11052.668419947415, 8140.511569305861, 8157.55133467665, 8250.216229458192, 8309.293710034473, 8324.708635197981, 8832.205101540636, 8848.734537963614, 8924.286057115285, 8947.328950328621, 8953.910460895308, 7910.920890791019, 8074.313683336982, 8096.51420914747, 8140.715074972348, 8189.631466583899, 7673.654685539276, 7856.175101614477, 7912.683492660229, 7973.760787176394, 8103.878441823495, 7409.740659076906, 7466.552006879605, 7510.511816731895, 7530.058742657168, 7531.0, 5182.300389447527, 5187.170052791535, 5223.973880130575, 5286.788528458972, 5554.1391084381985, 5491.0, 5639.154126881001, 5639.464250896158, 5674.404187560247, 5703.657780533182], "value": 4908.371091626499, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.7032670596463, 340.74614412262866, 347.52389226759345, 349.8076058168007, 351.04690764574184, 5589.608727389079, 5592.944070559298, 5616.466435688613, 5680.403557626451, 5695.857603559903, 5191.092987926763, 5331.706756128411, 5339.279197308372, 5351.822599028217, 5543.501084902358, 4198.286291330481, 4237.364395340708, 4269.097014030458, 4350.064736081742, 4402.647788176938, 4348.369486424466, 4361.411209486726, 4387.648988080962, 4387.990762124713, 4409.735415875058, 4136.524299705542, 4312.310030395138, 4323.610875021247, 4341.066670665807, 4386.758728269944, 4274.252005898971, 4282.415506262702, 4283.4431523902, 4284.700070995032, 4325.675574331937, 3793.3930571108767, 3793.8103094845146, 3804.345109877212, 3807.1814559869485, 3807.257584770971, 5245.8459138989365, 5345.7594408251725, 5437.918431223496, 5444.972775136139, 5446.564274858002, 4903.651495838637, 4958.834673851642, 4960.627952903511, 4963.329950456714, 4970.403551573834, 5719.656820590778, 5762.481376676077, 5798.681072541009, 5818.5926985111055, 5836.941630583725, 4039.9596004039877, 4114.382842573608, 4135.276326642826, 4140.7577726681875, 4162.354835000579, 5873.618214816066, 5908.670549126455, 5912.763489460416, 5933.851653708649, 5971.28344598651, 4110.280700877334, 4134.834606615762, 4146.150039241948, 4172.979135104305, 4176.227397931392, 4053.6959728020515, 4197.916041679149, 4213.936790948138, 4225.64082053029, 4230.238557059697, 4788.066327066189, 4791.616670666338, 4794.232922732416, 4807.0, 4807.567318941312, 5769.8557536061935, 5774.711264436845, 5830.38780928005, 5850.268716410449, 5863.70681465925, 1390.3812803302433, 1458.7228426598913, 1470.6764511807598, 1478.1722235548127, 1482.5626440200167, 939.1406862720671, 940.6049459227141, 946.6592026870321, 958.5494817435793, 963.5278713430368, 4855.902881942341, 4858.319835223072, 4886.486918873467, 4910.551387340743, 4912.336834527365, 5099.541041306226, 5134.460881607452, 5158.638895277295, 5159.535641792257, 5181.274621552986, 4845.473675792115, 4858.95141048585, 4883.633727470454, 4908.0, 5228.764705588258, 3136.43544162053, 3172.255259607207, 3173.2066983254185, 3175.539546765706, 3181.236503239206, 6152.323244443108, 6161.319825875758, 6176.455886028493, 6182.814515564541, 6200.751969921243, 5973.133895585116, 6046.365131661112, 6084.756609735649, 6084.8174554762545, 6108.144859719643, 6087.96956015226, 6115.0, 6116.3577824328695, 6141.219046476472, 6149.692515374213, 5793.768249270151, 5859.736311865891, 5930.762769489172, 5951.940480595139, 5994.160817485468, 5817.418258174149, 5844.883102338014, 5849.268841394825, 5862.355140934579, 5892.263467066617, 5979.3123790762875, 6129.693515324305, 6156.846078848064, 6174.44430001302, 6177.166082578794, 3951.7628942263555, 4187.706860519735, 4197.727147735387, 4207.305794543989, 4213.452251207324, 5727.336788393417, 5773.162891380643, 5915.260592425947, 5919.378465261258, 5946.583739138218, 5793.94206057934, 5812.360640329645, 5814.273215848019, 5839.562032847469, 5846.210761547137, 5589.748461319332, 5712.228849105318, 5740.311162660508, 5741.25363702716, 5811.738471768696, 5648.265725455664, 5669.716514174357, 5703.62926409782, 5728.312602487728, 5745.816589695889, 5587.74855131512, 5796.59423840344, 5816.621919575214, 5824.359320474659, 5857.882842343044, 5591.888162236651, 5597.860053498695, 5635.577331700057, 5643.492085712305, 5685.260916080883], "value": 4352.711145253414, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.2247519905691, 837.9860368953566, 845.4462327175698, 850.1540966738097, 919.7124026363086, 14945.626359341022, 15018.474353397633, 15163.54509364718, 15292.541223763277, 15333.539993800176, 13218.801717974238, 15293.92353038236, 15394.923025384858, 15458.0, 15485.458008969688, 853.0914575976597, 867.0679020053436, 875.8335916175906, 876.548577482597, 877.0308808766317, 869.3653632848025, 872.8385248728973, 873.8470767615673, 874.5015341255487, 874.7725591346232, 916.0701887584107, 917.4403613795579, 918.481058202117, 921.9539023048854, 921.9585118669676, 912.434290739739, 915.5696822493418, 915.624593916491, 915.7252824152761, 915.7893684452547, 673.85848971716, 674.2010717299967, 674.2246416620876, 674.3391476353202, 674.6862708840364, 14630.341634626468, 14746.926265368604, 14758.335874885655, 14781.556553303311, 14791.852081479263, 13584.864151358459, 13819.585412437644, 13875.37560809766, 13965.650858728512, 13986.440542378292, 12077.93961030198, 12149.392530373447, 12618.621441356681, 12794.232346059267, 12820.166689165268, 3927.3897701942064, 4027.335489644205, 4044.4539987101657, 4084.979575102135, 4085.9387109193385, 52977.2053419199, 54708.72645636746, 69942.0, 73441.6327918357, 85330.0, 11232.49453774582, 11252.549898004152, 11472.0, 12882.227066376048, 12883.677908052186, 22049.0, 22091.447713806963, 22306.665400019014, 22371.44071398228, 22393.552128957657, 8817.118288171132, 8837.513936733541, 8951.104889510996, 8978.955105224562, 9144.3598948073, 4935.111679897653, 5077.238414237894, 5159.25190847325, 5170.663906846043, 5305.946940530623, 3848.2688289224957, 4003.3994900764537, 4004.3593025115842, 4006.579309172553, 4007.0182805212326, 657.9309172536815, 659.1694464974167, 662.7978466567744, 676.3608390071336, 694.1462001737891, 671.583618156746, 685.9279775623488, 715.9606221657755, 792.3574877782545, 793.5556088590408, 10196.847047294297, 10582.417967011734, 10766.0, 10830.296030757976, 10989.780204395867, 788.1645455816853, 792.5878543157526, 799.3645052183529, 809.3606051219589, 824.3652387661587, 5347.465253474621, 5430.348358197041, 5471.972640136853, 5486.3690675572025, 5535.446455354432, 76643.61678191573, 78227.60886195532, 109807.45096274467, 121983.39008305079, 134770.0, 111924.4403777976, 113624.0, 115827.42086289515, 115995.0, 118083.0, 72537.91193132107, 80324.59837700774, 82824.58587707144, 85723.57138214394, 90854.99999999868, 10472.947635261775, 10522.75047941611, 10582.470876455993, 10582.470876455993, 10843.186760993114, 54209.0, 55538.628728520634, 55590.72204638951, 55672.0, 56205.0, 77428.0, 78392.0, 81244.0, 81337.59331203306, 84637.57681211554, 13893.166410015432, 13894.553742802207, 14207.431702731776, 14356.928215358856, 14397.64005899861, 15601.765973510634, 15822.129782862054, 15826.60433489172, 15937.0, 16162.595935101717, 15183.620409489851, 15615.921920390325, 15622.375104995674, 16863.325466981183, 16878.83121168822, 15131.470398536, 15361.645158239691, 15362.846371536141, 15629.76555351648, 15630.0, 14288.42846286137, 15135.545933622008, 15164.24178791034, 15449.150296733338, 15572.377104915677, 12473.126881118234, 12510.18683785551, 12517.311547864954, 13081.67295817574, 13333.333333333489, 12023.81964270554, 12950.611481655566, 12956.740865182832, 13010.479580816662, 13035.15271507349], "value": 8054.756231094336, "unit": "score"}], "name": "dromaeo_css", "value": 7649.181857975679, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 111.0, 110.0, 113.0, 111.0, 111.0, 111.0, 110.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 115.0, 121.0, 147.0, 120.0, 115.0, 123.0, 115.0, 153.0, 116.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 161.0, 161.0, 162.0, 162.0, 161.0, 159.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 113.0, 76.0, 74.0, 75.0, 76.0, 96.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 119.0, 81.0, 82.0, 80.0, 105.0, 81.0, 82.0, 113.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 50.0, 48.0, 49.0, 51.0, 49.0, 48.0, 49.0, 50.0], "value": 49.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 78.0, 83.0, 74.0, 74.0, 93.0, 76.0, 73.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 124.0, 122.0, 130.0, 127.0, 121.0, 123.0, 124.0, 164.0, 121.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 161.0, 157.0, 158.0, 156.0, 155.0, 158.0, 154.0, 157.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 64.0, 61.0, 63.0, 64.0, 61.0, 62.0, 61.0, 59.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1461.1999999999998, "alertThreshold": 2.0}]} 03:53:44 INFO - Return code: 0 03:53:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:53:44 INFO - # TBPL SUCCESS # 03:53:44 INFO - Running post-action listener: _resource_record_post_action 03:53:44 INFO - [mozharness: 2016-11-02 10:53:44.875282Z] Finished run-tests step (success) 03:53:44 INFO - Running post-run listener: _resource_record_post_run 03:53:44 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 2134016; Write bytes: 370139136; Read time: 500; Write time: 229884 03:53:44 INFO - TinderboxPrint: CPU usage
13.0% 03:53:44 INFO - TinderboxPrint: I/O read bytes / time
2,134,016 / 500 03:53:44 INFO - TinderboxPrint: I/O write bytes / time
370,139,136 / 229,884 03:53:44 INFO - TinderboxPrint: CPU idle
8,266.3 (87.0%) 03:53:44 INFO - TinderboxPrint: CPU user
1,188.4 (12.5%) 03:53:44 INFO - TinderboxPrint: Swap in / out
0 / 0 03:53:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118743040; Read time: 0; Write time: 73984 03:53:44 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 250503168; Read time: 20; Write time: 155824 03:53:45 INFO - Running post-run listener: _upload_blobber_files 03:53:45 INFO - Blob upload gear active. 03:53:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:53:45 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 03:53:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:53:45 INFO - (blobuploader) - INFO - Open directory for files ... 03:53:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:53:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:53:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:49 INFO - (blobuploader) - INFO - Done attempting. 03:53:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:53:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:53:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:49 INFO - (blobuploader) - INFO - Done attempting. 03:53:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:53:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:53:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:50 INFO - (blobuploader) - INFO - Done attempting. 03:53:50 INFO - (blobuploader) - INFO - Iteration through files over. 03:53:50 INFO - Return code: 0 03:53:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:53:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:53:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a7d972dbdeb06d02432d2795e6b72a32c8002ba167662af75786ab5142a2fc4cd2237302bcc1e8cbde25e19388e17d97778864f87c298c33fef035898004dcde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bfc565943dc3e80fb7b611c9c90198dfaf79ce88478ca3850e67fb91309051f7fc57e2fda4ee0dae2811479769e63cf55064bb06e9256d901b75afd697147bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c453075250679225b407ceb8d166ddd7a3bc35dc7b4c4046215cdf2b9b03d7da18998d2326e50d41a2e8edbc255244f9b90e66b501ffad88cb4c34ab1c7a6c0"} 03:53:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:53:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:53:50 INFO - Contents: 03:53:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a7d972dbdeb06d02432d2795e6b72a32c8002ba167662af75786ab5142a2fc4cd2237302bcc1e8cbde25e19388e17d97778864f87c298c33fef035898004dcde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bfc565943dc3e80fb7b611c9c90198dfaf79ce88478ca3850e67fb91309051f7fc57e2fda4ee0dae2811479769e63cf55064bb06e9256d901b75afd697147bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c453075250679225b407ceb8d166ddd7a3bc35dc7b4c4046215cdf2b9b03d7da18998d2326e50d41a2e8edbc255244f9b90e66b501ffad88cb4c34ab1c7a6c0"} 03:53:50 INFO - Running post-run listener: copy_logs_to_upload_dir 03:53:50 INFO - Copying logs to upload dir... 03:53:50 INFO - mkdir: /builds/slave/test/build/upload/logs 03:53:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.247978 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-02 03:53:50.532175) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 03:53:50.536695) ========= 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=1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063 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/sha512/a7d972dbdeb06d02432d2795e6b72a32c8002ba167662af75786ab5142a2fc4cd2237302bcc1e8cbde25e19388e17d97778864f87c298c33fef035898004dcde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bfc565943dc3e80fb7b611c9c90198dfaf79ce88478ca3850e67fb91309051f7fc57e2fda4ee0dae2811479769e63cf55064bb06e9256d901b75afd697147bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c453075250679225b407ceb8d166ddd7a3bc35dc7b4c4046215cdf2b9b03d7da18998d2326e50d41a2e8edbc255244f9b90e66b501ffad88cb4c34ab1c7a6c0"} build_url:https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/drBM0ERsT9O0Kp1G2u06nA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a7d972dbdeb06d02432d2795e6b72a32c8002ba167662af75786ab5142a2fc4cd2237302bcc1e8cbde25e19388e17d97778864f87c298c33fef035898004dcde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bfc565943dc3e80fb7b611c9c90198dfaf79ce88478ca3850e67fb91309051f7fc57e2fda4ee0dae2811479769e63cf55064bb06e9256d901b75afd697147bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c453075250679225b407ceb8d166ddd7a3bc35dc7b4c4046215cdf2b9b03d7da18998d2326e50d41a2e8edbc255244f9b90e66b501ffad88cb4c34ab1c7a6c0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 03:53:50.564557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 03:53:50.564885) ========= 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=1f5564757af27664ca02d71f000001b0-1478075950.473073-1804943063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 03:53:50.645307) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-02 03:53:50.645643) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-02 03:53:50.645941) ========= ========= Total master_lag: 0.18 =========