builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1482275348.99 results: success (0) buildid: 20161220133017 builduid: 036521b16e024e3fac2fbfb094ab78a3 revision: 7083c0d30e75fc102c715887af9faec933e936f8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 15:09:08.988653) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 15:09:08.989207) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 15:09:08.989538) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 15:09:09.005370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 15:09:09.005859) ========= 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=c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-20 15:09:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-12-20 15:09:09 (43.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076298 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 15:09:09.106094) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 15:09:09.106521) ========= 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=c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018901 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 15:09:09.159235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 15:09:09.160119) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7083c0d30e75fc102c715887af9faec933e936f8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7083c0d30e75fc102c715887af9faec933e936f8 --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=c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-20 15:09:09,443 truncating revision to first 12 chars 2016-12-20 15:09:09,444 Setting DEBUG logging. 2016-12-20 15:09:09,444 attempt 1/10 2016-12-20 15:09:09,444 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7083c0d30e75?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-20 15:09:09,747 unpacking tar archive at: mozilla-central-7083c0d30e75/testing/mozharness/ program finished with exit code 0 elapsedTime=0.612938 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 15:09:09.788936) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 15:09:09.789309) ========= script_repo_revision: 7083c0d30e75fc102c715887af9faec933e936f8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 15:09:09.789779) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 15:09:09.790122) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 15:09:09.799808) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-12-20 15:09:09.800209) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:09:10 INFO - MultiFileLogger online at 20161220 15:09:10 in /builds/slave/test 15:09:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:09:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:09:10 INFO - {'append_to_log': False, 15:09:10 INFO - 'base_work_dir': '/builds/slave/test', 15:09:10 INFO - 'blob_upload_branch': 'Firefox', 15:09:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:09:10 INFO - 'branch': 'Firefox', 15:09:10 INFO - 'buildbot_json_path': 'buildprops.json', 15:09:10 INFO - 'config_files': ('talos/linux_config.py',), 15:09:10 INFO - 'default_actions': ('clobber', 15:09:10 INFO - 'read-buildbot-config', 15:09:10 INFO - 'download-and-extract', 15:09:10 INFO - 'populate-webroot', 15:09:10 INFO - 'create-virtualenv', 15:09:10 INFO - 'install', 15:09:10 INFO - 'run-tests'), 15:09:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:09:10 INFO - 'download_minidump_stackwalk': True, 15:09:10 INFO - 'download_symbols': 'ondemand', 15:09:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:09:10 INFO - 'tooltool.py': '/tools/tooltool.py', 15:09:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:09:10 INFO - '/tools/misc-python/virtualenv.py')}, 15:09:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:09:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:09:10 INFO - 'installer_path': 'installer.exe', 15:09:10 INFO - 'log_level': 'info', 15:09:10 INFO - 'log_name': 'talos', 15:09:10 INFO - 'log_to_console': True, 15:09:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:09:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:09:10 INFO - 'opt_config_files': (), 15:09:10 INFO - 'pip_index': False, 15:09:10 INFO - 'sps_profile': False, 15:09:10 INFO - 'sps_profile_interval': 0, 15:09:10 INFO - 'suite': 'dromaeojs', 15:09:10 INFO - 'system_bits': '32', 15:09:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:09:10 INFO - 'title': 'talos-linux64-ix-004', 15:09:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:09:10 INFO - 'use_talos_json': True, 15:09:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:09:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:09:10 INFO - 'work_dir': 'build'} 15:09:10 INFO - [mozharness: 2016-12-20 23:09:10.181442Z] Running clobber step. 15:09:10 INFO - Running pre-action listener: _resource_record_pre_action 15:09:10 INFO - Running main action method: clobber 15:09:10 INFO - rmtree: /builds/slave/test/build 15:09:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:09:10 INFO - Running post-action listener: _resource_record_post_action 15:09:10 INFO - [mozharness: 2016-12-20 23:09:10.636885Z] Finished clobber step (success) 15:09:10 INFO - [mozharness: 2016-12-20 23:09:10.636986Z] Running read-buildbot-config step. 15:09:10 INFO - Running pre-action listener: _resource_record_pre_action 15:09:10 INFO - Running main action method: read_buildbot_config 15:09:10 INFO - Using buildbot properties: 15:09:10 INFO - { 15:09:10 INFO - "project": "", 15:09:10 INFO - "product": "firefox", 15:09:10 INFO - "script_repo_revision": "production", 15:09:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:09:10 INFO - "repository": "", 15:09:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 15:09:10 INFO - "buildid": "20161220133017", 15:09:10 INFO - "pgo_build": "True", 15:09:10 INFO - "basedir": "/builds/slave/test", 15:09:10 INFO - "buildnumber": 135, 15:09:10 INFO - "slavename": "talos-linux64-ix-004", 15:09:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:09:10 INFO - "platform": "ubuntu64_hw", 15:09:10 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 15:09:10 INFO - "branch": "mozilla-central", 15:09:10 INFO - "repo_path": "mozilla-central", 15:09:10 INFO - "revision": "7083c0d30e75fc102c715887af9faec933e936f8", 15:09:10 INFO - "stage_platform": "linux64-pgo", 15:09:10 INFO - "builduid": "036521b16e024e3fac2fbfb094ab78a3", 15:09:10 INFO - "slavebuilddir": "test" 15:09:10 INFO - } 15:09:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 15:09:10 INFO - Running post-action listener: _resource_record_post_action 15:09:10 INFO - [mozharness: 2016-12-20 23:09:10.639444Z] Finished read-buildbot-config step (success) 15:09:10 INFO - [mozharness: 2016-12-20 23:09:10.639534Z] Running download-and-extract step. 15:09:10 INFO - Running pre-action listener: _resource_record_pre_action 15:09:10 INFO - Running main action method: download_and_extract 15:09:10 INFO - mkdir: /builds/slave/test/build/tests 15:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:09:10 INFO - trying https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:09:10 INFO - Downloading https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:09:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:09:11 INFO - Downloaded 1361 bytes. 15:09:11 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:09:11 INFO - Using the following test package requirements: 15:09:11 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:09:11 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:09:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:09:11 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:09:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:09:11 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:09:11 INFO - u'jsshell-linux-x86_64.zip'], 15:09:11 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:09:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:09:11 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:09:11 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:09:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:09:11 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:09:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:09:11 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:09:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:09:11 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:09:11 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:09:11 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:09:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:09:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:09:11 INFO - Fetch https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:09:12 INFO - Expected file size: 21835356 15:09:12 INFO - Obtained file size: 21835356 15:09:16 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:09:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:09:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:09:16 INFO - Fetch https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:09:16 INFO - Expected file size: 21835356 15:09:16 INFO - Obtained file size: 21835356 15:09:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 15:09:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:09:21 INFO - Fetch https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:09:22 INFO - Expected file size: 14409734 15:09:22 INFO - Obtained file size: 14409734 15:09:22 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')]} 15:09:22 INFO - trying https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:09:22 INFO - Downloading https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:09:23 INFO - Downloaded 59819932 bytes. 15:09:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:09:23 INFO - mkdir: /builds/slave/test/properties 15:09:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:09:23 INFO - Writing to file /builds/slave/test/properties/build_url 15:09:23 INFO - Contents: 15:09:23 INFO - build_url:https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:09:24 INFO - Running post-action listener: _resource_record_post_action 15:09:24 INFO - Running post-action listener: set_extra_try_arguments 15:09:24 INFO - [mozharness: 2016-12-20 23:09:24.477139Z] Finished download-and-extract step (success) 15:09:24 INFO - [mozharness: 2016-12-20 23:09:24.477367Z] Running populate-webroot step. 15:09:24 INFO - Running pre-action listener: _resource_record_pre_action 15:09:24 INFO - Running main action method: populate_webroot 15:09:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:09:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:09:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:09:24 INFO - '--tppagecycles', 15:09:24 INFO - '7'], 15:09:24 INFO - 'tests': ['tsvgm']}}, 15:09:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:09:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:09:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:09:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:09:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:09:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:09:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:09:24 INFO - 'talos_options': ['--disable-e10s'], 15:09:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:09:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:09:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:09:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:09:24 INFO - 'talos_options': ['--disable-e10s'], 15:09:24 INFO - 'tests': ['damp', 'tps']}, 15:09:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:09:24 INFO - 'tests': ['damp', 'tps']}, 15:09:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:09:24 INFO - 'tests': ['dromaeo_dom']}, 15:09:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:09:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:09:24 INFO - 'tests': ['basic_compositor_video']}, 15:09:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:09:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:09:24 INFO - 'tests': ['a11yr', 15:09:24 INFO - 'ts_paint', 15:09:24 INFO - 'tpaint', 15:09:24 INFO - 'sessionrestore', 15:09:24 INFO - 'sessionrestore_no_auto_restore', 15:09:24 INFO - 'tabpaint']}, 15:09:24 INFO - 'other-e10s': {'tests': ['a11yr', 15:09:24 INFO - 'ts_paint', 15:09:24 INFO - 'tpaint', 15:09:24 INFO - 'sessionrestore', 15:09:24 INFO - 'sessionrestore_no_auto_restore', 15:09:24 INFO - 'tabpaint']}, 15:09:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:09:24 INFO - 'ts_paint', 15:09:24 INFO - 'tpaint', 15:09:24 INFO - 'sessionrestore', 15:09:24 INFO - 'sessionrestore_no_auto_restore', 15:09:24 INFO - 'tabpaint']}, 15:09:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:09:24 INFO - 'ts_paint', 15:09:24 INFO - 'tpaint', 15:09:24 INFO - 'sessionrestore', 15:09:24 INFO - 'sessionrestore_no_auto_restore', 15:09:24 INFO - 'tabpaint']}, 15:09:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:09:24 INFO - 'tests': ['a11yr', 15:09:24 INFO - 'ts_paint', 15:09:24 INFO - 'tpaint', 15:09:24 INFO - 'sessionrestore', 15:09:24 INFO - 'sessionrestore_no_auto_restore', 15:09:24 INFO - 'tabpaint']}, 15:09:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:09:24 INFO - 'tests': ['a11yr', 15:09:24 INFO - 'ts_paint', 15:09:24 INFO - 'tpaint', 15:09:24 INFO - 'sessionrestore', 15:09:24 INFO - 'sessionrestore_no_auto_restore', 15:09:24 INFO - 'tabpaint']}, 15:09:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:09:24 INFO - 'tests': ['tsvgx', 15:09:24 INFO - 'tsvgr_opacity', 15:09:24 INFO - 'tart', 15:09:24 INFO - 'tscrollx', 15:09:24 INFO - 'cart', 15:09:24 INFO - 'tsvg_static']}, 15:09:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:09:24 INFO - 'tsvgr_opacity', 15:09:24 INFO - 'tart', 15:09:24 INFO - 'tscrollx', 15:09:24 INFO - 'cart', 15:09:24 INFO - 'tsvg_static']}, 15:09:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:09:24 INFO - 'talos_options': ['--disable-e10s'], 15:09:24 INFO - 'tests': ['tp5o']}, 15:09:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:09:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:09:24 INFO - 'talos_options': ['--disable-e10s', 15:09:24 INFO - '--xperf_path', 15:09:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:09:24 INFO - 'tests': ['tp5n']}, 15:09:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:09:24 INFO - 'talos_options': ['--xperf_path', 15:09:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:09:24 INFO - 'tests': ['tp5n']}}, 15:09:24 INFO - 'talos.zip': {'path': '', 15:09:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:09:24 INFO - Running post-action listener: _resource_record_post_action 15:09:24 INFO - [mozharness: 2016-12-20 23:09:24.494087Z] Finished populate-webroot step (success) 15:09:24 INFO - [mozharness: 2016-12-20 23:09:24.494176Z] Running create-virtualenv step. 15:09:24 INFO - Running pre-action listener: _resource_record_pre_action 15:09:24 INFO - Running main action method: create_virtualenv 15:09:24 INFO - Creating virtualenv /builds/slave/test/build/venv 15:09:24 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 15:09:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:09:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:09:24 INFO - Using real prefix '/usr' 15:09:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:09:25 INFO - Installing distribute.............................................................................................................................................................................................done. 15:09:27 INFO - Installing pip.................done. 15:09:27 INFO - Return code: 0 15:09:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:09:27 INFO - Reading from file tmpfile_stdout 15:09:27 INFO - Output received: 15:09:27 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:09:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:09:27 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')]} 15:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:27 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')]} 15:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:27 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 0x15dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c3f0>, '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 0x194ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194d1a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', '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 15:09:27 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 15:09:27 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 15:09:27 INFO - Using env: {'DISPLAY': ':0', 15:09:27 INFO - 'HOME': '/home/cltbld', 15:09:27 INFO - 'LANG': 'en_US.UTF-8', 15:09:27 INFO - 'LANGUAGE': 'en_US:en', 15:09:27 INFO - 'LOGNAME': 'cltbld', 15:09:27 INFO - 'MAIL': '/var/mail/cltbld', 15:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:27 INFO - 'MOZ_NO_REMOTE': '1', 15:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:27 INFO - 'NO_EM_RESTART': '1', 15:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:27 INFO - 'PWD': '/builds/slave/test', 15:09:27 INFO - 'SHELL': '/bin/bash', 15:09:27 INFO - 'SHLVL': '1', 15:09:27 INFO - 'TERM': 'linux', 15:09:27 INFO - 'TMOUT': '86400', 15:09:27 INFO - 'USER': 'cltbld', 15:09:27 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', 15:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:27 INFO - '_': '/tools/buildbot/bin/python'} 15:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:27 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 15:09:27 INFO - Cleaning up... 15:09:27 INFO - Return code: 0 15:09:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:09:27 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')]} 15:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:27 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')]} 15:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:27 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 0x15dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c3f0>, '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 0x194ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194d1a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', '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 15:09:27 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 15:09:27 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 15:09:27 INFO - Using env: {'DISPLAY': ':0', 15:09:27 INFO - 'HOME': '/home/cltbld', 15:09:27 INFO - 'LANG': 'en_US.UTF-8', 15:09:27 INFO - 'LANGUAGE': 'en_US:en', 15:09:27 INFO - 'LOGNAME': 'cltbld', 15:09:27 INFO - 'MAIL': '/var/mail/cltbld', 15:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:27 INFO - 'MOZ_NO_REMOTE': '1', 15:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:27 INFO - 'NO_EM_RESTART': '1', 15:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:27 INFO - 'PWD': '/builds/slave/test', 15:09:27 INFO - 'SHELL': '/bin/bash', 15:09:27 INFO - 'SHLVL': '1', 15:09:27 INFO - 'TERM': 'linux', 15:09:27 INFO - 'TMOUT': '86400', 15:09:27 INFO - 'USER': 'cltbld', 15:09:27 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', 15:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:27 INFO - '_': '/tools/buildbot/bin/python'} 15:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:27 INFO - Downloading/unpacking psutil>=3.1.1 15:09:27 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 15:09:27 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 15:09:27 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 15:09:27 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 15:09:27 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 15:09:27 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 15:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:09:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:09:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:09:29 INFO - Installing collected packages: psutil 15:09:29 INFO - Running setup.py install for psutil 15:09:29 INFO - building 'psutil._psutil_linux' extension 15:09:29 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 15:09:30 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 15:09:30 INFO - building 'psutil._psutil_posix' extension 15:09:30 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 15:09:30 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 15:09:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:09:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:09:30 INFO - Successfully installed psutil 15:09:30 INFO - Cleaning up... 15:09:30 INFO - Return code: 0 15:09:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:09: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')]} 15:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09: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')]} 15:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:30 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 0x15dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c3f0>, '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 0x194ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194d1a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', '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 15:09:30 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 15:09:30 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 15:09:30 INFO - Using env: {'DISPLAY': ':0', 15:09:30 INFO - 'HOME': '/home/cltbld', 15:09:30 INFO - 'LANG': 'en_US.UTF-8', 15:09:30 INFO - 'LANGUAGE': 'en_US:en', 15:09:30 INFO - 'LOGNAME': 'cltbld', 15:09:30 INFO - 'MAIL': '/var/mail/cltbld', 15:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:30 INFO - 'MOZ_NO_REMOTE': '1', 15:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:30 INFO - 'NO_EM_RESTART': '1', 15:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:30 INFO - 'PWD': '/builds/slave/test', 15:09:30 INFO - 'SHELL': '/bin/bash', 15:09:30 INFO - 'SHLVL': '1', 15:09:30 INFO - 'TERM': 'linux', 15:09:30 INFO - 'TMOUT': '86400', 15:09:30 INFO - 'USER': 'cltbld', 15:09:30 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', 15:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:30 INFO - '_': '/tools/buildbot/bin/python'} 15:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:09:30 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 15:09:30 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 15:09:30 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 15:09:30 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 15:09:30 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 15:09:30 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 15:09:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:09:32 INFO - Installing collected packages: mozsystemmonitor 15:09:32 INFO - Running setup.py install for mozsystemmonitor 15:09:32 INFO - Successfully installed mozsystemmonitor 15:09:32 INFO - Cleaning up... 15:09:32 INFO - Return code: 0 15:09:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:09:32 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')]} 15:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:32 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')]} 15:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:32 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 0x15dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c3f0>, '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 0x194ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194d1a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', '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 15:09:32 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 15:09:32 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 15:09:32 INFO - Using env: {'DISPLAY': ':0', 15:09:32 INFO - 'HOME': '/home/cltbld', 15:09:32 INFO - 'LANG': 'en_US.UTF-8', 15:09:32 INFO - 'LANGUAGE': 'en_US:en', 15:09:32 INFO - 'LOGNAME': 'cltbld', 15:09:32 INFO - 'MAIL': '/var/mail/cltbld', 15:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:32 INFO - 'MOZ_NO_REMOTE': '1', 15:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:32 INFO - 'NO_EM_RESTART': '1', 15:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:32 INFO - 'PWD': '/builds/slave/test', 15:09:32 INFO - 'SHELL': '/bin/bash', 15:09:32 INFO - 'SHLVL': '1', 15:09:32 INFO - 'TERM': 'linux', 15:09:32 INFO - 'TMOUT': '86400', 15:09:32 INFO - 'USER': 'cltbld', 15:09:32 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', 15:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:32 INFO - '_': '/tools/buildbot/bin/python'} 15:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:33 INFO - Downloading/unpacking jsonschema==2.5.1 15:09:33 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 15:09:33 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 15:09:33 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 15:09:33 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 15:09:33 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 15:09:33 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 15:09:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:09:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:09:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:09:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:09:35 INFO - Downloading functools32-3.2.3-2.tar.gz 15:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:09:35 INFO - warning: no files found matching '*.txt' 15:09:35 INFO - no previously-included directories found matching 'build' 15:09:35 INFO - no previously-included directories found matching 'dist' 15:09:35 INFO - no previously-included directories found matching '.git*' 15:09:35 INFO - Installing collected packages: jsonschema, functools32 15:09:35 INFO - Running setup.py install for functools32 15:09:35 INFO - warning: no files found matching '*.txt' 15:09:35 INFO - no previously-included directories found matching 'build' 15:09:35 INFO - no previously-included directories found matching 'dist' 15:09:35 INFO - no previously-included directories found matching '.git*' 15:09:35 INFO - Successfully installed jsonschema functools32 15:09:35 INFO - Cleaning up... 15:09:35 INFO - Return code: 0 15:09:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:09: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')]} 15:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09: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')]} 15:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09: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', '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 0x15dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c3f0>, '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 0x194ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194d1a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', '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 15:09: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:09: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 functools32==3.2.3-2 15:09:35 INFO - Using env: {'DISPLAY': ':0', 15:09:35 INFO - 'HOME': '/home/cltbld', 15:09:35 INFO - 'LANG': 'en_US.UTF-8', 15:09:35 INFO - 'LANGUAGE': 'en_US:en', 15:09:35 INFO - 'LOGNAME': 'cltbld', 15:09:35 INFO - 'MAIL': '/var/mail/cltbld', 15:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:35 INFO - 'MOZ_NO_REMOTE': '1', 15:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:35 INFO - 'NO_EM_RESTART': '1', 15:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:35 INFO - 'PWD': '/builds/slave/test', 15:09:35 INFO - 'SHELL': '/bin/bash', 15:09:35 INFO - 'SHLVL': '1', 15:09:35 INFO - 'TERM': 'linux', 15:09:35 INFO - 'TMOUT': '86400', 15:09:35 INFO - 'USER': 'cltbld', 15:09:35 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', 15:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:35 INFO - '_': '/tools/buildbot/bin/python'} 15:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:09:35 INFO - Cleaning up... 15:09:35 INFO - Return code: 0 15:09:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:09: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')]} 15:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09: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')]} 15:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09: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', '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 0x15dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c3f0>, '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 0x194ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194d1a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', '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 15:09: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:09: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 blobuploader==1.2.4 15:09:35 INFO - Using env: {'DISPLAY': ':0', 15:09:35 INFO - 'HOME': '/home/cltbld', 15:09:35 INFO - 'LANG': 'en_US.UTF-8', 15:09:35 INFO - 'LANGUAGE': 'en_US:en', 15:09:35 INFO - 'LOGNAME': 'cltbld', 15:09:35 INFO - 'MAIL': '/var/mail/cltbld', 15:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:35 INFO - 'MOZ_NO_REMOTE': '1', 15:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:35 INFO - 'NO_EM_RESTART': '1', 15:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:35 INFO - 'PWD': '/builds/slave/test', 15:09:35 INFO - 'SHELL': '/bin/bash', 15:09:35 INFO - 'SHLVL': '1', 15:09:35 INFO - 'TERM': 'linux', 15:09:35 INFO - 'TMOUT': '86400', 15:09:35 INFO - 'USER': 'cltbld', 15:09:35 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', 15:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:35 INFO - '_': '/tools/buildbot/bin/python'} 15:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:35 INFO - Downloading/unpacking blobuploader==1.2.4 15:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:09:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:09:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:09:37 INFO - Downloading blobuploader-1.2.4.tar.gz 15:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:09:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:09:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:09:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:09:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:09:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:09:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:09:38 INFO - Downloading docopt-0.6.1.tar.gz 15:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:09:38 INFO - Installing collected packages: blobuploader, requests, docopt 15:09:38 INFO - Running setup.py install for blobuploader 15:09:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:09:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:09:38 INFO - Running setup.py install for requests 15:09:39 INFO - Running setup.py install for docopt 15:09:39 INFO - Successfully installed blobuploader requests docopt 15:09:39 INFO - Cleaning up... 15:09:39 INFO - Return code: 0 15:09:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:09:39 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')]} 15:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:39 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')]} 15:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:39 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 0x15dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c3f0>, '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 0x194ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194d1a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', '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 15:09:39 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 15:09:39 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 15:09:39 INFO - Using env: {'DISPLAY': ':0', 15:09:39 INFO - 'HOME': '/home/cltbld', 15:09:39 INFO - 'LANG': 'en_US.UTF-8', 15:09:39 INFO - 'LANGUAGE': 'en_US:en', 15:09:39 INFO - 'LOGNAME': 'cltbld', 15:09:39 INFO - 'MAIL': '/var/mail/cltbld', 15:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:39 INFO - 'MOZ_NO_REMOTE': '1', 15:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:39 INFO - 'NO_EM_RESTART': '1', 15:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:39 INFO - 'PWD': '/builds/slave/test', 15:09:39 INFO - 'SHELL': '/bin/bash', 15:09:39 INFO - 'SHLVL': '1', 15:09:39 INFO - 'TERM': 'linux', 15:09:39 INFO - 'TMOUT': '86400', 15:09:39 INFO - 'USER': 'cltbld', 15:09:39 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', 15:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:39 INFO - '_': '/tools/buildbot/bin/python'} 15:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:09:39 INFO - Running setup.py (path:/tmp/pip-Ee3Mio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:09:39 INFO - Running setup.py (path:/tmp/pip-ZZaF6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:09:39 INFO - Running setup.py (path:/tmp/pip-2LEZp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:09:39 INFO - Running setup.py (path:/tmp/pip-TbY8Go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:09:39 INFO - Running setup.py (path:/tmp/pip-lkTBYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:09:40 INFO - Running setup.py (path:/tmp/pip-i_1OSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:09:40 INFO - Running setup.py (path:/tmp/pip-o5jbsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:09:40 INFO - Running setup.py (path:/tmp/pip-GMbREO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:09:40 INFO - Running setup.py (path:/tmp/pip-adcSER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:09:40 INFO - Running setup.py (path:/tmp/pip-A4hX89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:09:40 INFO - Running setup.py (path:/tmp/pip-DBO1ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:09:40 INFO - Running setup.py (path:/tmp/pip-g7aQ2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:09:40 INFO - Running setup.py (path:/tmp/pip-gWAcPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:09:40 INFO - Running setup.py (path:/tmp/pip-bfmizg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:09:40 INFO - Running setup.py (path:/tmp/pip-4KwVAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:09:40 INFO - Running setup.py (path:/tmp/pip-ps_ej0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:09:40 INFO - Running setup.py (path:/tmp/pip-mcaOuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:09:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:09:40 INFO - Running setup.py install for manifestparser 15:09:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:09:41 INFO - Running setup.py install for mozcrash 15:09:41 INFO - Running setup.py install for mozdebug 15:09:41 INFO - Running setup.py install for mozdevice 15:09:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:09:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:09:41 INFO - Running setup.py install for mozfile 15:09:41 INFO - Running setup.py install for mozhttpd 15:09:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:09:41 INFO - Running setup.py install for mozinfo 15:09:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:09:41 INFO - Running setup.py install for mozInstall 15:09:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:09:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:09:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:09:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:09:41 INFO - Running setup.py install for mozleak 15:09:41 INFO - Running setup.py install for mozlog 15:09:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:09:41 INFO - Running setup.py install for moznetwork 15:09:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:09:42 INFO - Running setup.py install for mozprocess 15:09:42 INFO - Running setup.py install for mozprofile 15:09:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:09:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:09:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:09:42 INFO - Running setup.py install for mozrunner 15:09:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:09:42 INFO - Running setup.py install for mozscreenshot 15:09:42 INFO - Running setup.py install for moztest 15:09:42 INFO - Running setup.py install for mozversion 15:09:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:09:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:09:42 INFO - Cleaning up... 15:09:42 INFO - Return code: 0 15:09:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:42 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 0x15dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c3f0>, '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 0x194ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194d1a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', '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 15:09:42 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 15:09:42 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 15:09:42 INFO - Using env: {'DISPLAY': ':0', 15:09:42 INFO - 'HOME': '/home/cltbld', 15:09:42 INFO - 'LANG': 'en_US.UTF-8', 15:09:42 INFO - 'LANGUAGE': 'en_US:en', 15:09:42 INFO - 'LOGNAME': 'cltbld', 15:09:42 INFO - 'MAIL': '/var/mail/cltbld', 15:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:42 INFO - 'MOZ_NO_REMOTE': '1', 15:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:42 INFO - 'NO_EM_RESTART': '1', 15:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:42 INFO - 'PWD': '/builds/slave/test', 15:09:42 INFO - 'SHELL': '/bin/bash', 15:09:42 INFO - 'SHLVL': '1', 15:09:42 INFO - 'TERM': 'linux', 15:09:42 INFO - 'TMOUT': '86400', 15:09:42 INFO - 'USER': 'cltbld', 15:09:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', 15:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:42 INFO - '_': '/tools/buildbot/bin/python'} 15:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:09:42 INFO - Running setup.py (path:/tmp/pip-lns_K5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:09:43 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)) 15:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:09:43 INFO - Running setup.py (path:/tmp/pip-VAENgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:09:43 INFO - Running setup.py (path:/tmp/pip-T6iGac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:09:43 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)) 15:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:09:43 INFO - Running setup.py (path:/tmp/pip-CGhPEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:09:43 INFO - Running setup.py (path:/tmp/pip-_mz9Wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:09:43 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)) 15:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:09:43 INFO - Running setup.py (path:/tmp/pip-pvFwAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:09:43 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)) 15:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:09:43 INFO - Running setup.py (path:/tmp/pip-LbwGjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:09:43 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)) 15:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:09:43 INFO - Running setup.py (path:/tmp/pip-4YwzC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:09:43 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)) 15:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:09:43 INFO - Running setup.py (path:/tmp/pip-KbXFIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:09:43 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)) 15:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:09:43 INFO - Running setup.py (path:/tmp/pip-GosW3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:09:43 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)) 15:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:09:43 INFO - Running setup.py (path:/tmp/pip-JqEhAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:09:43 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)) 15:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:09:43 INFO - Running setup.py (path:/tmp/pip-dynp70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:09:43 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)) 15:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:09:43 INFO - Running setup.py (path:/tmp/pip-80KbTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:09:43 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)) 15:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:09:43 INFO - Running setup.py (path:/tmp/pip-CyFHB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:09:44 INFO - Running setup.py (path:/tmp/pip-5Pd5hB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:09:44 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)) 15:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:09:44 INFO - Running setup.py (path:/tmp/pip-3O8d0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:09:44 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)) 15:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:09:44 INFO - Running setup.py (path:/tmp/pip-V23MzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:09:44 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)) 15:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:09:44 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)) 15:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:09:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:09: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 15:09: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 15:09: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 15:09: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 15:09: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 15:09: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 15:09:46 INFO - Downloading blessings-1.6.tar.gz 15:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:09:46 INFO - Installing collected packages: blessings 15:09:46 INFO - Running setup.py install for blessings 15:09:46 INFO - Successfully installed blessings 15:09:46 INFO - Cleaning up... 15:09:46 INFO - Return code: 0 15:09:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:09:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:09:46 INFO - Reading from file tmpfile_stdout 15:09:46 INFO - Current package versions: 15:09:46 INFO - argparse == 1.2.1 15:09:46 INFO - blessings == 1.6 15:09:46 INFO - blobuploader == 1.2.4 15:09:46 INFO - docopt == 0.6.1 15:09:46 INFO - functools32 == 3.2.3-2 15:09:46 INFO - jsonschema == 2.5.1 15:09:46 INFO - manifestparser == 1.1 15:09:46 INFO - mozInstall == 1.12 15:09:46 INFO - mozcrash == 1.0 15:09:46 INFO - mozdebug == 0.1 15:09:46 INFO - mozdevice == 0.49 15:09:46 INFO - mozfile == 1.2 15:09:46 INFO - mozhttpd == 0.7 15:09:46 INFO - mozinfo == 0.9 15:09:46 INFO - mozleak == 0.1 15:09:46 INFO - mozlog == 3.4 15:09:46 INFO - moznetwork == 0.27 15:09:46 INFO - mozprocess == 0.23 15:09:46 INFO - mozprofile == 0.28 15:09:46 INFO - mozrunner == 6.13 15:09:46 INFO - mozscreenshot == 0.1 15:09:46 INFO - mozsystemmonitor == 0.3 15:09:46 INFO - moztest == 0.7 15:09:46 INFO - mozversion == 1.4 15:09:46 INFO - psutil == 3.1.1 15:09:46 INFO - requests == 1.2.3 15:09:46 INFO - wsgiref == 0.1.2 15:09:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:46 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 0x15dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c3f0>, '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 0x194ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194d1a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', '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 15:09:46 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 15:09:46 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 15:09:46 INFO - Using env: {'DISPLAY': ':0', 15:09:46 INFO - 'HOME': '/home/cltbld', 15:09:46 INFO - 'LANG': 'en_US.UTF-8', 15:09:46 INFO - 'LANGUAGE': 'en_US:en', 15:09:46 INFO - 'LOGNAME': 'cltbld', 15:09:46 INFO - 'MAIL': '/var/mail/cltbld', 15:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:46 INFO - 'MOZ_NO_REMOTE': '1', 15:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:46 INFO - 'NO_EM_RESTART': '1', 15:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:46 INFO - 'PWD': '/builds/slave/test', 15:09:46 INFO - 'SHELL': '/bin/bash', 15:09:46 INFO - 'SHLVL': '1', 15:09:46 INFO - 'TERM': 'linux', 15:09:46 INFO - 'TMOUT': '86400', 15:09:46 INFO - 'USER': 'cltbld', 15:09:46 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', 15:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:46 INFO - '_': '/tools/buildbot/bin/python'} 15:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:46 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)) 15:09:46 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)) 15:09:46 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)) 15:09:46 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)) 15:09:46 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)) 15:09:46 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)) 15:09:46 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)) 15:09:46 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)) 15:09:46 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)) 15:09:46 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)) 15:09:46 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)) 15:09:46 INFO - Cleaning up... 15:09:46 INFO - Return code: 0 15:09:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:09:46 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 0x15dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ec70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194c3f0>, '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 0x194ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194d1a0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', '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 15:09:46 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 15:09:46 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 15:09:46 INFO - Using env: {'DISPLAY': ':0', 15:09:46 INFO - 'HOME': '/home/cltbld', 15:09:46 INFO - 'LANG': 'en_US.UTF-8', 15:09:46 INFO - 'LANGUAGE': 'en_US:en', 15:09:46 INFO - 'LOGNAME': 'cltbld', 15:09:46 INFO - 'MAIL': '/var/mail/cltbld', 15:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:46 INFO - 'MOZ_NO_REMOTE': '1', 15:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:09:46 INFO - 'NO_EM_RESTART': '1', 15:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:46 INFO - 'PWD': '/builds/slave/test', 15:09:46 INFO - 'SHELL': '/bin/bash', 15:09:46 INFO - 'SHLVL': '1', 15:09:46 INFO - 'TERM': 'linux', 15:09:46 INFO - 'TMOUT': '86400', 15:09:46 INFO - 'USER': 'cltbld', 15:09:46 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', 15:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:46 INFO - '_': '/tools/buildbot/bin/python'} 15:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:09:47 INFO - Cleaning up... 15:09:47 INFO - Return code: 0 15:09:47 INFO - Running post-action listener: _resource_record_post_action 15:09:47 INFO - Running post-action listener: _start_resource_monitoring 15:09:47 INFO - Starting resource monitoring. 15:09:47 INFO - [mozharness: 2016-12-20 23:09:47.201790Z] Finished create-virtualenv step (success) 15:09:47 INFO - [mozharness: 2016-12-20 23:09:47.202275Z] Running install step. 15:09:47 INFO - Running pre-action listener: _resource_record_pre_action 15:09:47 INFO - Running main action method: install 15:09:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:09:47 INFO - Reading from file tmpfile_stdout 15:09:47 INFO - Detecting whether we're running mozinstall >=1.0... 15:09:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:09:47 INFO - Reading from file tmpfile_stdout 15:09:47 INFO - Output received: 15:09:47 INFO - Usage: mozinstall [options] installer 15:09:47 INFO - Options: 15:09:47 INFO - -h, --help show this help message and exit 15:09:47 INFO - -d DEST, --destination=DEST 15:09:47 INFO - Directory to install application into. [default: 15:09:47 INFO - "/builds/slave/test"] 15:09:47 INFO - --app=APP Application being installed. [default: firefox] 15:09:47 INFO - mkdir: /builds/slave/test/build/application 15:09:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:10:05 INFO - Reading from file tmpfile_stdout 15:10:05 INFO - Output received: 15:10:05 INFO - /builds/slave/test/build/application/firefox/firefox 15:10:05 INFO - Running post-action listener: _resource_record_post_action 15:10:05 INFO - [mozharness: 2016-12-20 23:10:05.019307Z] Finished install step (success) 15:10:05 INFO - [mozharness: 2016-12-20 23:10:05.019553Z] Running run-tests step. 15:10:05 INFO - Running pre-action listener: _resource_record_pre_action 15:10:05 INFO - Running main action method: run_tests 15:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:10:05 INFO - Python 2.7.3 15:10:05 INFO - Return code: 0 15:10:05 INFO - grabbing minidump binary from tooltool 15:10:05 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')]} 15:10:05 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 0x194c3f0>, '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 0x194ccf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194d1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:10:05 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 15:10:05 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 15:10:05 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 15:10:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:10:05 INFO - Return code: 0 15:10:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:10:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:10:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:10:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:10:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 15:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 15:10:05 INFO - Using env: {'DISPLAY': ':0', 15:10:05 INFO - 'HOME': '/home/cltbld', 15:10:05 INFO - 'LANG': 'en_US.UTF-8', 15:10:05 INFO - 'LANGUAGE': 'en_US:en', 15:10:05 INFO - 'LOGNAME': 'cltbld', 15:10:05 INFO - 'MAIL': '/var/mail/cltbld', 15:10:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:10:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:05 INFO - 'MOZ_NO_REMOTE': '1', 15:10:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:05 INFO - 'NO_EM_RESTART': '1', 15:10:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:05 INFO - 'PWD': '/builds/slave/test', 15:10:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:10:05 INFO - 'SHELL': '/bin/bash', 15:10:05 INFO - 'SHLVL': '1', 15:10:05 INFO - 'TERM': 'linux', 15:10:05 INFO - 'TMOUT': '86400', 15:10:05 INFO - 'USER': 'cltbld', 15:10:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410', 15:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:05 INFO - '_': '/tools/buildbot/bin/python'} 15:10:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 15:10:05 INFO - mozversion application_buildid: 20161220133017 15:10:05 INFO - mozversion application_changeset: 7083c0d30e75fc102c715887af9faec933e936f8 15:10:05 INFO - mozversion application_display_name: Nightly 15:10:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:10:05 INFO - mozversion application_name: Firefox 15:10:05 INFO - mozversion application_remotingname: firefox 15:10:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:10:05 INFO - mozversion application_vendor: Mozilla 15:10:05 INFO - mozversion application_version: 53.0a1 15:10:05 INFO - mozversion platform_buildid: 20161220133017 15:10:05 INFO - mozversion platform_changeset: 7083c0d30e75fc102c715887af9faec933e936f8 15:10:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:10:05 INFO - mozversion platform_version: 53.0a1 15:10:05 INFO - using testdate: 1482275405 15:10:05 INFO - actual date: 1482275405 15:10:05 INFO - starting webserver on 'localhost:50383' 15:10:05 INFO - SUITE-START | Running 2 tests 15:10:05 INFO - TEST-START | dromaeo_css 15:10:05 INFO - operating with platform_type : linux_ 15:10:05 INFO - Initialising browser for dromaeo_css test... 15:10:05 INFO - TEST-INFO | started process 32420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnnfOX9/profile http://localhost:50383/getInfo.html) 15:10:08 INFO - PROCESS | 32420 | __metrics Screen width/height:1600/1200 15:10:08 INFO - PROCESS | 32420 | colorDepth:24 15:10:08 INFO - PROCESS | 32420 | Browser inner width/height: 1024/697 15:10:08 INFO - PROCESS | 32420 | __metrics 15:10:09 INFO - PROCESS | 32420 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:10:09 INFO - PROCESS | 32420 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:10:10 INFO - PROCESS | 32420 | console.error: PushService: 15:10:10 INFO - PROCESS | 32420 | stateChangeProcessEnqueue: Error transitioning state 15:10:10 INFO - PROCESS | 32420 | UnknownError 15:10:10 INFO - TEST-INFO | 32420: exit 0 15:10:10 INFO - Browser initialized. 15:10:10 INFO - Running cycle 1/1 for dromaeo_css test... 15:10:10 INFO - TEST-INFO | started process 32505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnnfOX9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:10:22 INFO - PROCESS | 32505 | RSS: Main: 152883200 15:10:22 INFO - PROCESS | 32505 | 15:11:13 INFO - PROCESS | 32505 | 1482275473832 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] 15:13:23 INFO - PROCESS | 32505 | Cycle 1(1): loaded http://localhost:50383/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50383/tests/dromaeo/cssquery-ext.html) 15:13:25 INFO - PROCESS | 32505 | RSS: Main: 283680768 15:13:25 INFO - PROCESS | 32505 | 15:16:27 INFO - PROCESS | 32505 | Cycle 1(1): loaded http://localhost:50383/tests/dromaeo/cssquery-ext.html (next: http://localhost:50383/tests/dromaeo/cssquery-jquery.html) 15:16:28 INFO - PROCESS | 32505 | RSS: Main: 252399616 15:16:28 INFO - PROCESS | 32505 | 15:19:30 INFO - PROCESS | 32505 | Cycle 1(1): loaded http://localhost:50383/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50383/tests/dromaeo/cssquery-mootools.html) 15:19:31 INFO - PROCESS | 32505 | RSS: Main: 190013440 15:19:31 INFO - PROCESS | 32505 | 15:22:33 INFO - PROCESS | 32505 | Cycle 1(1): loaded http://localhost:50383/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50383/tests/dromaeo/cssquery-prototype.html) 15:22:33 INFO - PROCESS | 32505 | RSS: Main: 187432960 15:22:33 INFO - PROCESS | 32505 | 15:25:36 INFO - PROCESS | 32505 | Cycle 1(1): loaded http://localhost:50383/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50383/tests/dromaeo/cssquery-yui.html) 15:25:37 INFO - PROCESS | 32505 | RSS: Main: 190078976 15:25:37 INFO - PROCESS | 32505 | 15:28:39 INFO - PROCESS | 32505 | Cycle 1(1): loaded http://localhost:50383/tests/dromaeo/cssquery-yui.html (next: http://localhost:50383/tests/dromaeo/cssquery-dojo.html) 15:28:40 INFO - PROCESS | 32505 | RSS: Main: 287694848 15:28:40 INFO - PROCESS | 32505 | 15:28:40 INFO - PROCESS | 32505 | __start_tp_report 15:28:40 INFO - PROCESS | 32505 | _x_x_mozilla_page_load 15:28:40 INFO - PROCESS | 32505 | _x_x_mozilla_page_load_details 15:28:40 INFO - PROCESS | 32505 | |i|pagename|runs| 15:28:40 INFO - PROCESS | 32505 | |0;dojo.html;2949.7640188784894;2962.3779006408654;2992.9551056734144;3002.6396832380105;3009.9999999999986;5128.769205385757;5187.247849061884;5191.636585439021;5260.053190425727;5340.279062326589;5193.065248255322;5224.164133738603;5225.242339860718;5332.57339412847;5364.624476286662;4730.432348118214;4753.191957367256;4782.83260085897;4827.589654879331;4842.97578512107;4757.738324392157;4807.110684523374;4831.7584120794;4855.660103792736;4864.246041863499;4775;4785.784639691222;4841.2496063110275;4841.854744357657;4867.732274724889;4608.262677971542;4629.745364004978;4633.4439867215815;4715.764211789431;4771.737554434505;4711.151992641323;4734.928976065362;4743.928841067387;4777.211760059586;4803.831865884677;5174.275601415805;5249.947500524984;5250.238715386286;5250.8687282817855;5260.473952604747;5383.246345511592;5454.154606036071;5501.807436739695;5661.745221465044;5681.517071048966;5453.345598528163;5478.342598888119;5488.17677348401;5526.281583394173;5532.75102620383;5134.255532947702;5141.048905952373;5144.279800827887;5146.099432599318;5183.248428977777;5526.834194974157;5530.059889818741;5590.636608620427;5595.552355811526;5599.692016939026;5423.267858839085;5452.700101494456;5512.145617429305;5534.557235421237;5588.6646801192055;5571.637843540157;5607.074832652566;5611.438856114356;5615.775368985276;5626.324841019104;5420.864478388072;5544.667319960735;5596.720163991866;5604.243427137284;5609.523190528851;5456.945430545723;5474;5480.862978425492;5486.8203336282895;5549.72251387429;4204.4324016257415;4206.137741762931;4207.915841683149;4208.873733787991;4242.957570424256;3793.260314238697;3802.448644946467;3813.1801662642665;3837.6737977272246;3853.4797802296894;5185.170372740344;5186.351706036746;5204.219367094966;5250.3962044364625;5262.500062494057;5603.3836278009385;5618.606697531215;5622.212890195376;5647.435256474319;5663.886722265532;5307.044731948286;5313.707746074003;5314.468553144655;5317.73411329432;5362.785488580413;4619.653525985565;4644.535546445329;4718.905621887612;4723.126221649006;4759.952400476021;5840.737166827503;5847.1229315603;5851.444112809361;5900.970495147582;5913;5593.608447408642;5634.6337488063145;5646.040173170653;5651.4348565143155;5660.122680984454;5599.1041433370465;5642.435756424325;5835.095560188008;5835.2122463466885;5835.299764028344;5435.510804027656;5444.754986025559;5467;5493.945060549343;5538.556915446835;5557.610967232416;5560.527355174855;5560.944390556205;5567.8886422272135;5568.860778480571;5345.572354211576;5386.353637563518;5447;5451;5505.03661859165;5433.157860531624;5493.368262649847;5496.835094947158;5540.445955404427;5584.246126772834;5456.345238571397;5462.644928079662;5462.9180562292395;5465.836024919259;5495.450454954633;5366.221897824872;5380.354357477127;5504.834854954358;5525.281713377235;5592.384837667934;5424.050791111618;5449.7002664852225;5454.2091396746455;5505;5516.3380394351325 15:28:40 INFO - PROCESS | 32505 | |1;ext.html;546.7621584610695;567.911973644085;568.2697733412563;580.077676494374;584.3688816078635;31722.682773172262;32444;33884.32231355371;41286.58713412865;42454.575454245445;43877.341839872424;44390.77804610981;44410.555894441044;44460;44474;8573.314134869195;8642;8658.826823463527;8738.475691458532;8741.213290803826;7932.762017139495;8108.472949258309;8599.527026013568;10183.236257280696;10403.219758518104;10337.483125843715;10408.583656653725;10420.791584168312;10426.530806113744;10428.791424171512;10340.431276279802;10385.376877387305;10393.740156496073;10398.324108932895;10400.219983501192;10290;10307.12389446898;10322.277440579162;10335.844962325571;10344.534495947626;41267.380989285186;41585.37621935673;41655.375169372484;41656.79171604153;41662.79168604168;3221.4040402525607;3267.4445344291526;3303.8348082595776;3380.256343604403;3616.9276614467826;30848.062525545534;31214.843925780453;31395.215119621964;31481.685183148333;32171;4147.854825081107;4216.51510076342;4257.106007738379;4279.165562715271;4406.272964960777;326519;327244;328013;328074;329439;56312;56571.15143272854;56640;56683.716581417655;56719;59001.40998590045;59145.704271479226;59254.70372648195;59270.92551760754;59282.40717592855;16340.101294428921;16570.337186512646;16578.58553536147;16579.91710041442;16582.50252492403;11819.527218911318;12307.69230769238;12338.259704417764;12339.93830030844;12348.506059757688;14339.569812905422;15871.603209919613;15945.36218551245;15974.68050639004;16887.577810554587;6179.84550386244;6432.549721519449;6505.51208659343;6530.412262896362;6597;858.8411143938391;981.8330883749637;1009.4599389326675;1053.8893416191343;1075.1774892207468;31318.217044573612;31591.52612710811;31818.68181318157;31946.840265798986;32273.35453290968;1025.8820235672993;1081.7025318037602;1102.5479553383075;1120.3389999900098;1195;15698.372065117495;16499.752503712454;16648.583785405463;16679.6664066718;16699.332026718796;440586;440961;441628;443280;443463;49958.25062624064;51084.23373649398;54087.72956135273;55188.17217741737;55209;1227.3127048852493;1296.1510210811932;1298.3313593499356;1304.3999760110266;1318.2551858200086;29221;30163.69836301609;31522.054338369886;31697.20756981094;32251.354972899942;48136;48556.81494332834;48588.27117593168;48858;48860;393619;395962;396310;396361;396891;24949.50100998006;25354.239372818844;25566;25785.355366115997;25787.871060645328;38771.41842872303;41180.38229426501;42248;42578;42868;34111.65888341184;34755.478667819494;35004;35704.464433033005;36207.456888146175;34135.658643414245;34490.65509344975;34587.30825383428;34677.47983780195;34768.30463390667;35092.82453587716;35430.645693542734;35531;35670;35826.283474329844;29691.85154074216;31996.360072797946;32192.83903580467;32491;32632.83683581567;24860.751392485843;25480.872595637644;25556;25577.872110639328;25758.613620796077 15:28:40 INFO - PROCESS | 32505 | |2;jquery.html;365.2858661317125;380.4483498926557;391.25661243637086;392.6407337286382;414.98132584033715;13640.408322418734;13990.160590364572;15819.999999999985;18802.247910083614;18971.52571185721;17836;17947.461576152735;18110.4566862994;18126.46533925885;18427.262909483637;5267.55225805806;5690.772369105231;5697;5704.201411802351;5706.828795136153;5450.618456708032;5542.806001789938;5552.805651802168;5558.527525160366;5596.776128954837;5594.58040646951;5594.888102237953;5595.328560572737;5599.7480113394795;5603.719814009303;5429.158480435539;5464.3442786865635;5508.008558459495;5511.58663100265;5535.474129957647;4919.311296418504;4941.283513890466;4944.653874228806;4951.331570238008;4952.727599981999;21289.467763305885;21621;21830.45423864416;22055;22159;1978.2284908885547;2073.7718850926385;2166.6749987501844;2193.7586865444787;2211.5355775287208;9647.469389183592;9671.323007389485;10029.548670309854;10078.748031299203;10440.216983726252;1876.408931186672;1940.8350290225349;1952.5899561092187;1952.6582848001542;1995.1520603743495;77490.92234925114;78304.60847695782;78455.21544784593;80712.19287807164;83288.58355708243;10425.687229383131;10657.413842238751;10749.946250268698;10864.511097000654;10974.890251097388;14974;14982.925085374503;14985.328594494418;15004.549863504113;15055.54833355001;7753;7944.443888927835;8072.8385432291025;8252.958735206286;8368.916310836936;7821.256980586835;7932.524048557105;7938.841223175504;8092.595370231465;8145.226203510657;4556.8177272908715;4600.102979918951;4660.184467718136;4678.8596342109795;4737.099951009366;1910.703840904662;1923.2403200735912;1925.7290188475538;1934.965596730832;1958.9118489667999;808.9999999999882;844.8479273730787;864.1703964194318;865.2731705367521;874.2437791310471;17920.28318867257;18675.43973680792;18793.53016174579;18834.905825471058;19072.14175362112;916.3997581584073;924.5007695844168;1011.206203130539;1031.5306535526317;1042.3329069395593;9871.30900836949;10374.740631484123;10477.633282835064;10502.632407865842;10526.947365263124;448298;450480;456747;459473;470008.1495517711;84541.57729211438;86584;88117;89028;89080.5545972266;970.2819913264275;975.0298453039271;976.9218462522981;982.921366290695;997.2498265544069;15743.13412762309;16125.193740313172;16346.918265408596;16502.17489125563;16676;38716.6128338713;39832.60167398405;40888.38667419932;40924.590754092074;41214.79392603018;52296.95406091933;52518.73740631272;55047.72476137754;58111;59131.40868591431;8018.438709290293;8307.293880020266;8373.497590144367;8508.149185081442;8541.658333666584;10615.946920265349;12138.75722485563;12484.625461236177;12487.31319777421;12718.427670755023;9580.18568421692;10305.99033188521;10519.789604208027;10560;10626.415547144981;10182.18542516582;10252.179825613784;10487.737806554896;10582.365058096539;10674.199435042248;10576.524056417633;10657.14742820588;11121.499532521218;11180.608678696206;11310.434478276218;7943.24539168778;8082.515049097073;8162.347012239125;8354.997400312002;8406.201410865959;9946.602135914482;10816.026557609854;10946.726331841768;11132.777344453227;11139.220254582102 15:28:40 INFO - PROCESS | 32505 | |3;mootools.html;1314.7830607949688;1361.5847166614183;1392.5265409760682;1479.7791821747062;1720.9397671081506;7291.635418229087;8045.87931181032;8329.875051874227;8338.791530211754;8596.968363796337;8343.165683431655;8412;8415.789605259872;8434.24091831735;8434.283085937703;1903.6097599992038;1966.7443232379771;2155.299527653511;2185.825133989285;2190.5290362572046;2167.967480487794;2228.9777102229014;2235.564065007324;2243.270936945491;2244.427670943907;2167.1223154622403;2167.5881582499355;2181.19295860531;2182.519845633958;2210.370044537307;2196.417949243452;2218.0351547077075;2221.0893533651124;2226.2875879718576;2227.3652009177467;2172.7935846094597;2206.062423470019;2208.7791220877943;2209.6464565669417;2210.80102790748;8314.127016663224;8363.832723345498;8501.61742721579;8507.276881465083;8509.234168924764;5032.3961124665275;5161.174212126042;5168.483151684839;5174.249733788617;5179;3134.5925029746213;3379.290349026707;3386.5597472328686;3397.5243465914546;3414.453687410027;1044.759705267785;1049.8477720730452;1058.8570542976754;1064.1061508333037;1139.0716565998766;10934.398608076554;11155.609553665663;11300.660980170607;11611.477483513178;11724.120690948213;4213.831446742157;4322.913541729148;4405.03089320349;4424.535423780521;4433.401490798766;9168.220701240336;9198;9199.678011269574;9202.263818894473;9214.308926830514;5077.339945807022;5093.083245015859;5094;5099.133147364957;5102.311187989648;3936.9212615748097;4230.302000169938;4753.500882407367;4763.595094417014;4816.879578010507;3589.4436362363876;3625.0574850538524;3631.854725810938;3701.6113308102263;3713.9071523212137;1113.1873732175557;1116.201915630312;1123.971900702489;1125.21797350842;1128.2666266926562;769.6690423118001;857.6998050682336;887.7349776568365;904.412132114131;907.773056735816;5461.781528738886;5510.504054635022;5556.888862222733;5574.554035677136;5960.463558279689;406.5873138764157;408.2304855347691;408.8895998080561;413.8965258685329;420.9305464598368;3740.308043011997;3822.541295044557;3839.520059992501;3861.2084522673345;3968.40473928913;9918.107370336704;10427.791444171075;10433.843492347622;10435.634752783617;10447.84328235077;10085.739282589677;10120.089191972758;10171.796564068678;10291.53688084038;10316.1747060235;7645.579493127821;7708.113566939874;7825.491343062683;7849.803754906173;7850.842983140419;5377.166539186433;5396.406395296436;5434.483724046209;5484.095124304445;5575.832725018256;9422.246220302497;9437.905620943977;9468.337216394786;9478.57346419399;9564.330496865152;9524.619015239312;9537.427754334762;9718.125368716566;9834.213262938805;9838.803223935338;6475.481961443167;6672.5329226953645;6829.31706829333;7152.6781294842895;7239.674214660458;7840.411969102226;8181.877271840808;8186.386021048326;8191.385646076449;8198.754037378889;7148.28517148281;7224.2300636344435;7401;7473.991011213634;7482.812929676802;7001.36987671112;7077.752278670222;7214.531055481377;7245.38414234796;7257.346838784535;6597.868042639025;6735.090762746966;6740.090087838275;6751.324867513209;6752.426043786333;4803.327534145293;4843.564079232886;4900.068986892479;4934.703917764946;5011.699298042129;4546.136234115507;4628.583427491542;4644.396228490275;4695.600873925755;4778.952210477851 15:28:40 INFO - PROCESS | 32505 | |4;prototype.html;371.4446901881686;373.7495877761899;375.12969909809243;376.26064782701985;379.5672932856544;5001.349824522807;5115.258287548303;5136.357955255593;5147.176451767713;5193.662411943225;5039.521245481674;5101.948980510194;5155.2009438537;5162.664426812264;5165.199394093912;3924.1955399143108;3993.181397813456;4008.518977722663;4122.8144733486915;4132.524759652649;4085.5710150434224;4089.2230476209575;4102.507699076115;4104.1381309924955;4107.8973025674295;4041.454403655513;4068.41008053832;4078.4509681449094;4099.442211959451;4104.774237416941;4007.5591684914634;4078.4086307485395;4084.121913788535;4092.6930480214105;4112.218678451115;3660.3960346543054;3677.9080522987138;3683.686886614641;3684.355237833395;3688.2992231475932;5033.320501732256;5043.697378157322;5048.16705243638;5062.4684408137355;5075.289459475676;4675.275332323496;4678.274867395525;4698.342232087511;4712.69367491112;4715.386999690053;5278.366596008465;5345.893082138336;5361.597880159004;5365.517103460668;5378.1663842104535;4020.7386519876113;4051.7163798534116;4053.635172834459;4063.085805693725;4068.247374235746;5660.2075709400715;5679.914801277984;5692.743826527816;5713.485786279255;5713.971430142864;4010.6991975601945;4127.442795222607;4128.256913755553;4130.938035929464;4133.81397837098;4191.790410479463;4200.201961627281;4203.222403855297;4216.789160541961;4217.599328063829;4681.9297710534365;4692.436907571113;4710.481846996828;4727.267273572602;4729.905401891943;5216.895662086737;5341.866453338697;5358.356997160366;5408.702521361284;5424.593155513352;1405.508072174751;1412.3079690951565;1413.6993965551717;1417.4471955937192;1429.6704065219237;966.6471737815788;1006.1799633298838;1008.1884083313004;1017.31839667423;1026.0863489591857;4901.730404827768;4981.62637802159;4991.925121123186;5007.474215207423;5032.370953630723;5250.4749525047955;5320.441353657888;5344.759485823147;5359.3653935549255;5371.274877891513;4871.441138835538;5003.699778013331;5018.247262910592;5086.440491545927;5100;2823.632927719383;2832.957505637417;2844.0756754055014;2848.1170837040586;2850.474995877196;5482.698451585121;5503.477169668875;5507.256520369699;5519.9640197891;5529.170624406291;5365.892682146413;5464.9453505464435;5672.4894759471845;5676;5680.261565996477;5697;5704;5736.827895163152;5751.626144300607;5769.249997500214;5505.697186654773;5580.2745643067765;5619.915701264403;5631.915521267102;5658.660480371026;5554.444555544414;5592.105263157875;5594.552435805207;5596.664200148004;5597.328320601554;5708.115242137475;5736.168255602997;5781.392953739797;5782.595218334676;5794.246747922743;3835.2521258354354;3945.34901741221;3987.980060099797;3988.1824226034173;4019.376996565537;5360.597955153301;5471.398146203994;5545.085060964896;5589.972050139723;5604.187392827936;5338.46615338463;5439.238506609157;5445.891082178414;5462.8361149165585;5471.206675032018;5391.838244852661;5393.759435329817;5421.701806400686;5433.185022246695;5444.863878403072;5166;5339.357018275979;5384.946150538444;5394.919076213781;5401.2168235606405;5430.212619170119;5509;5527.82150263592;5534.723263836872;5544.1960915666195;5300.2049692546425;5386.946130538801;5393.352797664148;5400.675959442446;5412.891742165213 15:28:40 INFO - PROCESS | 32505 | |5;yui.html;622.3465361370561;644.5455953552743;659.808655489908;742.6843591473626;764.1365257259296;14545.345459454324;15133.6973260535;15235.61910952224;15274.694506109885;15290.847091529095;14873.479428219987;14908;15001.6999660007;15025.098494090334;15063.39746410145;784.5214419204281;804.9114597394282;805.8186907945724;809.5911564659839;820.8891799607036;676.5129107042922;690.2097098821846;783.5925318834203;784.1335324466468;804.5977011494252;838.1785849867134;838.4591938199858;838.9454685445457;839.0099682374795;840.0717207485732;836.7322456813822;837.417994493827;837.4723923927917;837.7026155714756;838.5974732128582;515.2245869965677;527.9340082489689;592.052715654953;605.9969700151515;613.0038687133408;15070.849291507055;15094.16982065986;15132.394704211818;15146.621334466616;15173.468928587557;13965.371558279901;13989.860101398957;14008;14115.929420352833;14181.361838717283;12968.870311296861;13032.152910060911;13190;13358.198508089547;14105.083169593943;4319.589638984323;4326.58897404746;4346.956530434687;4350.081813465305;4440.4671439427475;82072;82127.17872821254;83074.99999999939;85712.57143714304;86107.56946215291;10429.478526073666;11123.388213648326;11130.610428634958;11156.16328775345;11338;20825.271115510885;20903.477413064797;20914.268000619904;20921.686174707393;21079.68380474294;7184.9640751795905;7751.457397982087;7805.37556995439;7855.214478552099;8058.919410805935;4099.405586190045;4144.70987030905;4222.725522841006;4245.9736456807805;4345.261305578059;3437.329720704439;3474.6004209515722;3507.245942122405;3511.4030614795547;3514.7539672222697;564.1988376505373;569.9373068962411;574.5891687443415;583.5419195931173;584.1967294969417;608.8234412020464;636.4081404294051;637.1907677249867;660.867826434715;662.6752891083335;8356.456830306011;8536.274416674652;8642.827143457096;8846.709345967201;8913.331500137516;590.503976659608;604.9304330002107;624.7188765055743;673.7035704290195;684.8295369956807;4045.554988951213;4058.3912413138264;4100.610442008005;4108.630223279919;4168.8332466701595;80283.46849656894;81203.18796812075;81601;82483.5875820629;84150.57924710338;70065;70223.64888175526;71850.64074679594;72931.63534182402;72973.635131824;63456.68271658704;65829.34170658328;67264.99999999903;68311.65844170748;68501.65749171222;8212.289671657225;8608.311335093053;8671.4363566368;8709;9019.729408117766;45118.32322515231;45913;46417.53582464132;47322.29016564685;47368.28947565858;57840.710796447434;61423.385766141764;62690.686546566976;62890;63859.36140638534;10291.382517049002;10516.369017858953;10597.15222782191;10825.891741082489;11033.668989930315;11425.14311426663;11586.884131158919;11671.174902931572;11683.357415341898;11871.703207419883;11642.24325418845;11660.53357865676;11713.824292635787;11728.70678233051;12471.688207794878;10710.892891071302;11097.833532496858;11200.215984881306;11431.657050288504;12125.878741212828;11416.82874756896;11580.826287605862;11678.416079195837;11683.649490515298;11932.522699091938;8879.629583480975;8947.239484643878;9638.42169469834;9645.614175433186;9794.265430092913;9368;9794.853077203705;9859.457729824928;9907.356021858555;10078.697639070839 15:28:40 INFO - PROCESS | 32505 | __end_tp_report 15:28:40 INFO - PROCESS | 32505 | __start_cc_report 15:28:40 INFO - PROCESS | 32505 | _x_x_mozilla_cycle_collect,1330 15:28:40 INFO - PROCESS | 32505 | __end_cc_report 15:28:40 INFO - PROCESS | 32505 | __startTimestamp1482276520207__endTimestamp 15:28:40 INFO - PROCESS | 32505 | 15:28:40 INFO - PROCESS | 32505 | ------- Summary: start ------- 15:28:40 INFO - PROCESS | 32505 | Number of tests: 6 15:28:40 INFO - PROCESS | 32505 | 15:28:40 INFO - PROCESS | 32505 | [#0] dojo.html Cycles:165 Average:5182.37 Median:5424.05 stddev:594.19 (11.0%) stddev-sans-first:569.62 15:28:40 INFO - PROCESS | 32505 | Values: 2949.8 2962.4 2993.0 3002.6 3010.0 5128.8 5187.2 5191.6 5260.1 5340.3 5193.1 5224.2 5225.2 5332.6 5364.6 4730.4 4753.2 4782.8 4827.6 4843.0 4757.7 4807.1 4831.8 4855.7 4864.2 4775.0 4785.8 4841.2 4841.9 4867.7 4608.3 4629.7 4633.4 4715.8 4771.7 4711.2 4734.9 4743.9 4777.2 4803.8 5174.3 5249.9 5250.2 5250.9 5260.5 5383.2 5454.2 5501.8 5661.7 5681.5 5453.3 5478.3 5488.2 5526.3 5532.8 5134.3 5141.0 5144.3 5146.1 5183.2 5526.8 5530.1 5590.6 5595.6 5599.7 5423.3 5452.7 5512.1 5534.6 5588.7 5571.6 5607.1 5611.4 5615.8 5626.3 5420.9 5544.7 5596.7 5604.2 5609.5 5456.9 5474.0 5480.9 5486.8 5549.7 4204.4 4206.1 4207.9 4208.9 4243.0 3793.3 3802.4 3813.2 3837.7 3853.5 5185.2 5186.4 5204.2 5250.4 5262.5 5603.4 5618.6 5622.2 5647.4 5663.9 5307.0 5313.7 5314.5 5317.7 5362.8 4619.7 4644.5 4718.9 4723.1 4760.0 5840.7 5847.1 5851.4 5901.0 5913.0 5593.6 5634.6 5646.0 5651.4 5660.1 5599.1 5642.4 5835.1 5835.2 5835.3 5435.5 5444.8 5467.0 5493.9 5538.6 5557.6 5560.5 5560.9 5567.9 5568.9 5345.6 5386.4 5447.0 5451.0 5505.0 5433.2 5493.4 5496.8 5540.4 5584.2 5456.3 5462.6 5462.9 5465.8 5495.5 5366.2 5380.4 5504.8 5525.3 5592.4 5424.1 5449.7 5454.2 5505.0 5516.3 15:28:40 INFO - PROCESS | 32505 | 15:28:40 INFO - PROCESS | 32505 | [#1] ext.html Cycles:180 Average:54358.53 Median:18632.29 stddev:103333.06 (554.6%) stddev-sans-first:103543.95 15:28:40 INFO - PROCESS | 32505 | Values: 546.8 567.9 568.3 580.1 584.4 31722.7 32444.0 33884.3 41286.6 42454.6 43877.3 44390.8 44410.6 44460.0 44474.0 8573.3 8642.0 8658.8 8738.5 8741.2 7932.8 8108.5 8599.5 10183.2 10403.2 10337.5 10408.6 10420.8 10426.5 10428.8 10340.4 10385.4 10393.7 10398.3 10400.2 10290.0 10307.1 10322.3 10335.8 10344.5 41267.4 41585.4 41655.4 41656.8 41662.8 3221.4 3267.4 3303.8 3380.3 3616.9 30848.1 31214.8 31395.2 31481.7 32171.0 4147.9 4216.5 4257.1 4279.2 4406.3 326519.0 327244.0 328013.0 328074.0 329439.0 56312.0 56571.2 56640.0 56683.7 56719.0 59001.4 59145.7 59254.7 59270.9 59282.4 16340.1 16570.3 16578.6 16579.9 16582.5 11819.5 12307.7 12338.3 12339.9 12348.5 14339.6 15871.6 15945.4 15974.7 16887.6 6179.8 6432.5 6505.5 6530.4 6597.0 858.8 981.8 1009.5 1053.9 1075.2 31318.2 31591.5 31818.7 31946.8 32273.4 1025.9 1081.7 1102.5 1120.3 1195.0 15698.4 16499.8 16648.6 16679.7 16699.3 440586.0 440961.0 441628.0 443280.0 443463.0 49958.3 51084.2 54087.7 55188.2 55209.0 1227.3 1296.2 1298.3 1304.4 1318.3 29221.0 30163.7 31522.1 31697.2 32251.4 48136.0 48556.8 48588.3 48858.0 48860.0 393619.0 395962.0 396310.0 396361.0 396891.0 24949.5 25354.2 25566.0 25785.4 25787.9 38771.4 41180.4 42248.0 42578.0 42868.0 34111.7 34755.5 35004.0 35704.5 36207.5 34135.7 34490.7 34587.3 34677.5 34768.3 35092.8 35430.6 35531.0 35670.0 35826.3 29691.9 31996.4 32192.8 32491.0 32632.8 24860.8 25480.9 25556.0 25577.9 25758.6 15:28:40 INFO - PROCESS | 32505 | 15:28:40 INFO - PROCESS | 32505 | [#2] jquery.html Cycles:180 Average:27367.45 Median:41069.69 stddev:75475.33 (183.8%) stddev-sans-first:75659.82 15:28:40 INFO - PROCESS | 32505 | Values: 365.3 380.4 391.3 392.6 415.0 13640.4 13990.2 15820.0 18802.2 18971.5 17836.0 17947.5 18110.5 18126.5 18427.3 5267.6 5690.8 5697.0 5704.2 5706.8 5450.6 5542.8 5552.8 5558.5 5596.8 5594.6 5594.9 5595.3 5599.7 5603.7 5429.2 5464.3 5508.0 5511.6 5535.5 4919.3 4941.3 4944.7 4951.3 4952.7 21289.5 21621.0 21830.5 22055.0 22159.0 1978.2 2073.8 2166.7 2193.8 2211.5 9647.5 9671.3 10029.5 10078.7 10440.2 1876.4 1940.8 1952.6 1952.7 1995.2 77490.9 78304.6 78455.2 80712.2 83288.6 10425.7 10657.4 10749.9 10864.5 10974.9 14974.0 14982.9 14985.3 15004.5 15055.5 7753.0 7944.4 8072.8 8253.0 8368.9 7821.3 7932.5 7938.8 8092.6 8145.2 4556.8 4600.1 4660.2 4678.9 4737.1 1910.7 1923.2 1925.7 1935.0 1958.9 809.0 844.8 864.2 865.3 874.2 17920.3 18675.4 18793.5 18834.9 19072.1 916.4 924.5 1011.2 1031.5 1042.3 9871.3 10374.7 10477.6 10502.6 10526.9 448298.0 450480.0 456747.0 459473.0 470008.1 84541.6 86584.0 88117.0 89028.0 89080.6 970.3 975.0 976.9 982.9 997.2 15743.1 16125.2 16346.9 16502.2 16676.0 38716.6 39832.6 40888.4 40924.6 41214.8 52297.0 52518.7 55047.7 58111.0 59131.4 8018.4 8307.3 8373.5 8508.1 8541.7 10615.9 12138.8 12484.6 12487.3 12718.4 9580.2 10306.0 10519.8 10560.0 10626.4 10182.2 10252.2 10487.7 10582.4 10674.2 10576.5 10657.1 11121.5 11180.6 11310.4 7943.2 8082.5 8162.3 8355.0 8406.2 9946.6 10816.0 10946.7 11132.8 11139.2 15:28:40 INFO - PROCESS | 32505 | 15:28:40 INFO - PROCESS | 32505 | [#3] mootools.html Cycles:180 Average:5432.93 Median:4871.82 stddev:3103.51 (63.7%) stddev-sans-first:3096.79 15:28:40 INFO - PROCESS | 32505 | Values: 1314.8 1361.6 1392.5 1479.8 1720.9 7291.6 8045.9 8329.9 8338.8 8597.0 8343.2 8412.0 8415.8 8434.2 8434.3 1903.6 1966.7 2155.3 2185.8 2190.5 2168.0 2229.0 2235.6 2243.3 2244.4 2167.1 2167.6 2181.2 2182.5 2210.4 2196.4 2218.0 2221.1 2226.3 2227.4 2172.8 2206.1 2208.8 2209.6 2210.8 8314.1 8363.8 8501.6 8507.3 8509.2 5032.4 5161.2 5168.5 5174.2 5179.0 3134.6 3379.3 3386.6 3397.5 3414.5 1044.8 1049.8 1058.9 1064.1 1139.1 10934.4 11155.6 11300.7 11611.5 11724.1 4213.8 4322.9 4405.0 4424.5 4433.4 9168.2 9198.0 9199.7 9202.3 9214.3 5077.3 5093.1 5094.0 5099.1 5102.3 3936.9 4230.3 4753.5 4763.6 4816.9 3589.4 3625.1 3631.9 3701.6 3713.9 1113.2 1116.2 1124.0 1125.2 1128.3 769.7 857.7 887.7 904.4 907.8 5461.8 5510.5 5556.9 5574.6 5960.5 406.6 408.2 408.9 413.9 420.9 3740.3 3822.5 3839.5 3861.2 3968.4 9918.1 10427.8 10433.8 10435.6 10447.8 10085.7 10120.1 10171.8 10291.5 10316.2 7645.6 7708.1 7825.5 7849.8 7850.8 5377.2 5396.4 5434.5 5484.1 5575.8 9422.2 9437.9 9468.3 9478.6 9564.3 9524.6 9537.4 9718.1 9834.2 9838.8 6475.5 6672.5 6829.3 7152.7 7239.7 7840.4 8181.9 8186.4 8191.4 8198.8 7148.3 7224.2 7401.0 7474.0 7482.8 7001.4 7077.8 7214.5 7245.4 7257.3 6597.9 6735.1 6740.1 6751.3 6752.4 4803.3 4843.6 4900.1 4934.7 5011.7 4546.1 4628.6 4644.4 4695.6 4779.0 15:28:40 INFO - PROCESS | 32505 | 15:28:40 INFO - PROCESS | 32505 | [#4] prototype.html Cycles:180 Average:4574.59 Median:5100.97 stddev:1312.07 (25.7%) stddev-sans-first:1277.26 15:28:40 INFO - PROCESS | 32505 | Values: 371.4 373.7 375.1 376.3 379.6 5001.3 5115.3 5136.4 5147.2 5193.7 5039.5 5101.9 5155.2 5162.7 5165.2 3924.2 3993.2 4008.5 4122.8 4132.5 4085.6 4089.2 4102.5 4104.1 4107.9 4041.5 4068.4 4078.5 4099.4 4104.8 4007.6 4078.4 4084.1 4092.7 4112.2 3660.4 3677.9 3683.7 3684.4 3688.3 5033.3 5043.7 5048.2 5062.5 5075.3 4675.3 4678.3 4698.3 4712.7 4715.4 5278.4 5345.9 5361.6 5365.5 5378.2 4020.7 4051.7 4053.6 4063.1 4068.2 5660.2 5679.9 5692.7 5713.5 5714.0 4010.7 4127.4 4128.3 4130.9 4133.8 4191.8 4200.2 4203.2 4216.8 4217.6 4681.9 4692.4 4710.5 4727.3 4729.9 5216.9 5341.9 5358.4 5408.7 5424.6 1405.5 1412.3 1413.7 1417.4 1429.7 966.6 1006.2 1008.2 1017.3 1026.1 4901.7 4981.6 4991.9 5007.5 5032.4 5250.5 5320.4 5344.8 5359.4 5371.3 4871.4 5003.7 5018.2 5086.4 5100.0 2823.6 2833.0 2844.1 2848.1 2850.5 5482.7 5503.5 5507.3 5520.0 5529.2 5365.9 5464.9 5672.5 5676.0 5680.3 5697.0 5704.0 5736.8 5751.6 5769.2 5505.7 5580.3 5619.9 5631.9 5658.7 5554.4 5592.1 5594.6 5596.7 5597.3 5708.1 5736.2 5781.4 5782.6 5794.2 3835.3 3945.3 3988.0 3988.2 4019.4 5360.6 5471.4 5545.1 5590.0 5604.2 5338.5 5439.2 5445.9 5462.8 5471.2 5391.8 5393.8 5421.7 5433.2 5444.9 5166.0 5339.4 5384.9 5394.9 5401.2 5430.2 5509.0 5527.8 5534.7 5544.2 5300.2 5386.9 5393.4 5400.7 5412.9 15:28:40 INFO - PROCESS | 32505 | 15:28:40 INFO - PROCESS | 32505 | [#5] yui.html Cycles:180 Average:17793.91 Median:29207.65 stddev:24006.38 (82.2%) stddev-sans-first:24039.10 15:28:40 INFO - PROCESS | 32505 | Values: 622.3 644.5 659.8 742.7 764.1 14545.3 15133.7 15235.6 15274.7 15290.8 14873.5 14908.0 15001.7 15025.1 15063.4 784.5 804.9 805.8 809.6 820.9 676.5 690.2 783.6 784.1 804.6 838.2 838.5 838.9 839.0 840.1 836.7 837.4 837.5 837.7 838.6 515.2 527.9 592.1 606.0 613.0 15070.8 15094.2 15132.4 15146.6 15173.5 13965.4 13989.9 14008.0 14115.9 14181.4 12968.9 13032.2 13190.0 13358.2 14105.1 4319.6 4326.6 4347.0 4350.1 4440.5 82072.0 82127.2 83075.0 85712.6 86107.6 10429.5 11123.4 11130.6 11156.2 11338.0 20825.3 20903.5 20914.3 20921.7 21079.7 7185.0 7751.5 7805.4 7855.2 8058.9 4099.4 4144.7 4222.7 4246.0 4345.3 3437.3 3474.6 3507.2 3511.4 3514.8 564.2 569.9 574.6 583.5 584.2 608.8 636.4 637.2 660.9 662.7 8356.5 8536.3 8642.8 8846.7 8913.3 590.5 604.9 624.7 673.7 684.8 4045.6 4058.4 4100.6 4108.6 4168.8 80283.5 81203.2 81601.0 82483.6 84150.6 70065.0 70223.6 71850.6 72931.6 72973.6 63456.7 65829.3 67265.0 68311.7 68501.7 8212.3 8608.3 8671.4 8709.0 9019.7 45118.3 45913.0 46417.5 47322.3 47368.3 57840.7 61423.4 62690.7 62890.0 63859.4 10291.4 10516.4 10597.2 10825.9 11033.7 11425.1 11586.9 11671.2 11683.4 11871.7 11642.2 11660.5 11713.8 11728.7 12471.7 10710.9 11097.8 11200.2 11431.7 12125.9 11416.8 11580.8 11678.4 11683.6 11932.5 8879.6 8947.2 9638.4 9645.6 9794.3 9368.0 9794.9 9859.5 9907.4 10078.7 15:28:40 INFO - PROCESS | 32505 | -------- Summary: end -------- 15:28:40 INFO - PROCESS | 32505 | 15:28:41 INFO - TEST-INFO | 32505: exit 0 15:28:41 INFO - TEST-OK | dromaeo_css | took 1115732ms 15:28:41 INFO - TEST-START | kraken 15:28:41 INFO - operating with platform_type : linux_ 15:28:41 INFO - Initialising browser for kraken test... 15:28:41 INFO - TEST-INFO | started process 343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVa7RZ4/profile http://localhost:50383/getInfo.html) 15:28:44 INFO - PROCESS | 343 | __metrics Screen width/height:1600/1200 15:28:44 INFO - PROCESS | 343 | colorDepth:24 15:28:44 INFO - PROCESS | 343 | Browser inner width/height: 1024/697 15:28:44 INFO - PROCESS | 343 | __metrics 15:28:45 INFO - PROCESS | 343 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:28:45 INFO - PROCESS | 343 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:28:45 INFO - PROCESS | 343 | console.error: PushService: 15:28:45 INFO - PROCESS | 343 | stateChangeProcessEnqueue: Error transitioning state 15:28:45 INFO - PROCESS | 343 | UnknownError 15:28:46 INFO - TEST-INFO | 343: exit 0 15:28:46 INFO - Browser initialized. 15:28:46 INFO - Running cycle 1/1 for kraken test... 15:28:46 INFO - TEST-INFO | started process 429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVa7RZ4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:28:58 INFO - PROCESS | 429 | RSS: Main: 152805376 15:28:58 INFO - PROCESS | 429 | 15:29:00 INFO - PROCESS | 429 | Cycle 1(1): loaded http://localhost:50383/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50383/tests/kraken/driver.html?testName=audio-beat-detection) 15:29:01 INFO - PROCESS | 429 | RSS: Main: 206282752 15:29:01 INFO - PROCESS | 429 | 15:29:04 INFO - PROCESS | 429 | Cycle 1(1): loaded http://localhost:50383/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50383/tests/kraken/driver.html?testName=audio-dft) 15:29:04 INFO - PROCESS | 429 | RSS: Main: 184995840 15:29:04 INFO - PROCESS | 429 | 15:29:07 INFO - PROCESS | 429 | Cycle 1(1): loaded http://localhost:50383/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50383/tests/kraken/driver.html?testName=audio-fft) 15:29:08 INFO - PROCESS | 429 | RSS: Main: 266674176 15:29:08 INFO - PROCESS | 429 | 15:29:10 INFO - PROCESS | 429 | Cycle 1(1): loaded http://localhost:50383/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50383/tests/kraken/driver.html?testName=audio-oscillator) 15:29:11 INFO - PROCESS | 429 | RSS: Main: 177340416 15:29:11 INFO - PROCESS | 429 | 15:29:13 INFO - PROCESS | 429 | Cycle 1(1): loaded http://localhost:50383/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50383/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:29:13 INFO - PROCESS | 429 | RSS: Main: 182288384 15:29:13 INFO - PROCESS | 429 | 15:29:16 INFO - PROCESS | 429 | Cycle 1(1): loaded http://localhost:50383/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50383/tests/kraken/driver.html?testName=imaging-darkroom) 15:29:17 INFO - PROCESS | 429 | RSS: Main: 221188096 15:29:17 INFO - PROCESS | 429 | 15:29:20 INFO - PROCESS | 429 | Cycle 1(1): loaded http://localhost:50383/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50383/tests/kraken/driver.html?testName=imaging-desaturate) 15:29:21 INFO - PROCESS | 429 | RSS: Main: 221077504 15:29:21 INFO - PROCESS | 429 | 15:29:24 INFO - PROCESS | 429 | Cycle 1(1): loaded http://localhost:50383/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50383/tests/kraken/driver.html?testName=json-parse-financial) 15:29:24 INFO - PROCESS | 429 | RSS: Main: 219938816 15:29:24 INFO - PROCESS | 429 | 15:29:26 INFO - PROCESS | 429 | Cycle 1(1): loaded http://localhost:50383/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50383/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:29:27 INFO - PROCESS | 429 | RSS: Main: 181862400 15:29:27 INFO - PROCESS | 429 | 15:29:28 INFO - PROCESS | 429 | Cycle 1(1): loaded http://localhost:50383/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50383/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:29:29 INFO - PROCESS | 429 | RSS: Main: 188641280 15:29:29 INFO - PROCESS | 429 | 15:29:31 INFO - PROCESS | 429 | Cycle 1(1): loaded http://localhost:50383/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50383/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:29:32 INFO - PROCESS | 429 | RSS: Main: 197726208 15:29:32 INFO - PROCESS | 429 | 15:29:34 INFO - PROCESS | 429 | Cycle 1(1): loaded http://localhost:50383/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50383/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:29:35 INFO - PROCESS | 429 | RSS: Main: 206569472 15:29:35 INFO - PROCESS | 429 | 15:29:38 INFO - PROCESS | 429 | Cycle 1(1): loaded http://localhost:50383/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50383/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:29:38 INFO - PROCESS | 429 | RSS: Main: 203190272 15:29:38 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | Cycle 1(1): loaded http://localhost:50383/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50383/tests/kraken/driver.html?testName=ai-astar) 15:29:40 INFO - PROCESS | 429 | RSS: Main: 254480384 15:29:40 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | __start_tp_report 15:29:40 INFO - PROCESS | 429 | _x_x_mozilla_page_load 15:29:40 INFO - PROCESS | 429 | _x_x_mozilla_page_load_details 15:29:40 INFO - PROCESS | 429 | |i|pagename|runs| 15:29:40 INFO - PROCESS | 429 | |0;ai-astar;104;111;112;110;112;113;112;111;112;111 15:29:40 INFO - PROCESS | 429 | |1;audio-beat-detection;143;123;130;162;122;122;121;123;137;120 15:29:40 INFO - PROCESS | 429 | |2;audio-dft;160;160;161;161;159;163;161;162;163;162 15:29:40 INFO - PROCESS | 429 | |3;audio-fft;75;74;77;107;75;75;74;74;92;75 15:29:40 INFO - PROCESS | 429 | |4;audio-oscillator;82;82;107;83;84;83;107;83;83;113 15:29:40 INFO - PROCESS | 429 | |5;imaging-gaussian-blur;128;127;127;126;127;127;127;127;127;127 15:29:40 INFO - PROCESS | 429 | |6;imaging-darkroom;145;145;145;145;145;146;145;146;145;147 15:29:40 INFO - PROCESS | 429 | |7;imaging-desaturate;96;96;95;95;95;96;95;95;96;96 15:29:40 INFO - PROCESS | 429 | |8;json-parse-financial;56;51;52;50;53;53;54;53;53;52 15:29:40 INFO - PROCESS | 429 | |9;json-stringify-tinderbox;64;64;63;63;63;64;64;63;64;64 15:29:40 INFO - PROCESS | 429 | |10;stanford-crypto-aes;80;80;89;83;81;85;79;80;79;82 15:29:40 INFO - PROCESS | 429 | |11;stanford-crypto-ccm;138;127;123;127;124;124;124;123;166;131 15:29:40 INFO - PROCESS | 429 | |12;stanford-crypto-pbkdf2;164;164;167;163;164;164;163;163;167;161 15:29:40 INFO - PROCESS | 429 | |13;stanford-crypto-sha256-iterative;63;62;63;62;62;63;62;66;62;61 15:29:40 INFO - PROCESS | 429 | __end_tp_report 15:29:40 INFO - PROCESS | 429 | __start_cc_report 15:29:40 INFO - PROCESS | 429 | _x_x_mozilla_cycle_collect,1660 15:29:40 INFO - PROCESS | 429 | __end_cc_report 15:29:40 INFO - PROCESS | 429 | __startTimestamp1482276580709__endTimestamp 15:29:40 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | ------- Summary: start ------- 15:29:40 INFO - PROCESS | 429 | Number of tests: 14 15:29:40 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:2.53 (2.3%) stddev-sans-first:0.88 15:29:40 INFO - PROCESS | 429 | Values: 104.0 111.0 112.0 110.0 112.0 113.0 112.0 111.0 112.0 111.0 15:29:40 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | [#1] audio-beat-detection Cycles:10 Average:130.30 Median:126.50 stddev:13.53 (10.7%) stddev-sans-first:13.55 15:29:40 INFO - PROCESS | 429 | Values: 143.0 123.0 130.0 162.0 122.0 122.0 121.0 123.0 137.0 120.0 15:29:40 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.32 (0.8%) stddev-sans-first:1.32 15:29:40 INFO - PROCESS | 429 | Values: 160.0 160.0 161.0 161.0 159.0 163.0 161.0 162.0 163.0 162.0 15:29:40 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | [#3] audio-fft Cycles:10 Average:79.80 Median:75.00 stddev:11.00 (14.7%) stddev-sans-first:11.53 15:29:40 INFO - PROCESS | 429 | Values: 75.0 74.0 77.0 107.0 75.0 75.0 74.0 74.0 92.0 75.0 15:29:40 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:83.00 stddev:12.75 (15.4%) stddev-sans-first:13.12 15:29:40 INFO - PROCESS | 429 | Values: 82.0 82.0 107.0 83.0 84.0 83.0 107.0 83.0 83.0 113.0 15:29:40 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | [#5] imaging-gaussian-blur Cycles:10 Average:127.00 Median:127.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 15:29:40 INFO - PROCESS | 429 | Values: 128.0 127.0 127.0 126.0 127.0 127.0 127.0 127.0 127.0 127.0 15:29:40 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 15:29:40 INFO - PROCESS | 429 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 147.0 15:29:40 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:29:40 INFO - PROCESS | 429 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 15:29:40 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:1.64 (3.1%) stddev-sans-first:1.22 15:29:40 INFO - PROCESS | 429 | Values: 56.0 51.0 52.0 50.0 53.0 53.0 54.0 53.0 53.0 52.0 15:29:40 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 15:29:40 INFO - PROCESS | 429 | Values: 64.0 64.0 63.0 63.0 63.0 64.0 64.0 63.0 64.0 64.0 15:29:40 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.50 stddev:3.16 (3.9%) stddev-sans-first:3.28 15:29:40 INFO - PROCESS | 429 | Values: 80.0 80.0 89.0 83.0 81.0 85.0 79.0 80.0 79.0 82.0 15:29:40 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:127.00 stddev:13.25 (10.4%) stddev-sans-first:13.79 15:29:40 INFO - PROCESS | 429 | Values: 138.0 127.0 123.0 127.0 124.0 124.0 124.0 123.0 166.0 131.0 15:29:40 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:164.00 stddev:1.83 (1.1%) stddev-sans-first:1.94 15:29:40 INFO - PROCESS | 429 | Values: 164.0 164.0 167.0 163.0 164.0 164.0 163.0 163.0 167.0 161.0 15:29:40 INFO - PROCESS | 429 | 15:29:40 INFO - PROCESS | 429 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.50 stddev:1.35 (2.2%) stddev-sans-first:1.42 15:29:40 INFO - PROCESS | 429 | Values: 63.0 62.0 63.0 62.0 62.0 63.0 62.0 66.0 62.0 61.0 15:29:40 INFO - PROCESS | 429 | -------- Summary: end -------- 15:29:40 INFO - PROCESS | 429 | 15:29:41 INFO - TEST-INFO | 429: exit 0 15:29:41 INFO - TEST-OK | kraken | took 60752ms 15:29:41 INFO - SUITE-END | took 1176s 15:29:41 INFO - Completed test suite (00:19:36) 15:29:41 INFO - javascript benchmark 15:29:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2949.7640188784894, 2962.3779006408654, 2992.9551056734144, 3002.6396832380105, 3009.9999999999986, 5128.769205385757, 5187.247849061884, 5191.636585439021, 5260.053190425727, 5340.279062326589, 5193.065248255322, 5224.164133738603, 5225.242339860718, 5332.57339412847, 5364.624476286662, 4730.432348118214, 4753.191957367256, 4782.83260085897, 4827.589654879331, 4842.97578512107, 4757.738324392157, 4807.110684523374, 4831.7584120794, 4855.660103792736, 4864.246041863499, 4775.0, 4785.784639691222, 4841.2496063110275, 4841.854744357657, 4867.732274724889, 4608.262677971542, 4629.745364004978, 4633.4439867215815, 4715.764211789431, 4771.737554434505, 4711.151992641323, 4734.928976065362, 4743.928841067387, 4777.211760059586, 4803.831865884677, 5174.275601415805, 5249.947500524984, 5250.238715386286, 5250.8687282817855, 5260.473952604747, 5383.246345511592, 5454.154606036071, 5501.807436739695, 5661.745221465044, 5681.517071048966, 5453.345598528163, 5478.342598888119, 5488.17677348401, 5526.281583394173, 5532.75102620383, 5134.255532947702, 5141.048905952373, 5144.279800827887, 5146.099432599318, 5183.248428977777, 5526.834194974157, 5530.059889818741, 5590.636608620427, 5595.552355811526, 5599.692016939026, 5423.267858839085, 5452.700101494456, 5512.145617429305, 5534.557235421237, 5588.6646801192055, 5571.637843540157, 5607.074832652566, 5611.438856114356, 5615.775368985276, 5626.324841019104, 5420.864478388072, 5544.667319960735, 5596.720163991866, 5604.243427137284, 5609.523190528851, 5456.945430545723, 5474.0, 5480.862978425492, 5486.8203336282895, 5549.72251387429, 4204.4324016257415, 4206.137741762931, 4207.915841683149, 4208.873733787991, 4242.957570424256, 3793.260314238697, 3802.448644946467, 3813.1801662642665, 3837.6737977272246, 3853.4797802296894, 5185.170372740344, 5186.351706036746, 5204.219367094966, 5250.3962044364625, 5262.500062494057, 5603.3836278009385, 5618.606697531215, 5622.212890195376, 5647.435256474319, 5663.886722265532, 5307.044731948286, 5313.707746074003, 5314.468553144655, 5317.73411329432, 5362.785488580413, 4619.653525985565, 4644.535546445329, 4718.905621887612, 4723.126221649006, 4759.952400476021, 5840.737166827503, 5847.1229315603, 5851.444112809361, 5900.970495147582, 5913.0, 5593.608447408642, 5634.6337488063145, 5646.040173170653, 5651.4348565143155, 5660.122680984454, 5599.1041433370465, 5642.435756424325, 5835.095560188008, 5835.2122463466885, 5835.299764028344, 5435.510804027656, 5444.754986025559, 5467.0, 5493.945060549343, 5538.556915446835, 5557.610967232416, 5560.527355174855, 5560.944390556205, 5567.8886422272135, 5568.860778480571, 5345.572354211576, 5386.353637563518, 5447.0, 5451.0, 5505.03661859165, 5433.157860531624, 5493.368262649847, 5496.835094947158, 5540.445955404427, 5584.246126772834, 5456.345238571397, 5462.644928079662, 5462.9180562292395, 5465.836024919259, 5495.450454954633, 5366.221897824872, 5380.354357477127, 5504.834854954358, 5525.281713377235, 5592.384837667934, 5424.050791111618, 5449.7002664852225, 5454.2091396746455, 5505.0, 5516.3380394351325], "value": 5141.618735112198, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.7621584610695, 567.911973644085, 568.2697733412563, 580.077676494374, 584.3688816078635, 31722.682773172262, 32444.0, 33884.32231355371, 41286.58713412865, 42454.575454245445, 43877.341839872424, 44390.77804610981, 44410.555894441044, 44460.0, 44474.0, 8573.314134869195, 8642.0, 8658.826823463527, 8738.475691458532, 8741.213290803826, 7932.762017139495, 8108.472949258309, 8599.527026013568, 10183.236257280696, 10403.219758518104, 10337.483125843715, 10408.583656653725, 10420.791584168312, 10426.530806113744, 10428.791424171512, 10340.431276279802, 10385.376877387305, 10393.740156496073, 10398.324108932895, 10400.219983501192, 10290.0, 10307.12389446898, 10322.277440579162, 10335.844962325571, 10344.534495947626, 41267.380989285186, 41585.37621935673, 41655.375169372484, 41656.79171604153, 41662.79168604168, 3221.4040402525607, 3267.4445344291526, 3303.8348082595776, 3380.256343604403, 3616.9276614467826, 30848.062525545534, 31214.843925780453, 31395.215119621964, 31481.685183148333, 32171.0, 4147.854825081107, 4216.51510076342, 4257.106007738379, 4279.165562715271, 4406.272964960777, 326519.0, 327244.0, 328013.0, 328074.0, 329439.0, 56312.0, 56571.15143272854, 56640.0, 56683.716581417655, 56719.0, 59001.40998590045, 59145.704271479226, 59254.70372648195, 59270.92551760754, 59282.40717592855, 16340.101294428921, 16570.337186512646, 16578.58553536147, 16579.91710041442, 16582.50252492403, 11819.527218911318, 12307.69230769238, 12338.259704417764, 12339.93830030844, 12348.506059757688, 14339.569812905422, 15871.603209919613, 15945.36218551245, 15974.68050639004, 16887.577810554587, 6179.84550386244, 6432.549721519449, 6505.51208659343, 6530.412262896362, 6597.0, 858.8411143938391, 981.8330883749637, 1009.4599389326675, 1053.8893416191343, 1075.1774892207468, 31318.217044573612, 31591.52612710811, 31818.68181318157, 31946.840265798986, 32273.35453290968, 1025.8820235672993, 1081.7025318037602, 1102.5479553383075, 1120.3389999900098, 1195.0, 15698.372065117495, 16499.752503712454, 16648.583785405463, 16679.6664066718, 16699.332026718796, 440586.0, 440961.0, 441628.0, 443280.0, 443463.0, 49958.25062624064, 51084.23373649398, 54087.72956135273, 55188.17217741737, 55209.0, 1227.3127048852493, 1296.1510210811932, 1298.3313593499356, 1304.3999760110266, 1318.2551858200086, 29221.0, 30163.69836301609, 31522.054338369886, 31697.20756981094, 32251.354972899942, 48136.0, 48556.81494332834, 48588.27117593168, 48858.0, 48860.0, 393619.0, 395962.0, 396310.0, 396361.0, 396891.0, 24949.50100998006, 25354.239372818844, 25566.0, 25785.355366115997, 25787.871060645328, 38771.41842872303, 41180.38229426501, 42248.0, 42578.0, 42868.0, 34111.65888341184, 34755.478667819494, 35004.0, 35704.464433033005, 36207.456888146175, 34135.658643414245, 34490.65509344975, 34587.30825383428, 34677.47983780195, 34768.30463390667, 35092.82453587716, 35430.645693542734, 35531.0, 35670.0, 35826.283474329844, 29691.85154074216, 31996.360072797946, 32192.83903580467, 32491.0, 32632.83683581567, 24860.751392485843, 25480.872595637644, 25556.0, 25577.872110639328, 25758.613620796077], "value": 19098.226364892544, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.2858661317125, 380.4483498926557, 391.25661243637086, 392.6407337286382, 414.98132584033715, 13640.408322418734, 13990.160590364572, 15819.999999999985, 18802.247910083614, 18971.52571185721, 17836.0, 17947.461576152735, 18110.4566862994, 18126.46533925885, 18427.262909483637, 5267.55225805806, 5690.772369105231, 5697.0, 5704.201411802351, 5706.828795136153, 5450.618456708032, 5542.806001789938, 5552.805651802168, 5558.527525160366, 5596.776128954837, 5594.58040646951, 5594.888102237953, 5595.328560572737, 5599.7480113394795, 5603.719814009303, 5429.158480435539, 5464.3442786865635, 5508.008558459495, 5511.58663100265, 5535.474129957647, 4919.311296418504, 4941.283513890466, 4944.653874228806, 4951.331570238008, 4952.727599981999, 21289.467763305885, 21621.0, 21830.45423864416, 22055.0, 22159.0, 1978.2284908885547, 2073.7718850926385, 2166.6749987501844, 2193.7586865444787, 2211.5355775287208, 9647.469389183592, 9671.323007389485, 10029.548670309854, 10078.748031299203, 10440.216983726252, 1876.408931186672, 1940.8350290225349, 1952.5899561092187, 1952.6582848001542, 1995.1520603743495, 77490.92234925114, 78304.60847695782, 78455.21544784593, 80712.19287807164, 83288.58355708243, 10425.687229383131, 10657.413842238751, 10749.946250268698, 10864.511097000654, 10974.890251097388, 14974.0, 14982.925085374503, 14985.328594494418, 15004.549863504113, 15055.54833355001, 7753.0, 7944.443888927835, 8072.8385432291025, 8252.958735206286, 8368.916310836936, 7821.256980586835, 7932.524048557105, 7938.841223175504, 8092.595370231465, 8145.226203510657, 4556.8177272908715, 4600.102979918951, 4660.184467718136, 4678.8596342109795, 4737.099951009366, 1910.703840904662, 1923.2403200735912, 1925.7290188475538, 1934.965596730832, 1958.9118489667999, 808.9999999999882, 844.8479273730787, 864.1703964194318, 865.2731705367521, 874.2437791310471, 17920.28318867257, 18675.43973680792, 18793.53016174579, 18834.905825471058, 19072.14175362112, 916.3997581584073, 924.5007695844168, 1011.206203130539, 1031.5306535526317, 1042.3329069395593, 9871.30900836949, 10374.740631484123, 10477.633282835064, 10502.632407865842, 10526.947365263124, 448298.0, 450480.0, 456747.0, 459473.0, 470008.1495517711, 84541.57729211438, 86584.0, 88117.0, 89028.0, 89080.5545972266, 970.2819913264275, 975.0298453039271, 976.9218462522981, 982.921366290695, 997.2498265544069, 15743.13412762309, 16125.193740313172, 16346.918265408596, 16502.17489125563, 16676.0, 38716.6128338713, 39832.60167398405, 40888.38667419932, 40924.590754092074, 41214.79392603018, 52296.95406091933, 52518.73740631272, 55047.72476137754, 58111.0, 59131.40868591431, 8018.438709290293, 8307.293880020266, 8373.497590144367, 8508.149185081442, 8541.658333666584, 10615.946920265349, 12138.75722485563, 12484.625461236177, 12487.31319777421, 12718.427670755023, 9580.18568421692, 10305.99033188521, 10519.789604208027, 10560.0, 10626.415547144981, 10182.18542516582, 10252.179825613784, 10487.737806554896, 10582.365058096539, 10674.199435042248, 10576.524056417633, 10657.14742820588, 11121.499532521218, 11180.608678696206, 11310.434478276218, 7943.24539168778, 8082.515049097073, 8162.347012239125, 8354.997400312002, 8406.201410865959, 9946.602135914482, 10816.026557609854, 10946.726331841768, 11132.777344453227, 11139.220254582102], "value": 8768.269073099274, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.7830607949688, 1361.5847166614183, 1392.5265409760682, 1479.7791821747062, 1720.9397671081506, 7291.635418229087, 8045.87931181032, 8329.875051874227, 8338.791530211754, 8596.968363796337, 8343.165683431655, 8412.0, 8415.789605259872, 8434.24091831735, 8434.283085937703, 1903.6097599992038, 1966.7443232379771, 2155.299527653511, 2185.825133989285, 2190.5290362572046, 2167.967480487794, 2228.9777102229014, 2235.564065007324, 2243.270936945491, 2244.427670943907, 2167.1223154622403, 2167.5881582499355, 2181.19295860531, 2182.519845633958, 2210.370044537307, 2196.417949243452, 2218.0351547077075, 2221.0893533651124, 2226.2875879718576, 2227.3652009177467, 2172.7935846094597, 2206.062423470019, 2208.7791220877943, 2209.6464565669417, 2210.80102790748, 8314.127016663224, 8363.832723345498, 8501.61742721579, 8507.276881465083, 8509.234168924764, 5032.3961124665275, 5161.174212126042, 5168.483151684839, 5174.249733788617, 5179.0, 3134.5925029746213, 3379.290349026707, 3386.5597472328686, 3397.5243465914546, 3414.453687410027, 1044.759705267785, 1049.8477720730452, 1058.8570542976754, 1064.1061508333037, 1139.0716565998766, 10934.398608076554, 11155.609553665663, 11300.660980170607, 11611.477483513178, 11724.120690948213, 4213.831446742157, 4322.913541729148, 4405.03089320349, 4424.535423780521, 4433.401490798766, 9168.220701240336, 9198.0, 9199.678011269574, 9202.263818894473, 9214.308926830514, 5077.339945807022, 5093.083245015859, 5094.0, 5099.133147364957, 5102.311187989648, 3936.9212615748097, 4230.302000169938, 4753.500882407367, 4763.595094417014, 4816.879578010507, 3589.4436362363876, 3625.0574850538524, 3631.854725810938, 3701.6113308102263, 3713.9071523212137, 1113.1873732175557, 1116.201915630312, 1123.971900702489, 1125.21797350842, 1128.2666266926562, 769.6690423118001, 857.6998050682336, 887.7349776568365, 904.412132114131, 907.773056735816, 5461.781528738886, 5510.504054635022, 5556.888862222733, 5574.554035677136, 5960.463558279689, 406.5873138764157, 408.2304855347691, 408.8895998080561, 413.8965258685329, 420.9305464598368, 3740.308043011997, 3822.541295044557, 3839.520059992501, 3861.2084522673345, 3968.40473928913, 9918.107370336704, 10427.791444171075, 10433.843492347622, 10435.634752783617, 10447.84328235077, 10085.739282589677, 10120.089191972758, 10171.796564068678, 10291.53688084038, 10316.1747060235, 7645.579493127821, 7708.113566939874, 7825.491343062683, 7849.803754906173, 7850.842983140419, 5377.166539186433, 5396.406395296436, 5434.483724046209, 5484.095124304445, 5575.832725018256, 9422.246220302497, 9437.905620943977, 9468.337216394786, 9478.57346419399, 9564.330496865152, 9524.619015239312, 9537.427754334762, 9718.125368716566, 9834.213262938805, 9838.803223935338, 6475.481961443167, 6672.5329226953645, 6829.31706829333, 7152.6781294842895, 7239.674214660458, 7840.411969102226, 8181.877271840808, 8186.386021048326, 8191.385646076449, 8198.754037378889, 7148.28517148281, 7224.2300636344435, 7401.0, 7473.991011213634, 7482.812929676802, 7001.36987671112, 7077.752278670222, 7214.531055481377, 7245.38414234796, 7257.346838784535, 6597.868042639025, 6735.090762746966, 6740.090087838275, 6751.324867513209, 6752.426043786333, 4803.327534145293, 4843.564079232886, 4900.068986892479, 4934.703917764946, 5011.699298042129, 4546.136234115507, 4628.583427491542, 4644.396228490275, 4695.600873925755, 4778.952210477851], "value": 4261.858295389064, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.4446901881686, 373.7495877761899, 375.12969909809243, 376.26064782701985, 379.5672932856544, 5001.349824522807, 5115.258287548303, 5136.357955255593, 5147.176451767713, 5193.662411943225, 5039.521245481674, 5101.948980510194, 5155.2009438537, 5162.664426812264, 5165.199394093912, 3924.1955399143108, 3993.181397813456, 4008.518977722663, 4122.8144733486915, 4132.524759652649, 4085.5710150434224, 4089.2230476209575, 4102.507699076115, 4104.1381309924955, 4107.8973025674295, 4041.454403655513, 4068.41008053832, 4078.4509681449094, 4099.442211959451, 4104.774237416941, 4007.5591684914634, 4078.4086307485395, 4084.121913788535, 4092.6930480214105, 4112.218678451115, 3660.3960346543054, 3677.9080522987138, 3683.686886614641, 3684.355237833395, 3688.2992231475932, 5033.320501732256, 5043.697378157322, 5048.16705243638, 5062.4684408137355, 5075.289459475676, 4675.275332323496, 4678.274867395525, 4698.342232087511, 4712.69367491112, 4715.386999690053, 5278.366596008465, 5345.893082138336, 5361.597880159004, 5365.517103460668, 5378.1663842104535, 4020.7386519876113, 4051.7163798534116, 4053.635172834459, 4063.085805693725, 4068.247374235746, 5660.2075709400715, 5679.914801277984, 5692.743826527816, 5713.485786279255, 5713.971430142864, 4010.6991975601945, 4127.442795222607, 4128.256913755553, 4130.938035929464, 4133.81397837098, 4191.790410479463, 4200.201961627281, 4203.222403855297, 4216.789160541961, 4217.599328063829, 4681.9297710534365, 4692.436907571113, 4710.481846996828, 4727.267273572602, 4729.905401891943, 5216.895662086737, 5341.866453338697, 5358.356997160366, 5408.702521361284, 5424.593155513352, 1405.508072174751, 1412.3079690951565, 1413.6993965551717, 1417.4471955937192, 1429.6704065219237, 966.6471737815788, 1006.1799633298838, 1008.1884083313004, 1017.31839667423, 1026.0863489591857, 4901.730404827768, 4981.62637802159, 4991.925121123186, 5007.474215207423, 5032.370953630723, 5250.4749525047955, 5320.441353657888, 5344.759485823147, 5359.3653935549255, 5371.274877891513, 4871.441138835538, 5003.699778013331, 5018.247262910592, 5086.440491545927, 5100.0, 2823.632927719383, 2832.957505637417, 2844.0756754055014, 2848.1170837040586, 2850.474995877196, 5482.698451585121, 5503.477169668875, 5507.256520369699, 5519.9640197891, 5529.170624406291, 5365.892682146413, 5464.9453505464435, 5672.4894759471845, 5676.0, 5680.261565996477, 5697.0, 5704.0, 5736.827895163152, 5751.626144300607, 5769.249997500214, 5505.697186654773, 5580.2745643067765, 5619.915701264403, 5631.915521267102, 5658.660480371026, 5554.444555544414, 5592.105263157875, 5594.552435805207, 5596.664200148004, 5597.328320601554, 5708.115242137475, 5736.168255602997, 5781.392953739797, 5782.595218334676, 5794.246747922743, 3835.2521258354354, 3945.34901741221, 3987.980060099797, 3988.1824226034173, 4019.376996565537, 5360.597955153301, 5471.398146203994, 5545.085060964896, 5589.972050139723, 5604.187392827936, 5338.46615338463, 5439.238506609157, 5445.891082178414, 5462.8361149165585, 5471.206675032018, 5391.838244852661, 5393.759435329817, 5421.701806400686, 5433.185022246695, 5444.863878403072, 5166.0, 5339.357018275979, 5384.946150538444, 5394.919076213781, 5401.2168235606405, 5430.212619170119, 5509.0, 5527.82150263592, 5534.723263836872, 5544.1960915666195, 5300.2049692546425, 5386.946130538801, 5393.352797664148, 5400.675959442446, 5412.891742165213], "value": 4174.648058695004, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.3465361370561, 644.5455953552743, 659.808655489908, 742.6843591473626, 764.1365257259296, 14545.345459454324, 15133.6973260535, 15235.61910952224, 15274.694506109885, 15290.847091529095, 14873.479428219987, 14908.0, 15001.6999660007, 15025.098494090334, 15063.39746410145, 784.5214419204281, 804.9114597394282, 805.8186907945724, 809.5911564659839, 820.8891799607036, 676.5129107042922, 690.2097098821846, 783.5925318834203, 784.1335324466468, 804.5977011494252, 838.1785849867134, 838.4591938199858, 838.9454685445457, 839.0099682374795, 840.0717207485732, 836.7322456813822, 837.417994493827, 837.4723923927917, 837.7026155714756, 838.5974732128582, 515.2245869965677, 527.9340082489689, 592.052715654953, 605.9969700151515, 613.0038687133408, 15070.849291507055, 15094.16982065986, 15132.394704211818, 15146.621334466616, 15173.468928587557, 13965.371558279901, 13989.860101398957, 14008.0, 14115.929420352833, 14181.361838717283, 12968.870311296861, 13032.152910060911, 13190.0, 13358.198508089547, 14105.083169593943, 4319.589638984323, 4326.58897404746, 4346.956530434687, 4350.081813465305, 4440.4671439427475, 82072.0, 82127.17872821254, 83074.99999999939, 85712.57143714304, 86107.56946215291, 10429.478526073666, 11123.388213648326, 11130.610428634958, 11156.16328775345, 11338.0, 20825.271115510885, 20903.477413064797, 20914.268000619904, 20921.686174707393, 21079.68380474294, 7184.9640751795905, 7751.457397982087, 7805.37556995439, 7855.214478552099, 8058.919410805935, 4099.405586190045, 4144.70987030905, 4222.725522841006, 4245.9736456807805, 4345.261305578059, 3437.329720704439, 3474.6004209515722, 3507.245942122405, 3511.4030614795547, 3514.7539672222697, 564.1988376505373, 569.9373068962411, 574.5891687443415, 583.5419195931173, 584.1967294969417, 608.8234412020464, 636.4081404294051, 637.1907677249867, 660.867826434715, 662.6752891083335, 8356.456830306011, 8536.274416674652, 8642.827143457096, 8846.709345967201, 8913.331500137516, 590.503976659608, 604.9304330002107, 624.7188765055743, 673.7035704290195, 684.8295369956807, 4045.554988951213, 4058.3912413138264, 4100.610442008005, 4108.630223279919, 4168.8332466701595, 80283.46849656894, 81203.18796812075, 81601.0, 82483.5875820629, 84150.57924710338, 70065.0, 70223.64888175526, 71850.64074679594, 72931.63534182402, 72973.635131824, 63456.68271658704, 65829.34170658328, 67264.99999999903, 68311.65844170748, 68501.65749171222, 8212.289671657225, 8608.311335093053, 8671.4363566368, 8709.0, 9019.729408117766, 45118.32322515231, 45913.0, 46417.53582464132, 47322.29016564685, 47368.28947565858, 57840.710796447434, 61423.385766141764, 62690.686546566976, 62890.0, 63859.36140638534, 10291.382517049002, 10516.369017858953, 10597.15222782191, 10825.891741082489, 11033.668989930315, 11425.14311426663, 11586.884131158919, 11671.174902931572, 11683.357415341898, 11871.703207419883, 11642.24325418845, 11660.53357865676, 11713.824292635787, 11728.70678233051, 12471.688207794878, 10710.892891071302, 11097.833532496858, 11200.215984881306, 11431.657050288504, 12125.878741212828, 11416.82874756896, 11580.826287605862, 11678.416079195837, 11683.649490515298, 11932.522699091938, 8879.629583480975, 8947.239484643878, 9638.42169469834, 9645.614175433186, 9794.265430092913, 9368.0, 9794.853077203705, 9859.457729824928, 9907.356021858555, 10078.697639070839], "value": 6887.241748039224, "unit": "score"}], "name": "dromaeo_css", "value": 6874.159488869822, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 112.0, 110.0, 112.0, 113.0, 112.0, 111.0, 112.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 123.0, 130.0, 162.0, 122.0, 122.0, 121.0, 123.0, 137.0, 120.0], "value": 130.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 159.0, 163.0, 161.0, 162.0, 163.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 77.0, 107.0, 75.0, 75.0, 74.0, 74.0, 92.0, 75.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 107.0, 83.0, 84.0, 83.0, 107.0, 83.0, 83.0, 113.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 127.0, 126.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0], "value": 127.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 147.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 51.0, 52.0, 50.0, 53.0, 53.0, 54.0, 53.0, 53.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 89.0, 83.0, 81.0, 85.0, 79.0, 80.0, 79.0, 82.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 127.0, 123.0, 127.0, 124.0, 124.0, 124.0, 123.0, 166.0, 131.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 167.0, 163.0, 164.0, 164.0, 163.0, 163.0, 167.0, 161.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 66.0, 62.0, 61.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1496.1, "alertThreshold": 2.0}]} 15:29:41 INFO - Return code: 0 15:29:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:29:42 INFO - # TBPL SUCCESS # 15:29:42 INFO - Running post-action listener: _resource_record_post_action 15:29:42 INFO - [mozharness: 2016-12-20 23:29:42.018591Z] Finished run-tests step (success) 15:29:42 INFO - Running post-run listener: _resource_record_post_run 15:29:42 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 396550144; Read time: 24; Write time: 344836 15:29:42 INFO - TinderboxPrint: CPU usage
13.1% 15:29:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 15:29:42 INFO - TinderboxPrint: I/O write bytes / time
396,550,144 / 344,836 15:29:42 INFO - TinderboxPrint: CPU idle
8,279.0 (86.9%) 15:29:42 INFO - TinderboxPrint: CPU user
1,205.3 (12.6%) 15:29:42 INFO - TinderboxPrint: Swap in / out
0 / 0 15:29:42 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 104366080; Read time: 0; Write time: 95372 15:29:42 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292184064; Read time: 24; Write time: 249464 15:29:42 INFO - Running post-run listener: _upload_blobber_files 15:29:42 INFO - Blob upload gear active. 15:29:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:29:42 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 15:29:42 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:29:42 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:29:43 INFO - (blobuploader) - INFO - Open directory for files ... 15:29:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:29:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:29:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:29:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:29:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:29:43 INFO - (blobuploader) - INFO - Done attempting. 15:29:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:29:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:29:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:29:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:29:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:29:45 INFO - (blobuploader) - INFO - Done attempting. 15:29:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:29:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:29:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:29:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:29:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:29:46 INFO - (blobuploader) - INFO - Done attempting. 15:29:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:29:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:29:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:29:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:29:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:29:49 INFO - (blobuploader) - INFO - Done attempting. 15:29:49 INFO - (blobuploader) - INFO - Iteration through files over. 15:29:49 INFO - Return code: 0 15:29:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:29:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:29:49 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24321884b93e6f7f580ac29112b5a7fc8f7711c463b6ca80d1cb853e28511fb93af8dac8eac287cf673b4183ae6e160790e55e4bbe907fd741a523905f7aeb02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0a270119b51259d551459cf0378e9dd436553c7bfed6bb80ce9cde501842419ba461a1cd7445da377e70a43289d102180b94465332524898e410e15774c14fa", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfb518feb95b67395497fa4a8b65692713dcb84b1c0e562a7602667e195a51c4744e5f3fb4e85a404b288520fac6cef1e365524142b193ae361baf1178f72110", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccb4edd3ac0e5526d2c4d1bcc50e9d35df4eb3252983324d9b567bee5b7298f9344d07382b1136e158e1eca2a9f5603427cd399c4604cfbc35ffcbc8d557cb86"} 15:29:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:29:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:29:49 INFO - Contents: 15:29:49 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24321884b93e6f7f580ac29112b5a7fc8f7711c463b6ca80d1cb853e28511fb93af8dac8eac287cf673b4183ae6e160790e55e4bbe907fd741a523905f7aeb02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0a270119b51259d551459cf0378e9dd436553c7bfed6bb80ce9cde501842419ba461a1cd7445da377e70a43289d102180b94465332524898e410e15774c14fa", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfb518feb95b67395497fa4a8b65692713dcb84b1c0e562a7602667e195a51c4744e5f3fb4e85a404b288520fac6cef1e365524142b193ae361baf1178f72110", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccb4edd3ac0e5526d2c4d1bcc50e9d35df4eb3252983324d9b567bee5b7298f9344d07382b1136e158e1eca2a9f5603427cd399c4604cfbc35ffcbc8d557cb86"} 15:29:49 INFO - Running post-run listener: copy_logs_to_upload_dir 15:29:49 INFO - Copying logs to upload dir... 15:29:49 INFO - mkdir: /builds/slave/test/build/upload/logs 15:29:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.190137 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-12-20 15:29:49.003858) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 15:29:49.007211) ========= 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=c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24321884b93e6f7f580ac29112b5a7fc8f7711c463b6ca80d1cb853e28511fb93af8dac8eac287cf673b4183ae6e160790e55e4bbe907fd741a523905f7aeb02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0a270119b51259d551459cf0378e9dd436553c7bfed6bb80ce9cde501842419ba461a1cd7445da377e70a43289d102180b94465332524898e410e15774c14fa", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfb518feb95b67395497fa4a8b65692713dcb84b1c0e562a7602667e195a51c4744e5f3fb4e85a404b288520fac6cef1e365524142b193ae361baf1178f72110", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccb4edd3ac0e5526d2c4d1bcc50e9d35df4eb3252983324d9b567bee5b7298f9344d07382b1136e158e1eca2a9f5603427cd399c4604cfbc35ffcbc8d557cb86"} build_url:https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011824 build_url: 'https://queue.taskcluster.net/v1/task/YF6xIWCpQZmKw1PMfS2HPw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24321884b93e6f7f580ac29112b5a7fc8f7711c463b6ca80d1cb853e28511fb93af8dac8eac287cf673b4183ae6e160790e55e4bbe907fd741a523905f7aeb02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0a270119b51259d551459cf0378e9dd436553c7bfed6bb80ce9cde501842419ba461a1cd7445da377e70a43289d102180b94465332524898e410e15774c14fa", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfb518feb95b67395497fa4a8b65692713dcb84b1c0e562a7602667e195a51c4744e5f3fb4e85a404b288520fac6cef1e365524142b193ae361baf1178f72110", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccb4edd3ac0e5526d2c4d1bcc50e9d35df4eb3252983324d9b567bee5b7298f9344d07382b1136e158e1eca2a9f5603427cd399c4604cfbc35ffcbc8d557cb86"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 15:29:49.032171) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 15:29:49.032537) ========= 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=c6927cf182745ad25b1d38b9000001fe-1482275348.547031-760579410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 15:29:49.117619) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 15:29:49.117932) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 15:29:49.118212) ========= ========= Total master_lag: 0.18 =========