builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1474564815.66 results: success (0) buildid: 20160922085400 builduid: 2b4ab9304df74bd2b3b53d95c5e8fd0a revision: 6d1f666a9bc106f41aebcd45f43ea74d9f6e05d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 10:20:15.660587) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 10:20:15.661109) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 10:20:15.661396) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 10:20:15.676814) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 10:20:15.677205) ========= 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=d2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 10:20:16-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.4M=0s 2016-09-22 10:20:16 (66.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145073 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 10:20:15.836309) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 10:20:15.836634) ========= 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=d2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018670 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 10:20:15.886695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 10:20:15.887066) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 6d1f666a9bc106f41aebcd45f43ea74d9f6e05d9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 6d1f666a9bc106f41aebcd45f43ea74d9f6e05d9 --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=d2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 10:20:16,398 truncating revision to first 12 chars 2016-09-22 10:20:16,398 Setting DEBUG logging. 2016-09-22 10:20:16,398 attempt 1/10 2016-09-22 10:20:16,398 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/6d1f666a9bc1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 10:20:16,737 unpacking tar archive at: autoland-6d1f666a9bc1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.711821 ========= master_lag: 0.67 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 10:20:17.270990) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 10:20:17.271369) ========= script_repo_revision: 6d1f666a9bc106f41aebcd45f43ea74d9f6e05d9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 10:20:17.271781) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 10:20:17.272048) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 10:20:17.286699) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-22 10:20:17.287108) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:20:17 INFO - MultiFileLogger online at 20160922 10:20:17 in /builds/slave/test 10:20:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 10:20:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:20:17 INFO - {'append_to_log': False, 10:20:17 INFO - 'base_work_dir': '/builds/slave/test', 10:20:17 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 10:20:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:20:17 INFO - 'branch': 'Autoland-Non-PGO', 10:20:17 INFO - 'buildbot_json_path': 'buildprops.json', 10:20:17 INFO - 'config_files': ('talos/linux_config.py',), 10:20:17 INFO - 'default_actions': ('clobber', 10:20:17 INFO - 'read-buildbot-config', 10:20:17 INFO - 'download-and-extract', 10:20:17 INFO - 'populate-webroot', 10:20:17 INFO - 'create-virtualenv', 10:20:17 INFO - 'install', 10:20:17 INFO - 'run-tests'), 10:20:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:20:17 INFO - 'download_minidump_stackwalk': True, 10:20:17 INFO - 'download_symbols': 'ondemand', 10:20:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:20:17 INFO - 'tooltool.py': '/tools/tooltool.py', 10:20:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:20:17 INFO - '/tools/misc-python/virtualenv.py')}, 10:20:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:20:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:20:17 INFO - 'installer_path': 'installer.exe', 10:20:17 INFO - 'log_level': 'info', 10:20:17 INFO - 'log_name': 'talos', 10:20:17 INFO - 'log_to_console': True, 10:20:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:20:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:20:17 INFO - 'opt_config_files': (), 10:20:17 INFO - 'pip_index': False, 10:20:17 INFO - 'sps_profile': False, 10:20:17 INFO - 'sps_profile_interval': 0, 10:20:17 INFO - 'suite': 'dromaeojs', 10:20:17 INFO - 'system_bits': '32', 10:20:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:20:17 INFO - 'title': 'talos-linux64-ix-043', 10:20:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:20:17 INFO - 'use_talos_json': True, 10:20:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:20:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:20:17 INFO - 'work_dir': 'build'} 10:20:17 INFO - [mozharness: 2016-09-22 17:20:17.900301Z] Running clobber step. 10:20:17 INFO - Running pre-action listener: _resource_record_pre_action 10:20:17 INFO - Running main action method: clobber 10:20:17 INFO - rmtree: /builds/slave/test/build 10:20:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:20:18 INFO - Running post-action listener: _resource_record_post_action 10:20:18 INFO - [mozharness: 2016-09-22 17:20:18.361014Z] Finished clobber step (success) 10:20:18 INFO - [mozharness: 2016-09-22 17:20:18.361116Z] Running read-buildbot-config step. 10:20:18 INFO - Running pre-action listener: _resource_record_pre_action 10:20:18 INFO - Running main action method: read_buildbot_config 10:20:18 INFO - Using buildbot properties: 10:20:18 INFO - { 10:20:18 INFO - "project": "", 10:20:18 INFO - "product": "firefox", 10:20:18 INFO - "script_repo_revision": "production", 10:20:18 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 10:20:18 INFO - "repository": "", 10:20:18 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 10:20:18 INFO - "buildid": "20160922085400", 10:20:18 INFO - "pgo_build": "False", 10:20:18 INFO - "basedir": "/builds/slave/test", 10:20:18 INFO - "buildnumber": 696, 10:20:18 INFO - "slavename": "talos-linux64-ix-043", 10:20:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:20:18 INFO - "platform": "ubuntu64_hw", 10:20:18 INFO - "scheduler": "tests-autoland-linux64-talos", 10:20:18 INFO - "branch": "autoland", 10:20:18 INFO - "repo_path": "integration/autoland", 10:20:18 INFO - "revision": "6d1f666a9bc106f41aebcd45f43ea74d9f6e05d9", 10:20:18 INFO - "stage_platform": "linux64", 10:20:18 INFO - "builduid": "2b4ab9304df74bd2b3b53d95c5e8fd0a", 10:20:18 INFO - "slavebuilddir": "test" 10:20:18 INFO - } 10:20:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:20:18 INFO - Running post-action listener: _resource_record_post_action 10:20:18 INFO - [mozharness: 2016-09-22 17:20:18.363562Z] Finished read-buildbot-config step (success) 10:20:18 INFO - [mozharness: 2016-09-22 17:20:18.363652Z] Running download-and-extract step. 10:20:18 INFO - Running pre-action listener: _resource_record_pre_action 10:20:18 INFO - Running main action method: download_and_extract 10:20:18 INFO - mkdir: /builds/slave/test/build/tests 10:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:18 INFO - trying https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:20:18 INFO - Downloading https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:20:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:20:18 INFO - Downloaded 1361 bytes. 10:20:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:20:18 INFO - Using the following test package requirements: 10:20:18 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:20:18 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:20:18 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:20:18 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:18 INFO - u'jsshell-linux-x86_64.zip'], 10:20:18 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:20:18 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:20:18 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:20:18 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:20:18 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:20:18 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:20:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:20:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:20:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:20:18 INFO - Fetch https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:20:19 INFO - Expected file size: 20372989 10:20:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:20:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:20:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:20:23 INFO - Fetch https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:20:24 INFO - Expected file size: 20372989 10:20:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:20:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:20:28 INFO - Fetch https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:20:29 INFO - Expected file size: 14414059 10:20:30 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')]} 10:20:30 INFO - trying https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:20:30 INFO - Downloading https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:20:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:20:32 INFO - Downloaded 55714905 bytes. 10:20:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:20:32 INFO - mkdir: /builds/slave/test/properties 10:20:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:20:32 INFO - Writing to file /builds/slave/test/properties/build_url 10:20:32 INFO - Contents: 10:20:32 INFO - build_url:https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:20:33 INFO - Running post-action listener: _resource_record_post_action 10:20:33 INFO - Running post-action listener: set_extra_try_arguments 10:20:33 INFO - [mozharness: 2016-09-22 17:20:33.392790Z] Finished download-and-extract step (success) 10:20:33 INFO - [mozharness: 2016-09-22 17:20:33.393090Z] Running populate-webroot step. 10:20:33 INFO - Running pre-action listener: _resource_record_pre_action 10:20:33 INFO - Running main action method: populate_webroot 10:20:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:20:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:20:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:20:33 INFO - '--tppagecycles', 10:20:33 INFO - '7'], 10:20:33 INFO - 'tests': ['tsvgm']}}, 10:20:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:20:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:20:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:20:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:20:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:20:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:20:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:33 INFO - 'talos_options': ['--disable-e10s'], 10:20:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:20:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:20:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:33 INFO - 'talos_options': ['--disable-e10s'], 10:20:33 INFO - 'tests': ['damp', 'tps']}, 10:20:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:33 INFO - 'tests': ['damp', 'tps']}, 10:20:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:20:33 INFO - 'tests': ['dromaeo_dom']}, 10:20:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:20:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:20:33 INFO - 'tests': ['basic_compositor_video']}, 10:20:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:20:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:20:33 INFO - 'tests': ['a11yr', 10:20:33 INFO - 'ts_paint', 10:20:33 INFO - 'tpaint', 10:20:33 INFO - 'sessionrestore', 10:20:33 INFO - 'sessionrestore_no_auto_restore', 10:20:33 INFO - 'tabpaint']}, 10:20:33 INFO - 'other-e10s': {'tests': ['a11yr', 10:20:33 INFO - 'ts_paint', 10:20:33 INFO - 'tpaint', 10:20:33 INFO - 'sessionrestore', 10:20:33 INFO - 'sessionrestore_no_auto_restore', 10:20:33 INFO - 'tabpaint']}, 10:20:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:20:33 INFO - 'ts_paint', 10:20:33 INFO - 'tpaint', 10:20:33 INFO - 'sessionrestore', 10:20:33 INFO - 'sessionrestore_no_auto_restore', 10:20:33 INFO - 'tabpaint']}, 10:20:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:20:33 INFO - 'ts_paint', 10:20:33 INFO - 'tpaint', 10:20:33 INFO - 'sessionrestore', 10:20:33 INFO - 'sessionrestore_no_auto_restore', 10:20:33 INFO - 'tabpaint']}, 10:20:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:20:33 INFO - 'tests': ['a11yr', 10:20:33 INFO - 'ts_paint', 10:20:33 INFO - 'tpaint', 10:20:33 INFO - 'sessionrestore', 10:20:33 INFO - 'sessionrestore_no_auto_restore', 10:20:33 INFO - 'tabpaint']}, 10:20:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:20:33 INFO - 'tests': ['a11yr', 10:20:33 INFO - 'ts_paint', 10:20:33 INFO - 'tpaint', 10:20:33 INFO - 'sessionrestore', 10:20:33 INFO - 'sessionrestore_no_auto_restore', 10:20:33 INFO - 'tabpaint']}, 10:20:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:20:33 INFO - 'tests': ['tsvgx', 10:20:33 INFO - 'tsvgr_opacity', 10:20:33 INFO - 'tart', 10:20:33 INFO - 'tscrollx', 10:20:33 INFO - 'cart']}, 10:20:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:20:33 INFO - 'tsvgr_opacity', 10:20:33 INFO - 'tart', 10:20:33 INFO - 'tscrollx', 10:20:33 INFO - 'cart']}, 10:20:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:33 INFO - 'talos_options': ['--disable-e10s'], 10:20:33 INFO - 'tests': ['tp5o']}, 10:20:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:33 INFO - 'tests': ['tp5o']}, 10:20:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:33 INFO - 'talos_options': ['--disable-e10s', 10:20:33 INFO - '--xperf_path', 10:20:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:20:33 INFO - 'tests': ['tp5n']}, 10:20:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:33 INFO - 'talos_options': ['--xperf_path', 10:20:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:20:33 INFO - 'tests': ['tp5n']}}, 10:20:33 INFO - 'talos.zip': {'path': '', 10:20:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:20:33 INFO - Running post-action listener: _resource_record_post_action 10:20:33 INFO - [mozharness: 2016-09-22 17:20:33.412675Z] Finished populate-webroot step (success) 10:20:33 INFO - [mozharness: 2016-09-22 17:20:33.412765Z] Running create-virtualenv step. 10:20:33 INFO - Running pre-action listener: _resource_record_pre_action 10:20:33 INFO - Running main action method: create_virtualenv 10:20:33 INFO - Creating virtualenv /builds/slave/test/build/venv 10:20:33 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 10:20:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:20:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:20:33 INFO - Using real prefix '/usr' 10:20:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:20:34 INFO - Installing distribute.............................................................................................................................................................................................done. 10:20:35 INFO - Installing pip.................done. 10:20:35 INFO - Return code: 0 10:20:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:20: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')]} 10:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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')]} 10:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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 0x7fbad8667f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8f60>, '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 0x1bf9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', '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 10:20: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 10:20: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 10:20:35 INFO - Using env: {'DISPLAY': ':0', 10:20:35 INFO - 'HOME': '/home/cltbld', 10:20:35 INFO - 'LANG': 'en_US.UTF-8', 10:20:35 INFO - 'LANGUAGE': 'en_US:en', 10:20:35 INFO - 'LOGNAME': 'cltbld', 10:20:35 INFO - 'MAIL': '/var/mail/cltbld', 10:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:35 INFO - 'MOZ_NO_REMOTE': '1', 10:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:35 INFO - 'NO_EM_RESTART': '1', 10:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:35 INFO - 'PWD': '/builds/slave/test', 10:20:35 INFO - 'SHELL': '/bin/bash', 10:20:35 INFO - 'SHLVL': '1', 10:20:35 INFO - 'TERM': 'linux', 10:20:35 INFO - 'TMOUT': '86400', 10:20:35 INFO - 'USER': 'cltbld', 10:20:35 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', 10:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:35 INFO - '_': '/tools/buildbot/bin/python'} 10:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:36 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 10:20:36 INFO - Cleaning up... 10:20:36 INFO - Return code: 0 10:20:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:36 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 0x7fbad8667f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8f60>, '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 0x1bf9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', '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 10:20:36 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 10:20:36 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 10:20:36 INFO - Using env: {'DISPLAY': ':0', 10:20:36 INFO - 'HOME': '/home/cltbld', 10:20:36 INFO - 'LANG': 'en_US.UTF-8', 10:20:36 INFO - 'LANGUAGE': 'en_US:en', 10:20:36 INFO - 'LOGNAME': 'cltbld', 10:20:36 INFO - 'MAIL': '/var/mail/cltbld', 10:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:36 INFO - 'MOZ_NO_REMOTE': '1', 10:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:36 INFO - 'NO_EM_RESTART': '1', 10:20:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:36 INFO - 'PWD': '/builds/slave/test', 10:20:36 INFO - 'SHELL': '/bin/bash', 10:20:36 INFO - 'SHLVL': '1', 10:20:36 INFO - 'TERM': 'linux', 10:20:36 INFO - 'TMOUT': '86400', 10:20:36 INFO - 'USER': 'cltbld', 10:20:36 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', 10:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:36 INFO - '_': '/tools/buildbot/bin/python'} 10:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:36 INFO - Downloading/unpacking psutil>=3.1.1 10:20:36 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 10:20:36 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 10:20:36 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 10:20:36 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 10:20:36 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 10:20:36 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 10:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:20:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:20:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:20:38 INFO - Installing collected packages: psutil 10:20:38 INFO - Running setup.py install for psutil 10:20:38 INFO - building 'psutil._psutil_linux' extension 10:20:38 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 10:20:38 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 10:20:38 INFO - building 'psutil._psutil_posix' extension 10:20:38 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 10:20:38 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 10:20:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:20:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:20:38 INFO - Successfully installed psutil 10:20:38 INFO - Cleaning up... 10:20:38 INFO - Return code: 0 10:20:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:20: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')]} 10:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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')]} 10:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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 0x7fbad8667f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8f60>, '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 0x1bf9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', '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 10:20: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 10:20: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 10:20:38 INFO - Using env: {'DISPLAY': ':0', 10:20:38 INFO - 'HOME': '/home/cltbld', 10:20:38 INFO - 'LANG': 'en_US.UTF-8', 10:20:38 INFO - 'LANGUAGE': 'en_US:en', 10:20:38 INFO - 'LOGNAME': 'cltbld', 10:20:38 INFO - 'MAIL': '/var/mail/cltbld', 10:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:38 INFO - 'MOZ_NO_REMOTE': '1', 10:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:38 INFO - 'NO_EM_RESTART': '1', 10:20:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:38 INFO - 'PWD': '/builds/slave/test', 10:20:38 INFO - 'SHELL': '/bin/bash', 10:20:38 INFO - 'SHLVL': '1', 10:20:38 INFO - 'TERM': 'linux', 10:20:38 INFO - 'TMOUT': '86400', 10:20:38 INFO - 'USER': 'cltbld', 10:20:38 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', 10:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:38 INFO - '_': '/tools/buildbot/bin/python'} 10:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:20:39 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 10:20:39 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 10:20:39 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 10:20:39 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 10:20:39 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 10:20:39 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 10:20:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:20:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:20:41 INFO - Installing collected packages: mozsystemmonitor 10:20:41 INFO - Running setup.py install for mozsystemmonitor 10:20:41 INFO - Successfully installed mozsystemmonitor 10:20:41 INFO - Cleaning up... 10:20:41 INFO - Return code: 0 10:20:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:20:41 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')]} 10:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:41 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')]} 10:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:41 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 0x7fbad8667f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8f60>, '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 0x1bf9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', '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 10:20:41 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 10:20:41 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 10:20:41 INFO - Using env: {'DISPLAY': ':0', 10:20:41 INFO - 'HOME': '/home/cltbld', 10:20:41 INFO - 'LANG': 'en_US.UTF-8', 10:20:41 INFO - 'LANGUAGE': 'en_US:en', 10:20:41 INFO - 'LOGNAME': 'cltbld', 10:20:41 INFO - 'MAIL': '/var/mail/cltbld', 10:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:41 INFO - 'MOZ_NO_REMOTE': '1', 10:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:41 INFO - 'NO_EM_RESTART': '1', 10:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:41 INFO - 'PWD': '/builds/slave/test', 10:20:41 INFO - 'SHELL': '/bin/bash', 10:20:41 INFO - 'SHLVL': '1', 10:20:41 INFO - 'TERM': 'linux', 10:20:41 INFO - 'TMOUT': '86400', 10:20:41 INFO - 'USER': 'cltbld', 10:20:41 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', 10:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:41 INFO - '_': '/tools/buildbot/bin/python'} 10:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:41 INFO - Downloading/unpacking jsonschema==2.5.1 10:20:41 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 10:20:41 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 10:20:41 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 10:20:41 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 10:20:41 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 10:20:41 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 10:20:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:20:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20:43 INFO - Downloading functools32-3.2.3-2.tar.gz 10:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:20:43 INFO - warning: no files found matching '*.txt' 10:20:43 INFO - no previously-included directories found matching 'build' 10:20:43 INFO - no previously-included directories found matching 'dist' 10:20:43 INFO - no previously-included directories found matching '.git*' 10:20:43 INFO - Installing collected packages: jsonschema, functools32 10:20:43 INFO - Running setup.py install for functools32 10:20:43 INFO - warning: no files found matching '*.txt' 10:20:43 INFO - no previously-included directories found matching 'build' 10:20:43 INFO - no previously-included directories found matching 'dist' 10:20:43 INFO - no previously-included directories found matching '.git*' 10:20:43 INFO - Successfully installed jsonschema functools32 10:20:43 INFO - Cleaning up... 10:20:43 INFO - Return code: 0 10:20:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:20: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')]} 10:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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')]} 10:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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 0x7fbad8667f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8f60>, '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 0x1bf9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', '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 10:20: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 10:20: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 10:20:43 INFO - Using env: {'DISPLAY': ':0', 10:20:43 INFO - 'HOME': '/home/cltbld', 10:20:43 INFO - 'LANG': 'en_US.UTF-8', 10:20:43 INFO - 'LANGUAGE': 'en_US:en', 10:20:43 INFO - 'LOGNAME': 'cltbld', 10:20:43 INFO - 'MAIL': '/var/mail/cltbld', 10:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:43 INFO - 'MOZ_NO_REMOTE': '1', 10:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:43 INFO - 'NO_EM_RESTART': '1', 10:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:43 INFO - 'PWD': '/builds/slave/test', 10:20:43 INFO - 'SHELL': '/bin/bash', 10:20:43 INFO - 'SHLVL': '1', 10:20:43 INFO - 'TERM': 'linux', 10:20:43 INFO - 'TMOUT': '86400', 10:20:43 INFO - 'USER': 'cltbld', 10:20:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', 10:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:43 INFO - '_': '/tools/buildbot/bin/python'} 10:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:20:44 INFO - Cleaning up... 10:20:44 INFO - Return code: 0 10:20:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbad8667f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8f60>, '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 0x1bf9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', '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 10:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:20:44 INFO - Using env: {'DISPLAY': ':0', 10:20:44 INFO - 'HOME': '/home/cltbld', 10:20:44 INFO - 'LANG': 'en_US.UTF-8', 10:20:44 INFO - 'LANGUAGE': 'en_US:en', 10:20:44 INFO - 'LOGNAME': 'cltbld', 10:20:44 INFO - 'MAIL': '/var/mail/cltbld', 10:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:44 INFO - 'MOZ_NO_REMOTE': '1', 10:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:44 INFO - 'NO_EM_RESTART': '1', 10:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:44 INFO - 'PWD': '/builds/slave/test', 10:20:44 INFO - 'SHELL': '/bin/bash', 10:20:44 INFO - 'SHLVL': '1', 10:20:44 INFO - 'TERM': 'linux', 10:20:44 INFO - 'TMOUT': '86400', 10:20:44 INFO - 'USER': 'cltbld', 10:20:44 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', 10:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:44 INFO - '_': '/tools/buildbot/bin/python'} 10:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:44 INFO - Downloading/unpacking blobuploader==1.2.4 10:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:46 INFO - Downloading blobuploader-1.2.4.tar.gz 10:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:20:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:20:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20: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 10:20:46 INFO - Downloading docopt-0.6.1.tar.gz 10:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:20:46 INFO - Installing collected packages: blobuploader, requests, docopt 10:20:46 INFO - Running setup.py install for blobuploader 10:20:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:20:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:20:47 INFO - Running setup.py install for requests 10:20:47 INFO - Running setup.py install for docopt 10:20:47 INFO - Successfully installed blobuploader requests docopt 10:20:47 INFO - Cleaning up... 10:20:47 INFO - Return code: 0 10:20:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:47 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 0x7fbad8667f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8f60>, '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 0x1bf9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', '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 10:20:47 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 10:20:47 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 10:20:47 INFO - Using env: {'DISPLAY': ':0', 10:20:47 INFO - 'HOME': '/home/cltbld', 10:20:47 INFO - 'LANG': 'en_US.UTF-8', 10:20:47 INFO - 'LANGUAGE': 'en_US:en', 10:20:47 INFO - 'LOGNAME': 'cltbld', 10:20:47 INFO - 'MAIL': '/var/mail/cltbld', 10:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:47 INFO - 'MOZ_NO_REMOTE': '1', 10:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:47 INFO - 'NO_EM_RESTART': '1', 10:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:47 INFO - 'PWD': '/builds/slave/test', 10:20:47 INFO - 'SHELL': '/bin/bash', 10:20:47 INFO - 'SHLVL': '1', 10:20:47 INFO - 'TERM': 'linux', 10:20:47 INFO - 'TMOUT': '86400', 10:20:47 INFO - 'USER': 'cltbld', 10:20:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', 10:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:47 INFO - '_': '/tools/buildbot/bin/python'} 10:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:20:47 INFO - Running setup.py (path:/tmp/pip-ZtTl1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:20:47 INFO - Running setup.py (path:/tmp/pip-XZ3VI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:20:47 INFO - Running setup.py (path:/tmp/pip-gZfOyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:20:47 INFO - Running setup.py (path:/tmp/pip-XvfCTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:20:48 INFO - Running setup.py (path:/tmp/pip-4X1H0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:20:48 INFO - Running setup.py (path:/tmp/pip-d6t8Fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:20:48 INFO - Running setup.py (path:/tmp/pip-Hg1DDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:20:48 INFO - Running setup.py (path:/tmp/pip-LfPYnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:20:48 INFO - Running setup.py (path:/tmp/pip-iNe8Rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:20:48 INFO - Running setup.py (path:/tmp/pip-sdwJbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:20:48 INFO - Running setup.py (path:/tmp/pip-QIHYFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:20:48 INFO - Running setup.py (path:/tmp/pip-YEHFQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:20:48 INFO - Running setup.py (path:/tmp/pip-qzY2aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:20:48 INFO - Running setup.py (path:/tmp/pip-BjbNyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:48 INFO - Running setup.py (path:/tmp/pip-Ri6k9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:20:48 INFO - Running setup.py (path:/tmp/pip-FUnVlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:20:48 INFO - Running setup.py (path:/tmp/pip-9lLjuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:20:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:20:48 INFO - Running setup.py install for manifestparser 10:20:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:20:49 INFO - Running setup.py install for mozcrash 10:20:49 INFO - Running setup.py install for mozdebug 10:20:49 INFO - Running setup.py install for mozdevice 10:20:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:20:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:20:49 INFO - Running setup.py install for mozfile 10:20:49 INFO - Running setup.py install for mozhttpd 10:20:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:20:49 INFO - Running setup.py install for mozinfo 10:20:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:20:49 INFO - Running setup.py install for mozInstall 10:20:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:20:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:20:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:20:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:20:49 INFO - Running setup.py install for mozleak 10:20:49 INFO - Running setup.py install for mozlog 10:20:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:20:50 INFO - Running setup.py install for moznetwork 10:20:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:20:50 INFO - Running setup.py install for mozprocess 10:20:50 INFO - Running setup.py install for mozprofile 10:20:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:20:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:20:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:20:50 INFO - Running setup.py install for mozrunner 10:20:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:20:50 INFO - Running setup.py install for mozscreenshot 10:20:50 INFO - Running setup.py install for moztest 10:20:50 INFO - Running setup.py install for mozversion 10:20:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:20:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:20:50 INFO - Cleaning up... 10:20:50 INFO - Return code: 0 10:20:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:20: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')]} 10:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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')]} 10:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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 0x7fbad8667f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8f60>, '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 0x1bf9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', '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 10:20: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 10:20: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 10:20:50 INFO - Using env: {'DISPLAY': ':0', 10:20:50 INFO - 'HOME': '/home/cltbld', 10:20:50 INFO - 'LANG': 'en_US.UTF-8', 10:20:50 INFO - 'LANGUAGE': 'en_US:en', 10:20:50 INFO - 'LOGNAME': 'cltbld', 10:20:50 INFO - 'MAIL': '/var/mail/cltbld', 10:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:50 INFO - 'MOZ_NO_REMOTE': '1', 10:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:50 INFO - 'NO_EM_RESTART': '1', 10:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:50 INFO - 'PWD': '/builds/slave/test', 10:20:50 INFO - 'SHELL': '/bin/bash', 10:20:50 INFO - 'SHLVL': '1', 10:20:50 INFO - 'TERM': 'linux', 10:20:50 INFO - 'TMOUT': '86400', 10:20:50 INFO - 'USER': 'cltbld', 10:20:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', 10:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:50 INFO - '_': '/tools/buildbot/bin/python'} 10:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:20:51 INFO - Running setup.py (path:/tmp/pip-5jyFja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:20:51 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)) 10:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:20:51 INFO - Running setup.py (path:/tmp/pip-KuNCxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:20:51 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)) 10:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:20:51 INFO - Running setup.py (path:/tmp/pip-eYwCk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:20:51 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)) 10:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:20:51 INFO - Running setup.py (path:/tmp/pip-fFWECr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:20:51 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)) 10:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:20:51 INFO - Running setup.py (path:/tmp/pip-6tKory-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:20:51 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)) 10:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:20:51 INFO - Running setup.py (path:/tmp/pip-J0oses-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:20:51 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)) 10:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:20:51 INFO - Running setup.py (path:/tmp/pip-tcsp7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:20:51 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)) 10:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:20:51 INFO - Running setup.py (path:/tmp/pip-JKOkNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:20:51 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)) 10:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:20:51 INFO - Running setup.py (path:/tmp/pip-ZA1Y8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:20: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)) 10:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:20:51 INFO - Running setup.py (path:/tmp/pip-zlPfTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:20: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)) 10:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:20:51 INFO - Running setup.py (path:/tmp/pip-TaFPKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:20: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)) 10:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:20:51 INFO - Running setup.py (path:/tmp/pip-c6tjzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:20: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)) 10:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:20:51 INFO - Running setup.py (path:/tmp/pip-lOeTOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:20: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)) 10:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:20:51 INFO - Running setup.py (path:/tmp/pip-a2zQ9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:20:52 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)) 10:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:52 INFO - Running setup.py (path:/tmp/pip-TnjXQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:52 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)) 10:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:20:52 INFO - Running setup.py (path:/tmp/pip-8Xm0z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:20:52 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)) 10:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:20:52 INFO - Running setup.py (path:/tmp/pip-wH3XbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:20:52 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)) 10:20:52 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)) 10:20:52 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)) 10:20:52 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)) 10:20:52 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)) 10:20:52 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)) 10:20:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:20:52 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 10:20:52 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 10:20:52 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 10:20:52 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 10:20:52 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 10:20:52 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 10:20:54 INFO - Downloading blessings-1.6.tar.gz 10:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:20:54 INFO - Installing collected packages: blessings 10:20:54 INFO - Running setup.py install for blessings 10:20:54 INFO - Successfully installed blessings 10:20:54 INFO - Cleaning up... 10:20:54 INFO - Return code: 0 10:20:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:20:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:20:54 INFO - Reading from file tmpfile_stdout 10:20:54 INFO - Current package versions: 10:20:54 INFO - argparse == 1.2.1 10:20:54 INFO - blessings == 1.6 10:20:54 INFO - blobuploader == 1.2.4 10:20:54 INFO - docopt == 0.6.1 10:20:54 INFO - functools32 == 3.2.3-2 10:20:54 INFO - jsonschema == 2.5.1 10:20:54 INFO - manifestparser == 1.1 10:20:54 INFO - mozInstall == 1.12 10:20:54 INFO - mozcrash == 0.17 10:20:54 INFO - mozdebug == 0.1 10:20:54 INFO - mozdevice == 0.48 10:20:54 INFO - mozfile == 1.2 10:20:54 INFO - mozhttpd == 0.7 10:20:54 INFO - mozinfo == 0.9 10:20:54 INFO - mozleak == 0.1 10:20:54 INFO - mozlog == 3.4 10:20:54 INFO - moznetwork == 0.27 10:20:54 INFO - mozprocess == 0.23 10:20:54 INFO - mozprofile == 0.28 10:20:54 INFO - mozrunner == 6.12 10:20:54 INFO - mozscreenshot == 0.1 10:20:54 INFO - mozsystemmonitor == 0.3 10:20:54 INFO - moztest == 0.7 10:20:54 INFO - mozversion == 1.4 10:20:54 INFO - psutil == 3.1.1 10:20:54 INFO - requests == 1.2.3 10:20:54 INFO - wsgiref == 0.1.2 10:20:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:20: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')]} 10:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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')]} 10:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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 0x7fbad8667f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8f60>, '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 0x1bf9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', '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 10:20: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 10:20: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 10:20:54 INFO - Using env: {'DISPLAY': ':0', 10:20:54 INFO - 'HOME': '/home/cltbld', 10:20:54 INFO - 'LANG': 'en_US.UTF-8', 10:20:54 INFO - 'LANGUAGE': 'en_US:en', 10:20:54 INFO - 'LOGNAME': 'cltbld', 10:20:54 INFO - 'MAIL': '/var/mail/cltbld', 10:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:54 INFO - 'MOZ_NO_REMOTE': '1', 10:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:54 INFO - 'NO_EM_RESTART': '1', 10:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:54 INFO - 'PWD': '/builds/slave/test', 10:20:54 INFO - 'SHELL': '/bin/bash', 10:20:54 INFO - 'SHLVL': '1', 10:20:54 INFO - 'TERM': 'linux', 10:20:54 INFO - 'TMOUT': '86400', 10:20:54 INFO - 'USER': 'cltbld', 10:20:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', 10:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:54 INFO - '_': '/tools/buildbot/bin/python'} 10:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20: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)) 10:20: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)) 10:20: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)) 10:20: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)) 10:20: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)) 10:20: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)) 10:20: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)) 10:20: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)) 10:20: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)) 10:20: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)) 10:20: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)) 10:20:54 INFO - Cleaning up... 10:20:54 INFO - Return code: 0 10:20:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:20: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')]} 10:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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')]} 10:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20: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 0x7fbad8667f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfbca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf8f60>, '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 0x1bf9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', '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 10:20: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 10:20: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 10:20:54 INFO - Using env: {'DISPLAY': ':0', 10:20:54 INFO - 'HOME': '/home/cltbld', 10:20:54 INFO - 'LANG': 'en_US.UTF-8', 10:20:54 INFO - 'LANGUAGE': 'en_US:en', 10:20:54 INFO - 'LOGNAME': 'cltbld', 10:20:54 INFO - 'MAIL': '/var/mail/cltbld', 10:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:54 INFO - 'MOZ_NO_REMOTE': '1', 10:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:54 INFO - 'NO_EM_RESTART': '1', 10:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:54 INFO - 'PWD': '/builds/slave/test', 10:20:54 INFO - 'SHELL': '/bin/bash', 10:20:54 INFO - 'SHLVL': '1', 10:20:54 INFO - 'TERM': 'linux', 10:20:54 INFO - 'TMOUT': '86400', 10:20:54 INFO - 'USER': 'cltbld', 10:20:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', 10:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:54 INFO - '_': '/tools/buildbot/bin/python'} 10:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:20:55 INFO - Cleaning up... 10:20:55 INFO - Return code: 0 10:20:55 INFO - Running post-action listener: _resource_record_post_action 10:20:55 INFO - Running post-action listener: _start_resource_monitoring 10:20:55 INFO - Starting resource monitoring. 10:20:55 INFO - [mozharness: 2016-09-22 17:20:55.076326Z] Finished create-virtualenv step (success) 10:20:55 INFO - [mozharness: 2016-09-22 17:20:55.076825Z] Running install step. 10:20:55 INFO - Running pre-action listener: _resource_record_pre_action 10:20:55 INFO - Running main action method: install 10:20:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:20:55 INFO - Reading from file tmpfile_stdout 10:20:55 INFO - Detecting whether we're running mozinstall >=1.0... 10:20:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:20:55 INFO - Reading from file tmpfile_stdout 10:20:55 INFO - Output received: 10:20:55 INFO - Usage: mozinstall [options] installer 10:20:55 INFO - Options: 10:20:55 INFO - -h, --help show this help message and exit 10:20:55 INFO - -d DEST, --destination=DEST 10:20:55 INFO - Directory to install application into. [default: 10:20:55 INFO - "/builds/slave/test"] 10:20:55 INFO - --app=APP Application being installed. [default: firefox] 10:20:55 INFO - mkdir: /builds/slave/test/build/application 10:20:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:21:11 INFO - Reading from file tmpfile_stdout 10:21:11 INFO - Output received: 10:21:11 INFO - /builds/slave/test/build/application/firefox/firefox 10:21:11 INFO - Running post-action listener: _resource_record_post_action 10:21:11 INFO - [mozharness: 2016-09-22 17:21:11.472561Z] Finished install step (success) 10:21:11 INFO - [mozharness: 2016-09-22 17:21:11.472805Z] Running run-tests step. 10:21:11 INFO - Running pre-action listener: _resource_record_pre_action 10:21:11 INFO - Running main action method: run_tests 10:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:21:11 INFO - Python 2.7.3 10:21:11 INFO - Return code: 0 10:21:11 INFO - grabbing minidump binary from tooltool 10:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:11 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 0x1bf8f60>, '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 0x1bf9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bfa1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:21:11 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 10:21:11 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 10:21:11 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 10:21:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:21:11 INFO - Return code: 0 10:21:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:21:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:21:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:21:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:21:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 10:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 10:21:11 INFO - Using env: {'DISPLAY': ':0', 10:21:11 INFO - 'HOME': '/home/cltbld', 10:21:11 INFO - 'LANG': 'en_US.UTF-8', 10:21:11 INFO - 'LANGUAGE': 'en_US:en', 10:21:11 INFO - 'LOGNAME': 'cltbld', 10:21:11 INFO - 'MAIL': '/var/mail/cltbld', 10:21:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:21:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:11 INFO - 'MOZ_NO_REMOTE': '1', 10:21:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:11 INFO - 'NO_EM_RESTART': '1', 10:21:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:11 INFO - 'PWD': '/builds/slave/test', 10:21:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:21:11 INFO - 'SHELL': '/bin/bash', 10:21:11 INFO - 'SHLVL': '1', 10:21:11 INFO - 'TERM': 'linux', 10:21:11 INFO - 'TMOUT': '86400', 10:21:11 INFO - 'USER': 'cltbld', 10:21:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673', 10:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:11 INFO - '_': '/tools/buildbot/bin/python'} 10:21:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 10:21:11 INFO - mozversion application_buildid: 20160922085400 10:21:11 INFO - mozversion application_changeset: 6d1f666a9bc106f41aebcd45f43ea74d9f6e05d9 10:21:11 INFO - mozversion application_display_name: Nightly 10:21:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:21:11 INFO - mozversion application_name: Firefox 10:21:11 INFO - mozversion application_remotingname: firefox 10:21:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 10:21:11 INFO - mozversion application_vendor: Mozilla 10:21:11 INFO - mozversion application_version: 52.0a1 10:21:11 INFO - mozversion platform_buildid: 20160922085400 10:21:11 INFO - mozversion platform_changeset: 6d1f666a9bc106f41aebcd45f43ea74d9f6e05d9 10:21:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 10:21:11 INFO - mozversion platform_version: 52.0a1 10:21:11 INFO - using testdate: 1474564871 10:21:11 INFO - actual date: 1474564871 10:21:11 INFO - starting webserver on 'localhost:50277' 10:21:11 INFO - SUITE-START | Running 2 tests 10:21:11 INFO - TEST-START | dromaeo_css 10:21:11 INFO - operating with platform_type : linux_ 10:21:11 INFO - Initialising browser for dromaeo_css test... 10:21:11 INFO - TEST-INFO | started process 5775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG3jSeb/profile http://localhost:50277/getInfo.html) 10:21:16 INFO - PROCESS | 5775 | __metrics Screen width/height:1600/1200 10:21:16 INFO - PROCESS | 5775 | colorDepth:24 10:21:16 INFO - PROCESS | 5775 | Browser inner width/height: 1024/697 10:21:16 INFO - PROCESS | 5775 | __metrics 10:21:17 INFO - PROCESS | 5775 | 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" 10:21:17 INFO - PROCESS | 5775 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:21:17 INFO - PROCESS | 5775 | console.error: PushService: 10:21:17 INFO - PROCESS | 5775 | stateChangeProcessEnqueue: Error transitioning state 10:21:17 INFO - PROCESS | 5775 | UnknownError 10:21:18 INFO - TEST-INFO | 5775: exit 0 10:21:18 INFO - Browser initialized. 10:21:18 INFO - Running cycle 1/1 for dromaeo_css test... 10:21:18 INFO - TEST-INFO | started process 5858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG3jSeb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:30 INFO - PROCESS | 5858 | RSS: Main: 177876992 10:21:30 INFO - PROCESS | 5858 | 10:22:21 INFO - PROCESS | 5858 | 1474564941911 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] 10:24:35 INFO - PROCESS | 5858 | Cycle 1(1): loaded http://localhost:50277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50277/tests/dromaeo/cssquery-ext.html) 10:24:36 INFO - PROCESS | 5858 | RSS: Main: 313257984 10:24:36 INFO - PROCESS | 5858 | 10:27:39 INFO - PROCESS | 5858 | Cycle 1(1): loaded http://localhost:50277/tests/dromaeo/cssquery-ext.html (next: http://localhost:50277/tests/dromaeo/cssquery-jquery.html) 10:27:39 INFO - PROCESS | 5858 | RSS: Main: 276713472 10:27:39 INFO - PROCESS | 5858 | 10:30:42 INFO - PROCESS | 5858 | Cycle 1(1): loaded http://localhost:50277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50277/tests/dromaeo/cssquery-mootools.html) 10:30:42 INFO - PROCESS | 5858 | RSS: Main: 218669056 10:30:42 INFO - PROCESS | 5858 | 10:33:45 INFO - PROCESS | 5858 | Cycle 1(1): loaded http://localhost:50277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50277/tests/dromaeo/cssquery-prototype.html) 10:33:45 INFO - PROCESS | 5858 | RSS: Main: 261820416 10:33:45 INFO - PROCESS | 5858 | 10:36:48 INFO - PROCESS | 5858 | Cycle 1(1): loaded http://localhost:50277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50277/tests/dromaeo/cssquery-yui.html) 10:36:49 INFO - PROCESS | 5858 | RSS: Main: 221163520 10:36:49 INFO - PROCESS | 5858 | 10:39:52 INFO - PROCESS | 5858 | Cycle 1(1): loaded http://localhost:50277/tests/dromaeo/cssquery-yui.html (next: http://localhost:50277/tests/dromaeo/cssquery-dojo.html) 10:39:52 INFO - PROCESS | 5858 | RSS: Main: 309374976 10:39:52 INFO - PROCESS | 5858 | 10:39:52 INFO - PROCESS | 5858 | __start_tp_report 10:39:52 INFO - PROCESS | 5858 | _x_x_mozilla_page_load 10:39:52 INFO - PROCESS | 5858 | _x_x_mozilla_page_load_details 10:39:52 INFO - PROCESS | 5858 | |i|pagename|runs| 10:39:52 INFO - PROCESS | 5858 | |0;dojo.html;2561.8206725529208;2574.27920182349;2618.6857577090746;2628.15898912348;2637.9076732314375;4550.954490455095;4590.334401511779;4638.953610463895;4647.093816705739;4647.628189744821;4660.86017419478;4661.37071495348;4672.789724462399;4679.672422930396;4692.718436893789;4254.383114448403;4278.25130602145;4289.313709806432;4303.956960430387;4322.4164737760475;4271.444712187426;4286.464191976003;4303.7848107594655;4373.518912919592;4414.536473670267;4296.720713153635;4350.260455722519;4357.281048626973;4365.497967733703;4416.867493975186;4351.042770590465;4432.977835110803;4436.979494716234;4444.133393988173;4465.419495465601;4167.395727619509;4203.7687927164;4351.760653164075;4376.803043863034;4400.867973960786;4598.241290187115;4642.3500709900645;4653.278741795028;4675.438947326308;4717.882052948669;4829.203181475053;4842.394700662418;4859.368282123337;4956.776945037482;4998.300237966688;4902.65681402302;4952.232403977389;4964.87587810304;4980.726060066695;5018.096742586333;4553.612942899825;4598.517155698603;4606.124836281096;4632.444106707183;4652.674312798139;5100.438951715309;5121.07820592297;5126.5898728101665;5128.564072053917;5188.481151884781;4896.1921282987905;4927.310176575283;4931.950680493221;4933.58064564516;4940.209566469348;4833.830815921497;4878.36581244443;4881.170201065827;5007.023630392111;5080;4920.941997470561;4981.252812078217;5000.799968001312;5001.049800537886;5054.595632349403;4938.1358262304675;4941.48114447985;4943;4949.90100197994;5001.124803159432;4186.979065104655;4279.828806847753;4287.678424118141;4290.905819016131;4348.304271316638;3689.741718079709;3711.7030637548933;3736.813159342022;3757.962420375761;3768.3028639701743;4352.499462561783;4388.341748737651;4403.757793321398;4404.977975110168;4407.096545208225;5007.874803129951;5010.148274793221;5034.748262586856;5045.697258164522;5113.309703190096;4247.8088486018205;4346.6088052075465;4352.281873490839;4357.2592659248;4404.713693609905;4491.73049617024;4494.348319493655;4557.293619488984;4558.042811009659;4618.792154353062;4759.119562880878;4765;4767.928481072856;4771.5228477152705;4825.758712064453;5024.145895197898;5026.44709082008;5031.698098114125;5031.9245211322595;5092.414372347227;4620.306953956933;4687.414073240845;4750.263709125091;4781.593564547053;4786.832460863853;5006.974965125151;5025.422076461107;5027.59779217669;5027.74861256943;5083.669561478492;5048.444671086104;5086.364204474441;5092.41437234708;5097.7706003229205;5140.049090918192;4735.786889589908;4786.928196076992;4866.1727506323305;4877.048975449895;4911.115999120193;4951.950480495149;4952.479989601185;4953.133201689618;4994.200927851526;5013.448520662797;4850.223964165716;4863.90272194547;4865.0756356292195;4868.537488938687;4937.654364194472;4762.9523704762505;4800.399950006249;4883.706977581356;4951.72765497901;4978.1288274552535;4840.201366774443;4842.297866809223;4857.684250523705;4861.732604706775;4866.78099485531 10:39:52 INFO - PROCESS | 5858 | |1;ext.html;552.2875490617104;557.2143277978051;559.5663360895303;576.7837061102086;579.8695293558947;27323.5901461478;28017.29956751082;30719.539206911857;37168.699095531665;38197.42703859444;39862.80068599653;40390.59609403905;40412.393814092815;40466.39300410489;40466.39300410496;7655.3110220080325;7811.296983271504;7817.2964433201005;7822.256885595888;7822.9217707823045;6925.65371731414;7035.190953040389;7036.788896333092;7234.457415693818;7474.177840437547;7267.345938865501;9807.362521436084;10060.949695251513;10070.24473164512;10350.844737328945;9937.105660490555;10008.79982400348;10025;10038.598456061749;10061;9853.359531630493;9926.702198934043;9929.453880036595;9936.850947235796;9938.254630902638;36976.44535331972;37259.62740372616;37383.81308093469;37411.438828417595;37429.62570374316;2842.4457230839994;2908.5491748778973;2932.164333165059;2999.865006074732;3412.7952322860706;27830;28248.717512824813;28296.575551366746;28349.85825070882;28816.711832881614;3383.5432216650684;3539.982300088509;3562.4656301554714;3562.69717074049;3620.6741393274733;278018;278836;278940;279217;280357.5982120097;49860;50069;50157.24764128541;50172.24052677065;50259.74870125626;31503.36993260122;32060.67939320577;32175;34100;34146.658533414346;14177.716445671029;14298.28508574588;14316.141031538142;14327.35526901292;14337.139771613736;9886.110250077527;9908.80182396348;9913.058259465339;9915.256355773347;9919.80160396788;15136.243187840564;15331.616709582127;17090.914545427193;17103.14484275806;17136;6218.968905155445;6402.199725034371;6586.027549200323;6700.363465470772;6734.663266836638;739.9075115610549;781.3905153979905;883.2889523933295;951.3007939164709;983.7934033852828;26187.869060654957;27455.588166177524;27725.58411623827;28107.297317567223;28125.296867578476;917.4862077236769;922.5018490015451;930.4417349590192;963.6097380560884;1000.7598176437602;14086.577402677936;14773.448787877118;14808.62978425548;14997.819796250024;15006;407948.920510797;410477;412355;412399;412774;48174.5182548177;48303.516964829905;48479.5152048475;48615;48658;1126.1778901402022;1149.0635132367095;1156.1213477756964;1157.5543415785153;1159.3217967489113;25715.871420642776;26880.193594192206;26994;27240.863795680896;27465.862670686518;40328;40699.59300406958;40701.18597627972;40702.59297406988;40710.389344159266;330224;330356;331440;331842;332260;24111;24286;24643.87678061598;24844.37889052788;24991.500169996863;34070.31859362749;34174.51530184331;35927.820360898026;38204.42693359657;41716.374254386814;33977.91837241037;35114;35387.46918796271;35726.28547428985;35753.46369804403;35012.29975400427;35081.64918350784;35486.46770298499;35563.28873422569;35831.28337433185;32725.836370817993;32782.34435311328;32831;33111.66888331086;34720.305593888486;28382.71617283801;28984.710152898202;32421.35157296888;32962.34075318528;32992.1751956203;24610.261692149263;24951.87524062368;25275.620865686662;25360.112396066048;25426.872865635552 10:39:52 INFO - PROCESS | 5858 | |2;jquery.html;352.20401891724697;355.2007982040409;356.35321890768256;370.9944350834736;388.5880966175854;15371.231438428076;16587.502374928743;17499.825001749996;17560.736588951175;17613.383531576397;16036.35854565816;16917.238724257408;17048.23282952267;17144.142792860337;17184.82815171848;4829.275608658694;5110.31010813541;5112.8977420451565;5114.053900028488;5116.513931176551;3691.50164727761;3777.6977841772728;5033.924491132618;5594.888102237953;5853.941460585404;5919.141724449953;5922.822315330525;5927.762889484416;5930.466258036776;5936.347001829795;5687.573431992617;5809.448102430262;5829.47534721877;5845.123231515286;5847.44449277318;4925.975370123162;5142.820001299937;5146.614003949719;5165.199394093921;5169.2504586835075;19787.40637780869;20125.698114528295;20142.39572812818;20158.29445969384;20211.393658190133;1825.297260554696;1865.020864046373;1907.3324336482258;2209.2930262316067;2355.0815182079004;12401.441935112942;12891;13261.933690331487;13315.05073421254;13631.454741810316;1623.618449664328;1671.189473105543;1789.8568114550806;1803.9278428862829;1837.9540511487187;68628;70671;71928.64035679841;72409.6379518099;72982;9383.343165978316;9509.191718703987;9864;9981.351212171186;9989.200863930868;13289.269090200132;13324.133931294435;13410.530631427853;13629.727405451835;13640.454381824617;6792.72829086831;6843.076184715;7004.824879377954;7234.891476627855;7309.634518274065;6428.935710642927;6433.1636887205295;6601.70292336846;6605.933940660532;6616.503762217757;5976.760929562769;6046.3046749624355;6091.116788065706;6102;6239.220097487814;1578.8657964072952;1656.2464078844098;1702.7020271452445;1706.394230048315;1761.2778760708304;762.897008903802;785.4912800525059;813.938954578409;827.7765003449156;869.5739087847036;16870.578235543962;17163.31346746116;17607.647847042987;17755.201015954313;18004.9099754503;813.9064007639079;822.56404105824;826.557791581501;835.1898658301438;863.6329559937002;7178.5692858428665;9892.406455612687;10078.344907580984;10148.188144948386;10180.847287290697;372464;373523;373771;376877;377838;68590.65704671445;69803.3019669807;69858.65070674614;70228.2977170232;71555.64222178856;849.9490030598184;864.1272314961808;872.8079822439054;876.513534988075;879.0813599788108;14780.63048423798;15227.771583426036;15462.458813941457;15540.222988850739;16061.75907361414;34429.13927151841;34819.47770783491;36238.8188059058;39137.2172556553;40536.79731601323;47003;50512.74743626406;50757.17806808347;51796.741016294676;51853;6435.613863168038;6590.736370545316;6645.534812563074;6957.095577574883;7129.429645628441;8030.317423019109;10112.140468060003;10202.846957295498;10385.273030888067;11329.320240785579;9267.67563135287;9556.283278754261;9680.75798105053;9858.457784821903;9933.900660993586;9301.302402319718;9394.107559781809;9491.810163796823;9736.805263894541;9822.65620703272;9508.09673081084;9680.128788409076;9897.35667181631;10074.899251007397;10255.512950622267;6583;6679.666016699242;6803.217629972419;6988.336108069725;7229.7469588564145;7612.3148916597775;9399.624015039322;9693.854592180982;9852.162566181669;9894.010598940049 10:39:52 INFO - PROCESS | 5858 | |3;mootools.html;1316.8353955755533;1338.3308345827086;1350.8108864758935;1574.4568123997224;1580.8340124286942;6526.608403495794;6774.559653622511;7199.388052015578;7889.092754333254;7914.08987966384;7210.170830354511;7532.548047117177;7541.773746787591;7712.498687585303;7721.845563088735;1958.72577839103;1987.5627361980341;1991.950201244966;1992.8505362097828;1997.9900100499476;1776.4493007167819;1824.279409633194;2032.6442872497255;2133.6799480077957;2135.743710754704;2140.3685912655806;2144.7211862457857;2165.3936897668677;2171.1206961180746;2171.5331203791184;2061.360978096795;2116.121809449077;2124.5644642848256;2129.4995676016124;2133.743950725923;2046.4065421027883;2050.456628993318;2056.475598722316;2060.5672808710187;2066.95866082679;7529.849403011964;7536.208698086677;7544.4718869679145;7570.05374328209;7587.582682952436;4385.605295523418;4567.794449249792;4575.542445755431;4578.679492435531;4596.333531637927;2755.6968733439307;2879.424115176952;2939.76481881449;2944.528875379929;2953.7636989040825;907.4237858959608;917.3440989692335;929.1312622697799;930.5719369090226;940.4122423485321;10657.147428205724;10690.893091069067;10709.625163119332;10716.517756700967;10724.571017159304;3977.7215594908657;4064.4309796628495;4106.609872062149;4188.979055104705;4211.810468528924;9028.18746312835;9102.13529714676;9108.453492790453;9112.952010518875;9118;4592.7933243004145;4612.930806037912;4613.1465678848845;4621;4625.791839367236;4131.35963925592;4211.389348544444;4218.050938538804;4227.387028880795;4229.217594744982;3246.6915643013876;3334.3998080345773;3443.328550932594;3459.775114617542;3570.535830342039;1144.4163476626813;1150.5570355413226;1161.5005547614437;1161.8083016302385;1181.1082632612322;748.3751067858399;758.6699785593285;767.692922830861;773.5010917957885;779.1468342165319;4970.353853998957;4973.154563724175;5084.313617661643;5168.793248270027;5309.469053094737;791.1258059843905;796.621604737745;804.284187073505;810.623060276974;812.7683610171073;3536.4695295705337;3566.268914872445;3592.856285748593;3648.52569166012;3704.444333350019;8992.910070899206;9738.318317717833;9742.464164471023;9755.804883902425;9807.705768826947;9702.75743106428;9703.854442183372;9712.805743885225;9716.076972687584;9717.951410243046;6934.4452443804375;7012.579245245403;7035.472339574552;7080.079589653312;7087.89368159478;5040.042391945519;5088.033273677989;5115.514026167508;5271.314729085195;5284.603654725988;8789.296856251613;8948.73153805387;8977.506237157018;8987.056359082464;9056.230220431336;8533.402661813614;8763.956180219058;8866;9053.637854485747;9053.68312109073;6578.638174900427;6726.562773419712;6758.459323254227;6765.086713293839;6896.172459304916;6399.8720025598295;6674.098996635586;6712.731490740511;6950.478714096362;7271.781846544401;6434.806955791334;6439.67801609927;6493.253275873335;6512.153420055362;6525.282218956006;6308.842278943063;6376.840578985377;6392.242133413349;6411.230652321565;6435.742570297136;6020.488258498077;6023.5181185505935;6061.484628842789;6069.726862291296;6078.483328917092;4455.908302465917;4549;4555.043440877453;4580.0152967112235;4604.424446944132;4538.591526762607;4562.224421848227;4579.908401831878;4668.323093151406;4781.832635857867 10:39:52 INFO - PROCESS | 5858 | |4;prototype.html;286.62309063581404;295.4534111892998;299.89503673714205;303.1149044789215;303.1239717217241;4643.930341044887;4813.326134341186;4830.806767729291;4873.853784386465;4890.4131504219495;4612.446506419226;4744.478107408182;4753.548412900769;4767.736549814302;4787.162246606838;3768.434734789776;3770.5475342958885;3778.9782466380493;3779.8677046303246;3812.694984401255;3589.2642008388216;3590.8922732318074;3808.409696497047;3810.8285127169343;3813.2564149990626;3723.5345581802276;3740.9064773380746;3756.9436458453147;3766.9811650941706;3782.1490164712995;3734.8692795752017;3742.2328422673286;3778.7732736035787;3779.2819364320967;3781.243751249761;3289.243474000993;3299.8350082496017;3300.9174770630684;3302.1744563859033;3310.519974603693;4632.884177895546;4658.697184682985;4697.295405689139;4698.3187437821325;4721.480637129913;4259.8509052183335;4263.424437700902;4265.957340426618;4268.06102657418;4278.743275403454;5072.467390923936;5072.54347108762;5073.568746656501;5087.872803179913;5094.363204599425;3520.137566296248;3534.1871369584883;3559.469428145922;3631.5823680276844;3632.291703117893;5216.217567364888;5219.478052194788;5231.215317702337;5233.241180028875;5246.921296180561;3660.8285348688696;3661.8465183467124;3663.8351274192723;3669.7614655047337;3669.9082522936606;3717.851285948586;3752.493413389212;3755.248950209969;3765.548134223856;3768.6419790119894;4127.174565086994;4181.310083836133;4184.037671335549;4210.873673789792;4240.745555266694;4998.850034498971;5005.9749701251985;5012.298278241049;5018.498150185025;5057.974710126426;1213.6359092272282;1250.1811313589612;1295.9870401296055;1315.15829868884;1324.3709238112012;871.5642178910545;898.8786513820681;899.132337294514;904.6475519098989;906.9138431848963;4472.373867658531;4486.484054333793;4491.685582009293;4498.775061246924;4501.459824821042;5132.769025393866;5147.897042059138;5165.48345165488;5192.247124166975;5204.297419848348;4337.067530480962;4437.247287321555;4437.733735975788;4452.643788496913;4458.219811533034;2698.689650690196;2725.945481090367;2731.517315422812;2733.1687769194687;2736.54846950255;4874.147024270738;4880.902381952341;4899.853004409873;4911.729854857946;4930.852074437773;5016.247562865599;5175.792968281226;5189.7405129743365;5194.246834209094;5208.5312321891215;4799.784009719501;4808.687435316693;4822.927656085161;4833.26920290035;4837.975810120927;4922.883160241131;5104.69371837691;5110.671225481476;5120.513551212629;5161.380634323905;4996.450390457119;4999.450060493416;5003.774830132726;5004.42449118356;5006.574441172541;4769.4753577107185;4817.397825271841;4847.248676455155;4852.199387101089;4889.535494128052;3690.760100593453;3708;3710.109573702238;3724.459953306701;3727.1800203955086;4972.632526055364;5075.3402057732255;5080.466551012239;5087.898242035212;5102.413222479462;4927.162382394929;4940.654154209171;4940.827071052496;4942.1598328285;4971.701697898137;4978.4025916890205;4988.625853060962;4995.525425084611;5002.499250224845;5007.824726134568;4697.201475749199;4756.405449318835;4905.669806841722;4973.950260497493;5024.397072351341;4881.1445304497265;5063.594912406925;5113.64204505681;5121.41236216774;5121.8463446096675;5000.949990500048;5007.4977506748555;5009.474005229398;5012.724300163526;5023.196288593807 10:39:52 INFO - PROCESS | 5858 | |5;yui.html;596.7612954818072;603.0983679399299;634.7651368993473;643.8100760275721;677.8983152527123;11724.706882327935;12636.178648387848;12695.301758403284;12702.110852240347;12799;10996.615118470854;11426.25729327593;11489.482973266202;11513.424328783549;11520.769584608302;712.2201189697286;742.0872327037747;744.1591002167543;745.2063552316765;746.5110352718978;722.7651013420633;722.9638518074102;723.0311382747118;723.1105739939877;723.4863247094569;757.4205732614554;757.4924800383756;758.0145810446397;758.1811643425087;758.6168984662737;752.6951584608188;753.6118898767139;754.3022703998779;754.5585832288118;756.4591317208195;555.2310050579936;555.555555555554;555.5833125156133;555.6249531566217;557.8465921871518;11488.36813975231;11495.367754773484;11501.367424791633;11517.36654484003;11527.654170374903;13361.465541378333;13437.260950647711;13600.659983500393;13600.727985440335;13973.930130349283;10244.846327305097;10445.321054131457;10574.841377379345;10693.893061069368;10946.39794811285;3291.2923721399775;3293.3413317336626;3303.4219011672863;3334.6498617645284;3354.8658053677823;52748;53805;67981.320186798;68312.89708227324;69253.65373173101;9962.302638815214;10058.698239052841;10141.695749127539;10261.333013354108;10264.743381415376;17827.821721782617;17852.732209016875;17855.28578856831;17907.910460447616;17952.371666991854;6802.761903333359;6819.283975182633;6959.478039147084;6978.406835419046;7085.822854428578;3546.592141903714;3584.2652256287397;3656.846617815652;3690.2619476104887;3766.9058273543383;2807.1297897651793;2877.5971364009056;2910.6070680457865;2925.0347385363207;2925.9122226333243;491.50112635674816;492.7856382473635;497.6541303793901;503.90173916086746;505.69910903012646;530.2841164427991;560.7981126794351;567.0813282482322;583.7198144890391;590.3329237961076;7584;7664.594797893816;7664.923350766421;7847.097583777824;7880.566568838654;435.6514788169515;532.3239485852945;557.8103444828778;583.2068386993685;586.1442294250357;3619.728520360931;3631.1648320886343;3676.540432445944;3687.741858069963;3802.4676545283683;62459.06311405332;79713.60143199247;82838.17161828425;109620;110076;61229.69385153046;87307;87912;88469.55765221262;92827.5358623216;48638.5136148641;77288.61355693186;80154.59922700349;80628;82469;6941.861162776615;6946.37482626566;7051.612161330971;7325.706971721072;7402.629868506661;46128.308075379566;48114.27828582504;49032;49045.75477122592;49402.50597493979;40630.79684601558;62772.372276276656;66528.6673566629;68158.3184168152;72097.6395118021;9608.95195524018;9856.21150307988;9908;10087.29388942767;10138.79722405533;11003.546630701027;11165.162612804235;11554.59558915434;11710.180287379802;11919.04647628205;10108.292419530562;10359.171266298526;10618.415987120783;10756.408397538211;11049.39228342449;10977.17671174681;11280;11497.597584084851;11551.595694151001;11729.824052639387;9659.951700241454;9760.85358719634;9919.40483570988;10312.535935882754;10336;8665.393422460367;8724.825503489768;8859.379843411158;8871.467711937305;9102.954485227532;8945.552722363986;9444.411302670575;9535.427874327563;9656.908530585415;9792.902070979198 10:39:52 INFO - PROCESS | 5858 | __end_tp_report 10:39:52 INFO - PROCESS | 5858 | __start_cc_report 10:39:52 INFO - PROCESS | 5858 | _x_x_mozilla_cycle_collect,1182 10:39:52 INFO - PROCESS | 5858 | __end_cc_report 10:39:52 INFO - PROCESS | 5858 | __startTimestamp1474565992704__endTimestamp 10:39:52 INFO - PROCESS | 5858 | 10:39:52 INFO - PROCESS | 5858 | ------- Summary: start ------- 10:39:52 INFO - PROCESS | 5858 | Number of tests: 6 10:39:52 INFO - PROCESS | 5858 | 10:39:52 INFO - PROCESS | 5858 | [#0] dojo.html Cycles:165 Average:4638.84 Median:4767.93 stddev:481.75 (10.1%) stddev-sans-first:454.84 10:39:52 INFO - PROCESS | 5858 | Values: 2561.8 2574.3 2618.7 2628.2 2637.9 4551.0 4590.3 4639.0 4647.1 4647.6 4660.9 4661.4 4672.8 4679.7 4692.7 4254.4 4278.3 4289.3 4304.0 4322.4 4271.4 4286.5 4303.8 4373.5 4414.5 4296.7 4350.3 4357.3 4365.5 4416.9 4351.0 4433.0 4437.0 4444.1 4465.4 4167.4 4203.8 4351.8 4376.8 4400.9 4598.2 4642.4 4653.3 4675.4 4717.9 4829.2 4842.4 4859.4 4956.8 4998.3 4902.7 4952.2 4964.9 4980.7 5018.1 4553.6 4598.5 4606.1 4632.4 4652.7 5100.4 5121.1 5126.6 5128.6 5188.5 4896.2 4927.3 4932.0 4933.6 4940.2 4833.8 4878.4 4881.2 5007.0 5080.0 4920.9 4981.3 5000.8 5001.0 5054.6 4938.1 4941.5 4943.0 4949.9 5001.1 4187.0 4279.8 4287.7 4290.9 4348.3 3689.7 3711.7 3736.8 3758.0 3768.3 4352.5 4388.3 4403.8 4405.0 4407.1 5007.9 5010.1 5034.7 5045.7 5113.3 4247.8 4346.6 4352.3 4357.3 4404.7 4491.7 4494.3 4557.3 4558.0 4618.8 4759.1 4765.0 4767.9 4771.5 4825.8 5024.1 5026.4 5031.7 5031.9 5092.4 4620.3 4687.4 4750.3 4781.6 4786.8 5007.0 5025.4 5027.6 5027.7 5083.7 5048.4 5086.4 5092.4 5097.8 5140.0 4735.8 4786.9 4866.2 4877.0 4911.1 4952.0 4952.5 4953.1 4994.2 5013.4 4850.2 4863.9 4865.1 4868.5 4937.7 4763.0 4800.4 4883.7 4951.7 4978.1 4840.2 4842.3 4857.7 4861.7 4866.8 10:39:52 INFO - PROCESS | 5858 | 10:39:52 INFO - PROCESS | 5858 | [#1] ext.html Cycles:180 Average:47883.69 Median:35046.97 stddev:91007.04 (259.7%) stddev-sans-first:91192.95 10:39:52 INFO - PROCESS | 5858 | Values: 552.3 557.2 559.6 576.8 579.9 27323.6 28017.3 30719.5 37168.7 38197.4 39862.8 40390.6 40412.4 40466.4 40466.4 7655.3 7811.3 7817.3 7822.3 7822.9 6925.7 7035.2 7036.8 7234.5 7474.2 7267.3 9807.4 10060.9 10070.2 10350.8 9937.1 10008.8 10025.0 10038.6 10061.0 9853.4 9926.7 9929.5 9936.9 9938.3 36976.4 37259.6 37383.8 37411.4 37429.6 2842.4 2908.5 2932.2 2999.9 3412.8 27830.0 28248.7 28296.6 28349.9 28816.7 3383.5 3540.0 3562.5 3562.7 3620.7 278018.0 278836.0 278940.0 279217.0 280357.6 49860.0 50069.0 50157.2 50172.2 50259.7 31503.4 32060.7 32175.0 34100.0 34146.7 14177.7 14298.3 14316.1 14327.4 14337.1 9886.1 9908.8 9913.1 9915.3 9919.8 15136.2 15331.6 17090.9 17103.1 17136.0 6219.0 6402.2 6586.0 6700.4 6734.7 739.9 781.4 883.3 951.3 983.8 26187.9 27455.6 27725.6 28107.3 28125.3 917.5 922.5 930.4 963.6 1000.8 14086.6 14773.4 14808.6 14997.8 15006.0 407948.9 410477.0 412355.0 412399.0 412774.0 48174.5 48303.5 48479.5 48615.0 48658.0 1126.2 1149.1 1156.1 1157.6 1159.3 25715.9 26880.2 26994.0 27240.9 27465.9 40328.0 40699.6 40701.2 40702.6 40710.4 330224.0 330356.0 331440.0 331842.0 332260.0 24111.0 24286.0 24643.9 24844.4 24991.5 34070.3 34174.5 35927.8 38204.4 41716.4 33977.9 35114.0 35387.5 35726.3 35753.5 35012.3 35081.6 35486.5 35563.3 35831.3 32725.8 32782.3 32831.0 33111.7 34720.3 28382.7 28984.7 32421.4 32962.3 32992.2 24610.3 24951.9 25275.6 25360.1 25426.9 10:39:52 INFO - PROCESS | 5858 | 10:39:52 INFO - PROCESS | 5858 | [#2] jquery.html Cycles:180 Average:23691.88 Median:51824.87 stddev:61897.72 (119.4%) stddev-sans-first:62046.55 10:39:52 INFO - PROCESS | 5858 | Values: 352.2 355.2 356.4 371.0 388.6 15371.2 16587.5 17499.8 17560.7 17613.4 16036.4 16917.2 17048.2 17144.1 17184.8 4829.3 5110.3 5112.9 5114.1 5116.5 3691.5 3777.7 5033.9 5594.9 5853.9 5919.1 5922.8 5927.8 5930.5 5936.3 5687.6 5809.4 5829.5 5845.1 5847.4 4926.0 5142.8 5146.6 5165.2 5169.3 19787.4 20125.7 20142.4 20158.3 20211.4 1825.3 1865.0 1907.3 2209.3 2355.1 12401.4 12891.0 13261.9 13315.1 13631.5 1623.6 1671.2 1789.9 1803.9 1838.0 68628.0 70671.0 71928.6 72409.6 72982.0 9383.3 9509.2 9864.0 9981.4 9989.2 13289.3 13324.1 13410.5 13629.7 13640.5 6792.7 6843.1 7004.8 7234.9 7309.6 6428.9 6433.2 6601.7 6605.9 6616.5 5976.8 6046.3 6091.1 6102.0 6239.2 1578.9 1656.2 1702.7 1706.4 1761.3 762.9 785.5 813.9 827.8 869.6 16870.6 17163.3 17607.6 17755.2 18004.9 813.9 822.6 826.6 835.2 863.6 7178.6 9892.4 10078.3 10148.2 10180.8 372464.0 373523.0 373771.0 376877.0 377838.0 68590.7 69803.3 69858.7 70228.3 71555.6 849.9 864.1 872.8 876.5 879.1 14780.6 15227.8 15462.5 15540.2 16061.8 34429.1 34819.5 36238.8 39137.2 40536.8 47003.0 50512.7 50757.2 51796.7 51853.0 6435.6 6590.7 6645.5 6957.1 7129.4 8030.3 10112.1 10202.8 10385.3 11329.3 9267.7 9556.3 9680.8 9858.5 9933.9 9301.3 9394.1 9491.8 9736.8 9822.7 9508.1 9680.1 9897.4 10074.9 10255.5 6583.0 6679.7 6803.2 6988.3 7229.7 7612.3 9399.6 9693.9 9852.2 9894.0 10:39:52 INFO - PROCESS | 5858 | 10:39:52 INFO - PROCESS | 5858 | [#3] mootools.html Cycles:180 Average:5026.89 Median:5142.15 stddev:2853.57 (55.5%) stddev-sans-first:2847.96 10:39:52 INFO - PROCESS | 5858 | Values: 1316.8 1338.3 1350.8 1574.5 1580.8 6526.6 6774.6 7199.4 7889.1 7914.1 7210.2 7532.5 7541.8 7712.5 7721.8 1958.7 1987.6 1992.0 1992.9 1998.0 1776.4 1824.3 2032.6 2133.7 2135.7 2140.4 2144.7 2165.4 2171.1 2171.5 2061.4 2116.1 2124.6 2129.5 2133.7 2046.4 2050.5 2056.5 2060.6 2067.0 7529.8 7536.2 7544.5 7570.1 7587.6 4385.6 4567.8 4575.5 4578.7 4596.3 2755.7 2879.4 2939.8 2944.5 2953.8 907.4 917.3 929.1 930.6 940.4 10657.1 10690.9 10709.6 10716.5 10724.6 3977.7 4064.4 4106.6 4189.0 4211.8 9028.2 9102.1 9108.5 9113.0 9118.0 4592.8 4612.9 4613.1 4621.0 4625.8 4131.4 4211.4 4218.1 4227.4 4229.2 3246.7 3334.4 3443.3 3459.8 3570.5 1144.4 1150.6 1161.5 1161.8 1181.1 748.4 758.7 767.7 773.5 779.1 4970.4 4973.2 5084.3 5168.8 5309.5 791.1 796.6 804.3 810.6 812.8 3536.5 3566.3 3592.9 3648.5 3704.4 8992.9 9738.3 9742.5 9755.8 9807.7 9702.8 9703.9 9712.8 9716.1 9718.0 6934.4 7012.6 7035.5 7080.1 7087.9 5040.0 5088.0 5115.5 5271.3 5284.6 8789.3 8948.7 8977.5 8987.1 9056.2 8533.4 8764.0 8866.0 9053.6 9053.7 6578.6 6726.6 6758.5 6765.1 6896.2 6399.9 6674.1 6712.7 6950.5 7271.8 6434.8 6439.7 6493.3 6512.2 6525.3 6308.8 6376.8 6392.2 6411.2 6435.7 6020.5 6023.5 6061.5 6069.7 6078.5 4455.9 4549.0 4555.0 4580.0 4604.4 4538.6 4562.2 4579.9 4668.3 4781.8 10:39:52 INFO - PROCESS | 5858 | 10:39:52 INFO - PROCESS | 5858 | [#4] prototype.html Cycles:180 Average:4168.41 Median:4762.07 stddev:1199.06 (25.2%) stddev-sans-first:1166.49 10:39:52 INFO - PROCESS | 5858 | Values: 286.6 295.5 299.9 303.1 303.1 4643.9 4813.3 4830.8 4873.9 4890.4 4612.4 4744.5 4753.5 4767.7 4787.2 3768.4 3770.5 3779.0 3779.9 3812.7 3589.3 3590.9 3808.4 3810.8 3813.3 3723.5 3740.9 3756.9 3767.0 3782.1 3734.9 3742.2 3778.8 3779.3 3781.2 3289.2 3299.8 3300.9 3302.2 3310.5 4632.9 4658.7 4697.3 4698.3 4721.5 4259.9 4263.4 4266.0 4268.1 4278.7 5072.5 5072.5 5073.6 5087.9 5094.4 3520.1 3534.2 3559.5 3631.6 3632.3 5216.2 5219.5 5231.2 5233.2 5246.9 3660.8 3661.8 3663.8 3669.8 3669.9 3717.9 3752.5 3755.2 3765.5 3768.6 4127.2 4181.3 4184.0 4210.9 4240.7 4998.9 5006.0 5012.3 5018.5 5058.0 1213.6 1250.2 1296.0 1315.2 1324.4 871.6 898.9 899.1 904.6 906.9 4472.4 4486.5 4491.7 4498.8 4501.5 5132.8 5147.9 5165.5 5192.2 5204.3 4337.1 4437.2 4437.7 4452.6 4458.2 2698.7 2725.9 2731.5 2733.2 2736.5 4874.1 4880.9 4899.9 4911.7 4930.9 5016.2 5175.8 5189.7 5194.2 5208.5 4799.8 4808.7 4822.9 4833.3 4838.0 4922.9 5104.7 5110.7 5120.5 5161.4 4996.5 4999.5 5003.8 5004.4 5006.6 4769.5 4817.4 4847.2 4852.2 4889.5 3690.8 3708.0 3710.1 3724.5 3727.2 4972.6 5075.3 5080.5 5087.9 5102.4 4927.2 4940.7 4940.8 4942.2 4971.7 4978.4 4988.6 4995.5 5002.5 5007.8 4697.2 4756.4 4905.7 4974.0 5024.4 4881.1 5063.6 5113.6 5121.4 5121.8 5000.9 5007.5 5009.5 5012.7 5023.2 10:39:52 INFO - PROCESS | 5858 | 10:39:52 INFO - PROCESS | 5858 | [#5] yui.html Cycles:180 Average:17208.73 Median:27168.66 stddev:25159.57 (92.6%) stddev-sans-first:25199.23 10:39:52 INFO - PROCESS | 5858 | Values: 596.8 603.1 634.8 643.8 677.9 11724.7 12636.2 12695.3 12702.1 12799.0 10996.6 11426.3 11489.5 11513.4 11520.8 712.2 742.1 744.2 745.2 746.5 722.8 723.0 723.0 723.1 723.5 757.4 757.5 758.0 758.2 758.6 752.7 753.6 754.3 754.6 756.5 555.2 555.6 555.6 555.6 557.8 11488.4 11495.4 11501.4 11517.4 11527.7 13361.5 13437.3 13600.7 13600.7 13973.9 10244.8 10445.3 10574.8 10693.9 10946.4 3291.3 3293.3 3303.4 3334.6 3354.9 52748.0 53805.0 67981.3 68312.9 69253.7 9962.3 10058.7 10141.7 10261.3 10264.7 17827.8 17852.7 17855.3 17907.9 17952.4 6802.8 6819.3 6959.5 6978.4 7085.8 3546.6 3584.3 3656.8 3690.3 3766.9 2807.1 2877.6 2910.6 2925.0 2925.9 491.5 492.8 497.7 503.9 505.7 530.3 560.8 567.1 583.7 590.3 7584.0 7664.6 7664.9 7847.1 7880.6 435.7 532.3 557.8 583.2 586.1 3619.7 3631.2 3676.5 3687.7 3802.5 62459.1 79713.6 82838.2 109620.0 110076.0 61229.7 87307.0 87912.0 88469.6 92827.5 48638.5 77288.6 80154.6 80628.0 82469.0 6941.9 6946.4 7051.6 7325.7 7402.6 46128.3 48114.3 49032.0 49045.8 49402.5 40630.8 62772.4 66528.7 68158.3 72097.6 9609.0 9856.2 9908.0 10087.3 10138.8 11003.5 11165.2 11554.6 11710.2 11919.0 10108.3 10359.2 10618.4 10756.4 11049.4 10977.2 11280.0 11497.6 11551.6 11729.8 9660.0 9760.9 9919.4 10312.5 10336.0 8665.4 8724.8 8859.4 8871.5 9103.0 8945.6 9444.4 9535.4 9656.9 9792.9 10:39:52 INFO - PROCESS | 5858 | -------- Summary: end -------- 10:39:52 INFO - PROCESS | 5858 | 10:39:53 INFO - TEST-INFO | 5858: exit 0 10:39:53 INFO - TEST-OK | dromaeo_css | took 1121971ms 10:39:53 INFO - TEST-START | kraken 10:39:53 INFO - operating with platform_type : linux_ 10:39:53 INFO - Initialising browser for kraken test... 10:39:53 INFO - TEST-INFO | started process 6165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEkKX_w/profile http://localhost:50277/getInfo.html) 10:39:58 INFO - PROCESS | 6165 | __metrics Screen width/height:1600/1200 10:39:58 INFO - PROCESS | 6165 | colorDepth:24 10:39:58 INFO - PROCESS | 6165 | Browser inner width/height: 1024/697 10:39:58 INFO - PROCESS | 6165 | __metrics 10:39:59 INFO - PROCESS | 6165 | 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" 10:39:59 INFO - PROCESS | 6165 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:39:59 INFO - PROCESS | 6165 | console.error: PushService: 10:39:59 INFO - PROCESS | 6165 | stateChangeProcessEnqueue: Error transitioning state 10:39:59 INFO - PROCESS | 6165 | UnknownError 10:40:00 INFO - TEST-INFO | 6165: exit 0 10:40:00 INFO - Browser initialized. 10:40:00 INFO - Running cycle 1/1 for kraken test... 10:40:00 INFO - TEST-INFO | started process 6247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEkKX_w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:40:12 INFO - PROCESS | 6247 | RSS: Main: 175738880 10:40:12 INFO - PROCESS | 6247 | 10:40:15 INFO - PROCESS | 6247 | Cycle 1(1): loaded http://localhost:50277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50277/tests/kraken/driver.html?testName=audio-beat-detection) 10:40:16 INFO - PROCESS | 6247 | RSS: Main: 234749952 10:40:16 INFO - PROCESS | 6247 | 10:40:19 INFO - PROCESS | 6247 | Cycle 1(1): loaded http://localhost:50277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50277/tests/kraken/driver.html?testName=audio-dft) 10:40:19 INFO - PROCESS | 6247 | RSS: Main: 218599424 10:40:19 INFO - PROCESS | 6247 | 10:40:23 INFO - PROCESS | 6247 | Cycle 1(1): loaded http://localhost:50277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50277/tests/kraken/driver.html?testName=audio-fft) 10:40:23 INFO - PROCESS | 6247 | RSS: Main: 301355008 10:40:23 INFO - PROCESS | 6247 | 10:40:25 INFO - PROCESS | 6247 | Cycle 1(1): loaded http://localhost:50277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50277/tests/kraken/driver.html?testName=audio-oscillator) 10:40:26 INFO - PROCESS | 6247 | RSS: Main: 210288640 10:40:26 INFO - PROCESS | 6247 | 10:40:28 INFO - PROCESS | 6247 | Cycle 1(1): loaded http://localhost:50277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:40:29 INFO - PROCESS | 6247 | RSS: Main: 214167552 10:40:29 INFO - PROCESS | 6247 | 10:40:32 INFO - PROCESS | 6247 | Cycle 1(1): loaded http://localhost:50277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50277/tests/kraken/driver.html?testName=imaging-darkroom) 10:40:33 INFO - PROCESS | 6247 | RSS: Main: 250830848 10:40:33 INFO - PROCESS | 6247 | 10:40:36 INFO - PROCESS | 6247 | Cycle 1(1): loaded http://localhost:50277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50277/tests/kraken/driver.html?testName=imaging-desaturate) 10:40:37 INFO - PROCESS | 6247 | RSS: Main: 244805632 10:40:37 INFO - PROCESS | 6247 | 10:40:40 INFO - PROCESS | 6247 | Cycle 1(1): loaded http://localhost:50277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50277/tests/kraken/driver.html?testName=json-parse-financial) 10:40:40 INFO - PROCESS | 6247 | RSS: Main: 248061952 10:40:40 INFO - PROCESS | 6247 | 10:40:42 INFO - PROCESS | 6247 | Cycle 1(1): loaded http://localhost:50277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:40:43 INFO - PROCESS | 6247 | RSS: Main: 211316736 10:40:43 INFO - PROCESS | 6247 | 10:40:45 INFO - PROCESS | 6247 | Cycle 1(1): loaded http://localhost:50277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50277/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:40:45 INFO - PROCESS | 6247 | RSS: Main: 218148864 10:40:45 INFO - PROCESS | 6247 | 10:40:47 INFO - PROCESS | 6247 | Cycle 1(1): loaded http://localhost:50277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:40:48 INFO - PROCESS | 6247 | RSS: Main: 222326784 10:40:48 INFO - PROCESS | 6247 | 10:40:51 INFO - PROCESS | 6247 | Cycle 1(1): loaded http://localhost:50277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:40:51 INFO - PROCESS | 6247 | RSS: Main: 223920128 10:40:51 INFO - PROCESS | 6247 | 10:40:54 INFO - PROCESS | 6247 | Cycle 1(1): loaded http://localhost:50277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:40:55 INFO - PROCESS | 6247 | RSS: Main: 221712384 10:40:55 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | Cycle 1(1): loaded http://localhost:50277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50277/tests/kraken/driver.html?testName=ai-astar) 10:40:57 INFO - PROCESS | 6247 | RSS: Main: 273039360 10:40:57 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | __start_tp_report 10:40:57 INFO - PROCESS | 6247 | _x_x_mozilla_page_load 10:40:57 INFO - PROCESS | 6247 | _x_x_mozilla_page_load_details 10:40:57 INFO - PROCESS | 6247 | |i|pagename|runs| 10:40:57 INFO - PROCESS | 6247 | |0;ai-astar;113;114;115;117;113;114;114;115;114;113 10:40:57 INFO - PROCESS | 6247 | |1;audio-beat-detection;156;125;125;175;126;124;123;125;155;126 10:40:57 INFO - PROCESS | 6247 | |2;audio-dft;162;161;162;161;162;161;163;161;162;162 10:40:57 INFO - PROCESS | 6247 | |3;audio-fft;76;75;77;115;76;76;77;76;111;76 10:40:57 INFO - PROCESS | 6247 | |4;audio-oscillator;86;85;124;84;84;84;112;83;84;112 10:40:57 INFO - PROCESS | 6247 | |5;imaging-gaussian-blur;118;117;117;118;118;117;118;118;118;117 10:40:57 INFO - PROCESS | 6247 | |6;imaging-darkroom;148;147;147;155;147;146;147;148;148;147 10:40:57 INFO - PROCESS | 6247 | |7;imaging-desaturate;95;95;95;96;95;95;95;96;95;95 10:40:57 INFO - PROCESS | 6247 | |8;json-parse-financial;64;63;64;64;65;63;65;63;64;64 10:40:57 INFO - PROCESS | 6247 | |9;json-stringify-tinderbox;67;66;67;66;66;66;71;66;66;66 10:40:57 INFO - PROCESS | 6247 | |10;stanford-crypto-aes;83;83;83;82;89;83;83;83;83;83 10:40:57 INFO - PROCESS | 6247 | |11;stanford-crypto-ccm;142;140;134;133;135;131;133;132;174;141 10:40:57 INFO - PROCESS | 6247 | |12;stanford-crypto-pbkdf2;179;175;177;177;181;176;172;172;170;176 10:40:57 INFO - PROCESS | 6247 | |13;stanford-crypto-sha256-iterative;70;70;70;70;70;69;68;70;69;67 10:40:57 INFO - PROCESS | 6247 | __end_tp_report 10:40:57 INFO - PROCESS | 6247 | __start_cc_report 10:40:57 INFO - PROCESS | 6247 | _x_x_mozilla_cycle_collect,1923 10:40:57 INFO - PROCESS | 6247 | __end_cc_report 10:40:57 INFO - PROCESS | 6247 | __startTimestamp1474566057594__endTimestamp 10:40:57 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | ------- Summary: start ------- 10:40:57 INFO - PROCESS | 6247 | Number of tests: 14 10:40:57 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:1.23 (1.1%) stddev-sans-first:1.22 10:40:57 INFO - PROCESS | 6247 | Values: 113.0 114.0 115.0 117.0 113.0 114.0 114.0 115.0 114.0 113.0 10:40:57 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:126.00 stddev:18.73 (14.9%) stddev-sans-first:18.42 10:40:57 INFO - PROCESS | 6247 | Values: 156.0 125.0 125.0 175.0 126.0 124.0 123.0 125.0 155.0 126.0 10:40:57 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 10:40:57 INFO - PROCESS | 6247 | Values: 162.0 161.0 162.0 161.0 162.0 161.0 163.0 161.0 162.0 162.0 10:40:57 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.00 stddev:15.59 (20.5%) stddev-sans-first:16.29 10:40:57 INFO - PROCESS | 6247 | Values: 76.0 75.0 77.0 115.0 76.0 76.0 77.0 76.0 111.0 76.0 10:40:57 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:84.00 stddev:15.68 (18.7%) stddev-sans-first:16.38 10:40:57 INFO - PROCESS | 6247 | Values: 86.0 85.0 124.0 84.0 84.0 84.0 112.0 83.0 84.0 112.0 10:40:57 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:40:57 INFO - PROCESS | 6247 | Values: 118.0 117.0 117.0 118.0 118.0 117.0 118.0 118.0 118.0 117.0 10:40:57 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:147.50 stddev:2.54 (1.7%) stddev-sans-first:2.69 10:40:57 INFO - PROCESS | 6247 | Values: 148.0 147.0 147.0 155.0 147.0 146.0 147.0 148.0 148.0 147.0 10:40:57 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:40:57 INFO - PROCESS | 6247 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 10:40:57 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 10:40:57 INFO - PROCESS | 6247 | Values: 64.0 63.0 64.0 64.0 65.0 63.0 65.0 63.0 64.0 64.0 10:40:57 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.00 stddev:1.57 (2.4%) stddev-sans-first:1.66 10:40:57 INFO - PROCESS | 6247 | Values: 67.0 66.0 67.0 66.0 66.0 66.0 71.0 66.0 66.0 66.0 10:40:57 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.00 stddev:1.96 (2.4%) stddev-sans-first:2.07 10:40:57 INFO - PROCESS | 6247 | Values: 83.0 83.0 83.0 82.0 89.0 83.0 83.0 83.0 83.0 83.0 10:40:57 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:137.50 stddev:12.75 (9.3%) stddev-sans-first:13.49 10:40:57 INFO - PROCESS | 6247 | Values: 142.0 140.0 134.0 133.0 135.0 131.0 133.0 132.0 174.0 141.0 10:40:57 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:176.50 stddev:3.37 (1.9%) stddev-sans-first:3.33 10:40:57 INFO - PROCESS | 6247 | Values: 179.0 175.0 177.0 177.0 181.0 176.0 172.0 172.0 170.0 176.0 10:40:57 INFO - PROCESS | 6247 | 10:40:57 INFO - PROCESS | 6247 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.00 stddev:1.06 (1.5%) stddev-sans-first:1.09 10:40:57 INFO - PROCESS | 6247 | Values: 70.0 70.0 70.0 70.0 70.0 69.0 68.0 70.0 69.0 67.0 10:40:57 INFO - PROCESS | 6247 | -------- Summary: end -------- 10:40:57 INFO - PROCESS | 6247 | 10:40:58 INFO - TEST-INFO | 6247: exit 0 10:40:58 INFO - TEST-OK | kraken | took 65149ms 10:40:58 INFO - SUITE-END | took 1187s 10:40:59 INFO - Completed test suite (00:19:47) 10:40:59 INFO - javascript benchmark 10:40:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2561.8206725529208, 2574.27920182349, 2618.6857577090746, 2628.15898912348, 2637.9076732314375, 4550.954490455095, 4590.334401511779, 4638.953610463895, 4647.093816705739, 4647.628189744821, 4660.86017419478, 4661.37071495348, 4672.789724462399, 4679.672422930396, 4692.718436893789, 4254.383114448403, 4278.25130602145, 4289.313709806432, 4303.956960430387, 4322.4164737760475, 4271.444712187426, 4286.464191976003, 4303.7848107594655, 4373.518912919592, 4414.536473670267, 4296.720713153635, 4350.260455722519, 4357.281048626973, 4365.497967733703, 4416.867493975186, 4351.042770590465, 4432.977835110803, 4436.979494716234, 4444.133393988173, 4465.419495465601, 4167.395727619509, 4203.7687927164, 4351.760653164075, 4376.803043863034, 4400.867973960786, 4598.241290187115, 4642.3500709900645, 4653.278741795028, 4675.438947326308, 4717.882052948669, 4829.203181475053, 4842.394700662418, 4859.368282123337, 4956.776945037482, 4998.300237966688, 4902.65681402302, 4952.232403977389, 4964.87587810304, 4980.726060066695, 5018.096742586333, 4553.612942899825, 4598.517155698603, 4606.124836281096, 4632.444106707183, 4652.674312798139, 5100.438951715309, 5121.07820592297, 5126.5898728101665, 5128.564072053917, 5188.481151884781, 4896.1921282987905, 4927.310176575283, 4931.950680493221, 4933.58064564516, 4940.209566469348, 4833.830815921497, 4878.36581244443, 4881.170201065827, 5007.023630392111, 5080.0, 4920.941997470561, 4981.252812078217, 5000.799968001312, 5001.049800537886, 5054.595632349403, 4938.1358262304675, 4941.48114447985, 4943.0, 4949.90100197994, 5001.124803159432, 4186.979065104655, 4279.828806847753, 4287.678424118141, 4290.905819016131, 4348.304271316638, 3689.741718079709, 3711.7030637548933, 3736.813159342022, 3757.962420375761, 3768.3028639701743, 4352.499462561783, 4388.341748737651, 4403.757793321398, 4404.977975110168, 4407.096545208225, 5007.874803129951, 5010.148274793221, 5034.748262586856, 5045.697258164522, 5113.309703190096, 4247.8088486018205, 4346.6088052075465, 4352.281873490839, 4357.2592659248, 4404.713693609905, 4491.73049617024, 4494.348319493655, 4557.293619488984, 4558.042811009659, 4618.792154353062, 4759.119562880878, 4765.0, 4767.928481072856, 4771.5228477152705, 4825.758712064453, 5024.145895197898, 5026.44709082008, 5031.698098114125, 5031.9245211322595, 5092.414372347227, 4620.306953956933, 4687.414073240845, 4750.263709125091, 4781.593564547053, 4786.832460863853, 5006.974965125151, 5025.422076461107, 5027.59779217669, 5027.74861256943, 5083.669561478492, 5048.444671086104, 5086.364204474441, 5092.41437234708, 5097.7706003229205, 5140.049090918192, 4735.786889589908, 4786.928196076992, 4866.1727506323305, 4877.048975449895, 4911.115999120193, 4951.950480495149, 4952.479989601185, 4953.133201689618, 4994.200927851526, 5013.448520662797, 4850.223964165716, 4863.90272194547, 4865.0756356292195, 4868.537488938687, 4937.654364194472, 4762.9523704762505, 4800.399950006249, 4883.706977581356, 4951.72765497901, 4978.1288274552535, 4840.201366774443, 4842.297866809223, 4857.684250523705, 4861.732604706775, 4866.78099485531], "value": 4608.1058088268155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.2875490617104, 557.2143277978051, 559.5663360895303, 576.7837061102086, 579.8695293558947, 27323.5901461478, 28017.29956751082, 30719.539206911857, 37168.699095531665, 38197.42703859444, 39862.80068599653, 40390.59609403905, 40412.393814092815, 40466.39300410489, 40466.39300410496, 7655.3110220080325, 7811.296983271504, 7817.2964433201005, 7822.256885595888, 7822.9217707823045, 6925.65371731414, 7035.190953040389, 7036.788896333092, 7234.457415693818, 7474.177840437547, 7267.345938865501, 9807.362521436084, 10060.949695251513, 10070.24473164512, 10350.844737328945, 9937.105660490555, 10008.79982400348, 10025.0, 10038.598456061749, 10061.0, 9853.359531630493, 9926.702198934043, 9929.453880036595, 9936.850947235796, 9938.254630902638, 36976.44535331972, 37259.62740372616, 37383.81308093469, 37411.438828417595, 37429.62570374316, 2842.4457230839994, 2908.5491748778973, 2932.164333165059, 2999.865006074732, 3412.7952322860706, 27830.0, 28248.717512824813, 28296.575551366746, 28349.85825070882, 28816.711832881614, 3383.5432216650684, 3539.982300088509, 3562.4656301554714, 3562.69717074049, 3620.6741393274733, 278018.0, 278836.0, 278940.0, 279217.0, 280357.5982120097, 49860.0, 50069.0, 50157.24764128541, 50172.24052677065, 50259.74870125626, 31503.36993260122, 32060.67939320577, 32175.0, 34100.0, 34146.658533414346, 14177.716445671029, 14298.28508574588, 14316.141031538142, 14327.35526901292, 14337.139771613736, 9886.110250077527, 9908.80182396348, 9913.058259465339, 9915.256355773347, 9919.80160396788, 15136.243187840564, 15331.616709582127, 17090.914545427193, 17103.14484275806, 17136.0, 6218.968905155445, 6402.199725034371, 6586.027549200323, 6700.363465470772, 6734.663266836638, 739.9075115610549, 781.3905153979905, 883.2889523933295, 951.3007939164709, 983.7934033852828, 26187.869060654957, 27455.588166177524, 27725.58411623827, 28107.297317567223, 28125.296867578476, 917.4862077236769, 922.5018490015451, 930.4417349590192, 963.6097380560884, 1000.7598176437602, 14086.577402677936, 14773.448787877118, 14808.62978425548, 14997.819796250024, 15006.0, 407948.920510797, 410477.0, 412355.0, 412399.0, 412774.0, 48174.5182548177, 48303.516964829905, 48479.5152048475, 48615.0, 48658.0, 1126.1778901402022, 1149.0635132367095, 1156.1213477756964, 1157.5543415785153, 1159.3217967489113, 25715.871420642776, 26880.193594192206, 26994.0, 27240.863795680896, 27465.862670686518, 40328.0, 40699.59300406958, 40701.18597627972, 40702.59297406988, 40710.389344159266, 330224.0, 330356.0, 331440.0, 331842.0, 332260.0, 24111.0, 24286.0, 24643.87678061598, 24844.37889052788, 24991.500169996863, 34070.31859362749, 34174.51530184331, 35927.820360898026, 38204.42693359657, 41716.374254386814, 33977.91837241037, 35114.0, 35387.46918796271, 35726.28547428985, 35753.46369804403, 35012.29975400427, 35081.64918350784, 35486.46770298499, 35563.28873422569, 35831.28337433185, 32725.836370817993, 32782.34435311328, 32831.0, 33111.66888331086, 34720.305593888486, 28382.71617283801, 28984.710152898202, 32421.35157296888, 32962.34075318528, 32992.1751956203, 24610.261692149263, 24951.87524062368, 25275.620865686662, 25360.112396066048, 25426.872865635552], "value": 17101.998648331166, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.20401891724697, 355.2007982040409, 356.35321890768256, 370.9944350834736, 388.5880966175854, 15371.231438428076, 16587.502374928743, 17499.825001749996, 17560.736588951175, 17613.383531576397, 16036.35854565816, 16917.238724257408, 17048.23282952267, 17144.142792860337, 17184.82815171848, 4829.275608658694, 5110.31010813541, 5112.8977420451565, 5114.053900028488, 5116.513931176551, 3691.50164727761, 3777.6977841772728, 5033.924491132618, 5594.888102237953, 5853.941460585404, 5919.141724449953, 5922.822315330525, 5927.762889484416, 5930.466258036776, 5936.347001829795, 5687.573431992617, 5809.448102430262, 5829.47534721877, 5845.123231515286, 5847.44449277318, 4925.975370123162, 5142.820001299937, 5146.614003949719, 5165.199394093921, 5169.2504586835075, 19787.40637780869, 20125.698114528295, 20142.39572812818, 20158.29445969384, 20211.393658190133, 1825.297260554696, 1865.020864046373, 1907.3324336482258, 2209.2930262316067, 2355.0815182079004, 12401.441935112942, 12891.0, 13261.933690331487, 13315.05073421254, 13631.454741810316, 1623.618449664328, 1671.189473105543, 1789.8568114550806, 1803.9278428862829, 1837.9540511487187, 68628.0, 70671.0, 71928.64035679841, 72409.6379518099, 72982.0, 9383.343165978316, 9509.191718703987, 9864.0, 9981.351212171186, 9989.200863930868, 13289.269090200132, 13324.133931294435, 13410.530631427853, 13629.727405451835, 13640.454381824617, 6792.72829086831, 6843.076184715, 7004.824879377954, 7234.891476627855, 7309.634518274065, 6428.935710642927, 6433.1636887205295, 6601.70292336846, 6605.933940660532, 6616.503762217757, 5976.760929562769, 6046.3046749624355, 6091.116788065706, 6102.0, 6239.220097487814, 1578.8657964072952, 1656.2464078844098, 1702.7020271452445, 1706.394230048315, 1761.2778760708304, 762.897008903802, 785.4912800525059, 813.938954578409, 827.7765003449156, 869.5739087847036, 16870.578235543962, 17163.31346746116, 17607.647847042987, 17755.201015954313, 18004.9099754503, 813.9064007639079, 822.56404105824, 826.557791581501, 835.1898658301438, 863.6329559937002, 7178.5692858428665, 9892.406455612687, 10078.344907580984, 10148.188144948386, 10180.847287290697, 372464.0, 373523.0, 373771.0, 376877.0, 377838.0, 68590.65704671445, 69803.3019669807, 69858.65070674614, 70228.2977170232, 71555.64222178856, 849.9490030598184, 864.1272314961808, 872.8079822439054, 876.513534988075, 879.0813599788108, 14780.63048423798, 15227.771583426036, 15462.458813941457, 15540.222988850739, 16061.75907361414, 34429.13927151841, 34819.47770783491, 36238.8188059058, 39137.2172556553, 40536.79731601323, 47003.0, 50512.74743626406, 50757.17806808347, 51796.741016294676, 51853.0, 6435.613863168038, 6590.736370545316, 6645.534812563074, 6957.095577574883, 7129.429645628441, 8030.317423019109, 10112.140468060003, 10202.846957295498, 10385.273030888067, 11329.320240785579, 9267.67563135287, 9556.283278754261, 9680.75798105053, 9858.457784821903, 9933.900660993586, 9301.302402319718, 9394.107559781809, 9491.810163796823, 9736.805263894541, 9822.65620703272, 9508.09673081084, 9680.128788409076, 9897.35667181631, 10074.899251007397, 10255.512950622267, 6583.0, 6679.666016699242, 6803.217629972419, 6988.336108069725, 7229.7469588564145, 7612.3148916597775, 9399.624015039322, 9693.854592180982, 9852.162566181669, 9894.010598940049], "value": 8109.66998863501, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.8353955755533, 1338.3308345827086, 1350.8108864758935, 1574.4568123997224, 1580.8340124286942, 6526.608403495794, 6774.559653622511, 7199.388052015578, 7889.092754333254, 7914.08987966384, 7210.170830354511, 7532.548047117177, 7541.773746787591, 7712.498687585303, 7721.845563088735, 1958.72577839103, 1987.5627361980341, 1991.950201244966, 1992.8505362097828, 1997.9900100499476, 1776.4493007167819, 1824.279409633194, 2032.6442872497255, 2133.6799480077957, 2135.743710754704, 2140.3685912655806, 2144.7211862457857, 2165.3936897668677, 2171.1206961180746, 2171.5331203791184, 2061.360978096795, 2116.121809449077, 2124.5644642848256, 2129.4995676016124, 2133.743950725923, 2046.4065421027883, 2050.456628993318, 2056.475598722316, 2060.5672808710187, 2066.95866082679, 7529.849403011964, 7536.208698086677, 7544.4718869679145, 7570.05374328209, 7587.582682952436, 4385.605295523418, 4567.794449249792, 4575.542445755431, 4578.679492435531, 4596.333531637927, 2755.6968733439307, 2879.424115176952, 2939.76481881449, 2944.528875379929, 2953.7636989040825, 907.4237858959608, 917.3440989692335, 929.1312622697799, 930.5719369090226, 940.4122423485321, 10657.147428205724, 10690.893091069067, 10709.625163119332, 10716.517756700967, 10724.571017159304, 3977.7215594908657, 4064.4309796628495, 4106.609872062149, 4188.979055104705, 4211.810468528924, 9028.18746312835, 9102.13529714676, 9108.453492790453, 9112.952010518875, 9118.0, 4592.7933243004145, 4612.930806037912, 4613.1465678848845, 4621.0, 4625.791839367236, 4131.35963925592, 4211.389348544444, 4218.050938538804, 4227.387028880795, 4229.217594744982, 3246.6915643013876, 3334.3998080345773, 3443.328550932594, 3459.775114617542, 3570.535830342039, 1144.4163476626813, 1150.5570355413226, 1161.5005547614437, 1161.8083016302385, 1181.1082632612322, 748.3751067858399, 758.6699785593285, 767.692922830861, 773.5010917957885, 779.1468342165319, 4970.353853998957, 4973.154563724175, 5084.313617661643, 5168.793248270027, 5309.469053094737, 791.1258059843905, 796.621604737745, 804.284187073505, 810.623060276974, 812.7683610171073, 3536.4695295705337, 3566.268914872445, 3592.856285748593, 3648.52569166012, 3704.444333350019, 8992.910070899206, 9738.318317717833, 9742.464164471023, 9755.804883902425, 9807.705768826947, 9702.75743106428, 9703.854442183372, 9712.805743885225, 9716.076972687584, 9717.951410243046, 6934.4452443804375, 7012.579245245403, 7035.472339574552, 7080.079589653312, 7087.89368159478, 5040.042391945519, 5088.033273677989, 5115.514026167508, 5271.314729085195, 5284.603654725988, 8789.296856251613, 8948.73153805387, 8977.506237157018, 8987.056359082464, 9056.230220431336, 8533.402661813614, 8763.956180219058, 8866.0, 9053.637854485747, 9053.68312109073, 6578.638174900427, 6726.562773419712, 6758.459323254227, 6765.086713293839, 6896.172459304916, 6399.8720025598295, 6674.098996635586, 6712.731490740511, 6950.478714096362, 7271.781846544401, 6434.806955791334, 6439.67801609927, 6493.253275873335, 6512.153420055362, 6525.282218956006, 6308.842278943063, 6376.840578985377, 6392.242133413349, 6411.230652321565, 6435.742570297136, 6020.488258498077, 6023.5181185505935, 6061.484628842789, 6069.726862291296, 6078.483328917092, 4455.908302465917, 4549.0, 4555.043440877453, 4580.0152967112235, 4604.424446944132, 4538.591526762607, 4562.224421848227, 4579.908401831878, 4668.323093151406, 4781.832635857867], "value": 4026.7726984066726, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.62309063581404, 295.4534111892998, 299.89503673714205, 303.1149044789215, 303.1239717217241, 4643.930341044887, 4813.326134341186, 4830.806767729291, 4873.853784386465, 4890.4131504219495, 4612.446506419226, 4744.478107408182, 4753.548412900769, 4767.736549814302, 4787.162246606838, 3768.434734789776, 3770.5475342958885, 3778.9782466380493, 3779.8677046303246, 3812.694984401255, 3589.2642008388216, 3590.8922732318074, 3808.409696497047, 3810.8285127169343, 3813.2564149990626, 3723.5345581802276, 3740.9064773380746, 3756.9436458453147, 3766.9811650941706, 3782.1490164712995, 3734.8692795752017, 3742.2328422673286, 3778.7732736035787, 3779.2819364320967, 3781.243751249761, 3289.243474000993, 3299.8350082496017, 3300.9174770630684, 3302.1744563859033, 3310.519974603693, 4632.884177895546, 4658.697184682985, 4697.295405689139, 4698.3187437821325, 4721.480637129913, 4259.8509052183335, 4263.424437700902, 4265.957340426618, 4268.06102657418, 4278.743275403454, 5072.467390923936, 5072.54347108762, 5073.568746656501, 5087.872803179913, 5094.363204599425, 3520.137566296248, 3534.1871369584883, 3559.469428145922, 3631.5823680276844, 3632.291703117893, 5216.217567364888, 5219.478052194788, 5231.215317702337, 5233.241180028875, 5246.921296180561, 3660.8285348688696, 3661.8465183467124, 3663.8351274192723, 3669.7614655047337, 3669.9082522936606, 3717.851285948586, 3752.493413389212, 3755.248950209969, 3765.548134223856, 3768.6419790119894, 4127.174565086994, 4181.310083836133, 4184.037671335549, 4210.873673789792, 4240.745555266694, 4998.850034498971, 5005.9749701251985, 5012.298278241049, 5018.498150185025, 5057.974710126426, 1213.6359092272282, 1250.1811313589612, 1295.9870401296055, 1315.15829868884, 1324.3709238112012, 871.5642178910545, 898.8786513820681, 899.132337294514, 904.6475519098989, 906.9138431848963, 4472.373867658531, 4486.484054333793, 4491.685582009293, 4498.775061246924, 4501.459824821042, 5132.769025393866, 5147.897042059138, 5165.48345165488, 5192.247124166975, 5204.297419848348, 4337.067530480962, 4437.247287321555, 4437.733735975788, 4452.643788496913, 4458.219811533034, 2698.689650690196, 2725.945481090367, 2731.517315422812, 2733.1687769194687, 2736.54846950255, 4874.147024270738, 4880.902381952341, 4899.853004409873, 4911.729854857946, 4930.852074437773, 5016.247562865599, 5175.792968281226, 5189.7405129743365, 5194.246834209094, 5208.5312321891215, 4799.784009719501, 4808.687435316693, 4822.927656085161, 4833.26920290035, 4837.975810120927, 4922.883160241131, 5104.69371837691, 5110.671225481476, 5120.513551212629, 5161.380634323905, 4996.450390457119, 4999.450060493416, 5003.774830132726, 5004.42449118356, 5006.574441172541, 4769.4753577107185, 4817.397825271841, 4847.248676455155, 4852.199387101089, 4889.535494128052, 3690.760100593453, 3708.0, 3710.109573702238, 3724.459953306701, 3727.1800203955086, 4972.632526055364, 5075.3402057732255, 5080.466551012239, 5087.898242035212, 5102.413222479462, 4927.162382394929, 4940.654154209171, 4940.827071052496, 4942.1598328285, 4971.701697898137, 4978.4025916890205, 4988.625853060962, 4995.525425084611, 5002.499250224845, 5007.824726134568, 4697.201475749199, 4756.405449318835, 4905.669806841722, 4973.950260497493, 5024.397072351341, 4881.1445304497265, 5063.594912406925, 5113.64204505681, 5121.41236216774, 5121.8463446096675, 5000.949990500048, 5007.4977506748555, 5009.474005229398, 5012.724300163526, 5023.196288593807], "value": 3789.5886852232993, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.7612954818072, 603.0983679399299, 634.7651368993473, 643.8100760275721, 677.8983152527123, 11724.706882327935, 12636.178648387848, 12695.301758403284, 12702.110852240347, 12799.0, 10996.615118470854, 11426.25729327593, 11489.482973266202, 11513.424328783549, 11520.769584608302, 712.2201189697286, 742.0872327037747, 744.1591002167543, 745.2063552316765, 746.5110352718978, 722.7651013420633, 722.9638518074102, 723.0311382747118, 723.1105739939877, 723.4863247094569, 757.4205732614554, 757.4924800383756, 758.0145810446397, 758.1811643425087, 758.6168984662737, 752.6951584608188, 753.6118898767139, 754.3022703998779, 754.5585832288118, 756.4591317208195, 555.2310050579936, 555.555555555554, 555.5833125156133, 555.6249531566217, 557.8465921871518, 11488.36813975231, 11495.367754773484, 11501.367424791633, 11517.36654484003, 11527.654170374903, 13361.465541378333, 13437.260950647711, 13600.659983500393, 13600.727985440335, 13973.930130349283, 10244.846327305097, 10445.321054131457, 10574.841377379345, 10693.893061069368, 10946.39794811285, 3291.2923721399775, 3293.3413317336626, 3303.4219011672863, 3334.6498617645284, 3354.8658053677823, 52748.0, 53805.0, 67981.320186798, 68312.89708227324, 69253.65373173101, 9962.302638815214, 10058.698239052841, 10141.695749127539, 10261.333013354108, 10264.743381415376, 17827.821721782617, 17852.732209016875, 17855.28578856831, 17907.910460447616, 17952.371666991854, 6802.761903333359, 6819.283975182633, 6959.478039147084, 6978.406835419046, 7085.822854428578, 3546.592141903714, 3584.2652256287397, 3656.846617815652, 3690.2619476104887, 3766.9058273543383, 2807.1297897651793, 2877.5971364009056, 2910.6070680457865, 2925.0347385363207, 2925.9122226333243, 491.50112635674816, 492.7856382473635, 497.6541303793901, 503.90173916086746, 505.69910903012646, 530.2841164427991, 560.7981126794351, 567.0813282482322, 583.7198144890391, 590.3329237961076, 7584.0, 7664.594797893816, 7664.923350766421, 7847.097583777824, 7880.566568838654, 435.6514788169515, 532.3239485852945, 557.8103444828778, 583.2068386993685, 586.1442294250357, 3619.728520360931, 3631.1648320886343, 3676.540432445944, 3687.741858069963, 3802.4676545283683, 62459.06311405332, 79713.60143199247, 82838.17161828425, 109620.0, 110076.0, 61229.69385153046, 87307.0, 87912.0, 88469.55765221262, 92827.5358623216, 48638.5136148641, 77288.61355693186, 80154.59922700349, 80628.0, 82469.0, 6941.861162776615, 6946.37482626566, 7051.612161330971, 7325.706971721072, 7402.629868506661, 46128.308075379566, 48114.27828582504, 49032.0, 49045.75477122592, 49402.50597493979, 40630.79684601558, 62772.372276276656, 66528.6673566629, 68158.3184168152, 72097.6395118021, 9608.95195524018, 9856.21150307988, 9908.0, 10087.29388942767, 10138.79722405533, 11003.546630701027, 11165.162612804235, 11554.59558915434, 11710.180287379802, 11919.04647628205, 10108.292419530562, 10359.171266298526, 10618.415987120783, 10756.408397538211, 11049.39228342449, 10977.17671174681, 11280.0, 11497.597584084851, 11551.595694151001, 11729.824052639387, 9659.951700241454, 9760.85358719634, 9919.40483570988, 10312.535935882754, 10336.0, 8665.393422460367, 8724.825503489768, 8859.379843411158, 8871.467711937305, 9102.954485227532, 8945.552722363986, 9444.411302670575, 9535.427874327563, 9656.908530585415, 9792.902070979198], "value": 6234.266223114338, "unit": "score"}], "name": "dromaeo_css", "value": 6270.845929656135, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 117.0, 113.0, 114.0, 114.0, 115.0, 114.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 125.0, 175.0, 126.0, 124.0, 123.0, 125.0, 155.0, 126.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 162.0, 161.0, 163.0, 161.0, 162.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 115.0, 76.0, 76.0, 77.0, 76.0, 111.0, 76.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 124.0, 84.0, 84.0, 84.0, 112.0, 83.0, 84.0, 112.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 155.0, 147.0, 146.0, 147.0, 148.0, 148.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 65.0, 63.0, 65.0, 63.0, 64.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 66.0, 66.0, 71.0, 66.0, 66.0, 66.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 82.0, 89.0, 83.0, 83.0, 83.0, 83.0, 83.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 140.0, 134.0, 133.0, 135.0, 131.0, 133.0, 132.0, 174.0, 141.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 175.0, 177.0, 177.0, 181.0, 176.0, 172.0, 172.0, 170.0, 176.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 70.0, 70.0, 69.0, 68.0, 70.0, 69.0, 67.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1548.3999999999999, "alertThreshold": 2.0}]} 10:40:59 INFO - Return code: 0 10:40:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:40:59 INFO - # TBPL SUCCESS # 10:40:59 INFO - Running post-action listener: _resource_record_post_action 10:40:59 INFO - [mozharness: 2016-09-22 17:40:59.377692Z] Finished run-tests step (success) 10:40:59 INFO - Running post-run listener: _resource_record_post_run 10:40:59 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 388763648; Read time: 0; Write time: 223340 10:40:59 INFO - TinderboxPrint: CPU usage
13.0% 10:40:59 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:40:59 INFO - TinderboxPrint: I/O write bytes / time
388,763,648 / 223,340 10:40:59 INFO - TinderboxPrint: CPU idle
8,355.6 (87.0%) 10:40:59 INFO - TinderboxPrint: CPU user
1,201.3 (12.5%) 10:40:59 INFO - TinderboxPrint: Swap in / out
0 / 0 10:40:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99061760; Read time: 0; Write time: 53304 10:40:59 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 288538624; Read time: 0; Write time: 170008 10:41:00 INFO - Running post-run listener: _upload_blobber_files 10:41:00 INFO - Blob upload gear active. 10:41:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:41:00 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 10:41:00 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:41:00 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:41:00 INFO - (blobuploader) - INFO - Open directory for files ... 10:41:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:41:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:41:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:03 INFO - (blobuploader) - INFO - Done attempting. 10:41:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:41:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:41:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:04 INFO - (blobuploader) - INFO - Done attempting. 10:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:41:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:05 INFO - (blobuploader) - INFO - Done attempting. 10:41:05 INFO - (blobuploader) - INFO - Iteration through files over. 10:41:05 INFO - Return code: 0 10:41:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:41:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:41:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3f59d3ee2d6bafe8464b9b340467d023156801aa42a9a8bd1f94b45e5bb0d5a78cef088b9be8ad9545631b2638a438691122a8cb117f2cb70c0276f6266ae3d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b166a5fff6b5c3a16d34f6c121d2183a35b78accae8a6b8b44ab7147f7c27206ef8ce4739f02cf897e7011cd4c18c12a69f3b20103a7d1c3cc7c7b258fa00b23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/03cf81d72ae4aab2f9503b780b61fd90f6a1ecece58a5656286a1b0f524c1047913584c35c53a90fa5f66720e6a8f903501ec97be2ca4d5ed4e8217f7e98a553"} 10:41:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:41:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:41:05 INFO - Contents: 10:41:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3f59d3ee2d6bafe8464b9b340467d023156801aa42a9a8bd1f94b45e5bb0d5a78cef088b9be8ad9545631b2638a438691122a8cb117f2cb70c0276f6266ae3d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b166a5fff6b5c3a16d34f6c121d2183a35b78accae8a6b8b44ab7147f7c27206ef8ce4739f02cf897e7011cd4c18c12a69f3b20103a7d1c3cc7c7b258fa00b23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/03cf81d72ae4aab2f9503b780b61fd90f6a1ecece58a5656286a1b0f524c1047913584c35c53a90fa5f66720e6a8f903501ec97be2ca4d5ed4e8217f7e98a553"} 10:41:05 INFO - Running post-run listener: copy_logs_to_upload_dir 10:41:05 INFO - Copying logs to upload dir... 10:41:05 INFO - mkdir: /builds/slave/test/build/upload/logs 10:41:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.091045 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-22 10:41:05.391389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 10:41:05.395317) ========= 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=d2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3f59d3ee2d6bafe8464b9b340467d023156801aa42a9a8bd1f94b45e5bb0d5a78cef088b9be8ad9545631b2638a438691122a8cb117f2cb70c0276f6266ae3d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b166a5fff6b5c3a16d34f6c121d2183a35b78accae8a6b8b44ab7147f7c27206ef8ce4739f02cf897e7011cd4c18c12a69f3b20103a7d1c3cc7c7b258fa00b23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/03cf81d72ae4aab2f9503b780b61fd90f6a1ecece58a5656286a1b0f524c1047913584c35c53a90fa5f66720e6a8f903501ec97be2ca4d5ed4e8217f7e98a553"} build_url:https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011425 build_url: 'https://queue.taskcluster.net/v1/task/EHHIQd2xTByP89-t4-7Zyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3f59d3ee2d6bafe8464b9b340467d023156801aa42a9a8bd1f94b45e5bb0d5a78cef088b9be8ad9545631b2638a438691122a8cb117f2cb70c0276f6266ae3d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b166a5fff6b5c3a16d34f6c121d2183a35b78accae8a6b8b44ab7147f7c27206ef8ce4739f02cf897e7011cd4c18c12a69f3b20103a7d1c3cc7c7b258fa00b23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/03cf81d72ae4aab2f9503b780b61fd90f6a1ecece58a5656286a1b0f524c1047913584c35c53a90fa5f66720e6a8f903501ec97be2ca4d5ed4e8217f7e98a553"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 10:41:05.420863) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 10:41:05.421228) ========= 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=d2a8c569965ab8367867b893000001a1-1474564815.435214-1339564673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 10:41:05.503755) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 10:41:05.504093) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 10:41:05.504508) ========= ========= Total master_lag: 0.82 =========