builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1477824043.67 results: success (0) buildid: 20161030004007 builduid: f425001c9f80471abea687f007cbb938 revision: c683b0d41a52ffab980165b79b9c82590001354b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 03:40:43.673635) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 03:40:43.674083) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 03:40:43.674382) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 03:40:43.689700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 03:40:43.690358) ========= 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=fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-30 03:40:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.1M=0s 2016-10-30 03:40:44 (69.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.170512 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 03:40:43.876207) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 03:40:43.876499) ========= 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=fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018783 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 03:40:43.925726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 03:40:43.926036) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c683b0d41a52ffab980165b79b9c82590001354b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c683b0d41a52ffab980165b79b9c82590001354b --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=fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-30 03:40:44,787 truncating revision to first 12 chars 2016-10-30 03:40:44,787 Setting DEBUG logging. 2016-10-30 03:40:44,787 attempt 1/10 2016-10-30 03:40:44,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c683b0d41a52?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-30 03:40:45,585 unpacking tar archive at: mozilla-aurora-c683b0d41a52/testing/mozharness/ program finished with exit code 0 elapsedTime=1.133994 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 03:40:45.075007) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 03:40:45.075323) ========= script_repo_revision: c683b0d41a52ffab980165b79b9c82590001354b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 03:40:45.075786) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 03:40:45.076173) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 03:40:45.086781) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-30 03:40:45.087100) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:40:46 INFO - MultiFileLogger online at 20161030 03:40:46 in /builds/slave/test 03:40:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:40:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:40:46 INFO - {'append_to_log': False, 03:40:46 INFO - 'base_work_dir': '/builds/slave/test', 03:40:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:40:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:40:46 INFO - 'branch': 'Mozilla-Aurora', 03:40:46 INFO - 'buildbot_json_path': 'buildprops.json', 03:40:46 INFO - 'config_files': ('talos/linux_config.py',), 03:40:46 INFO - 'default_actions': ('clobber', 03:40:46 INFO - 'read-buildbot-config', 03:40:46 INFO - 'download-and-extract', 03:40:46 INFO - 'populate-webroot', 03:40:46 INFO - 'create-virtualenv', 03:40:46 INFO - 'install', 03:40:46 INFO - 'run-tests'), 03:40:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:40:46 INFO - 'download_minidump_stackwalk': True, 03:40:46 INFO - 'download_symbols': 'ondemand', 03:40:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:40:46 INFO - 'tooltool.py': '/tools/tooltool.py', 03:40:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:40:46 INFO - '/tools/misc-python/virtualenv.py')}, 03:40:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:40:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:40:46 INFO - 'installer_path': 'installer.exe', 03:40:46 INFO - 'log_level': 'info', 03:40:46 INFO - 'log_name': 'talos', 03:40:46 INFO - 'log_to_console': True, 03:40:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:40:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:40:46 INFO - 'opt_config_files': (), 03:40:46 INFO - 'pip_index': False, 03:40:46 INFO - 'sps_profile': False, 03:40:46 INFO - 'sps_profile_interval': 0, 03:40:46 INFO - 'suite': 'dromaeojs', 03:40:46 INFO - 'system_bits': '32', 03:40:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:40:46 INFO - 'title': 'talos-linux64-ix-048', 03:40:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:40:46 INFO - 'use_talos_json': True, 03:40:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:40:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:40:46 INFO - 'work_dir': 'build'} 03:40:46 INFO - [mozharness: 2016-10-30 10:40:46.041485Z] Running clobber step. 03:40:46 INFO - Running pre-action listener: _resource_record_pre_action 03:40:46 INFO - Running main action method: clobber 03:40:46 INFO - rmtree: /builds/slave/test/build 03:40:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:40:46 INFO - Running post-action listener: _resource_record_post_action 03:40:46 INFO - [mozharness: 2016-10-30 10:40:46.500637Z] Finished clobber step (success) 03:40:46 INFO - [mozharness: 2016-10-30 10:40:46.500740Z] Running read-buildbot-config step. 03:40:46 INFO - Running pre-action listener: _resource_record_pre_action 03:40:46 INFO - Running main action method: read_buildbot_config 03:40:46 INFO - Using buildbot properties: 03:40:46 INFO - { 03:40:46 INFO - "project": "", 03:40:46 INFO - "product": "firefox", 03:40:46 INFO - "script_repo_revision": "production", 03:40:46 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:40:46 INFO - "repository": "", 03:40:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:40:46 INFO - "buildid": "20161030004007", 03:40:46 INFO - "stage_platform": "linux64-pgo", 03:40:46 INFO - "basedir": "/builds/slave/test", 03:40:46 INFO - "nightly_build": "True", 03:40:46 INFO - "buildnumber": 842, 03:40:46 INFO - "slavename": "talos-linux64-ix-048", 03:40:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:40:46 INFO - "platform": "ubuntu64_hw", 03:40:46 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:40:46 INFO - "branch": "mozilla-aurora", 03:40:46 INFO - "repo_path": "releases/mozilla-aurora", 03:40:46 INFO - "revision": "c683b0d41a52ffab980165b79b9c82590001354b", 03:40:46 INFO - "pgo_build": "True", 03:40:46 INFO - "builduid": "f425001c9f80471abea687f007cbb938", 03:40:46 INFO - "slavebuilddir": "test" 03:40:46 INFO - } 03:40:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 03:40:46 INFO - Running post-action listener: _resource_record_post_action 03:40:46 INFO - [mozharness: 2016-10-30 10:40:46.503284Z] Finished read-buildbot-config step (success) 03:40:46 INFO - [mozharness: 2016-10-30 10:40:46.503373Z] Running download-and-extract step. 03:40:46 INFO - Running pre-action listener: _resource_record_pre_action 03:40:46 INFO - Running main action method: download_and_extract 03:40:46 INFO - mkdir: /builds/slave/test/build/tests 03:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:46 INFO - trying https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:40:46 INFO - Downloading https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:40:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:40:47 INFO - Downloaded 1361 bytes. 03:40:47 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:40:47 INFO - Using the following test package requirements: 03:40:47 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:40:47 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:40:47 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:40:47 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:47 INFO - u'jsshell-linux-x86_64.zip'], 03:40:47 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:40:47 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:40:47 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:40:47 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:40:47 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:40:47 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:40:47 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:40:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:40:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:40:47 INFO - Fetch https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:40:48 INFO - Expected file size: 21895264 03:40:52 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:40:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:40:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:40:52 INFO - Fetch https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:40:53 INFO - Expected file size: 21895264 03:40:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:40:58 INFO - Fetch https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:40:59 INFO - Expected file size: 14414089 03:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:00 INFO - trying https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:41:00 INFO - Downloading https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:41:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:41:02 INFO - Downloaded 63977392 bytes. 03:41:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:41:02 INFO - mkdir: /builds/slave/test/properties 03:41:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:41:02 INFO - Writing to file /builds/slave/test/properties/build_url 03:41:02 INFO - Contents: 03:41:02 INFO - build_url:https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:41:03 INFO - Running post-action listener: _resource_record_post_action 03:41:03 INFO - Running post-action listener: set_extra_try_arguments 03:41:03 INFO - [mozharness: 2016-10-30 10:41:03.305836Z] Finished download-and-extract step (success) 03:41:03 INFO - [mozharness: 2016-10-30 10:41:03.306067Z] Running populate-webroot step. 03:41:03 INFO - Running pre-action listener: _resource_record_pre_action 03:41:03 INFO - Running main action method: populate_webroot 03:41:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:41:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:41:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:41:03 INFO - '--tppagecycles', 03:41:03 INFO - '7'], 03:41:03 INFO - 'tests': ['tsvgm']}}, 03:41:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:41:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:41:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:41:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:41:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:41:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:41:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:03 INFO - 'talos_options': ['--disable-e10s'], 03:41:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:03 INFO - 'talos_options': ['--disable-e10s'], 03:41:03 INFO - 'tests': ['damp', 'tps']}, 03:41:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:03 INFO - 'tests': ['damp', 'tps']}, 03:41:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:41:03 INFO - 'tests': ['dromaeo_dom']}, 03:41:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:41:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:41:03 INFO - 'tests': ['basic_compositor_video']}, 03:41:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:41:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:41:03 INFO - 'tests': ['a11yr', 03:41:03 INFO - 'ts_paint', 03:41:03 INFO - 'tpaint', 03:41:03 INFO - 'sessionrestore', 03:41:03 INFO - 'sessionrestore_no_auto_restore', 03:41:03 INFO - 'tabpaint']}, 03:41:03 INFO - 'other-e10s': {'tests': ['a11yr', 03:41:03 INFO - 'ts_paint', 03:41:03 INFO - 'tpaint', 03:41:03 INFO - 'sessionrestore', 03:41:03 INFO - 'sessionrestore_no_auto_restore', 03:41:03 INFO - 'tabpaint']}, 03:41:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:41:03 INFO - 'ts_paint', 03:41:03 INFO - 'tpaint', 03:41:03 INFO - 'sessionrestore', 03:41:03 INFO - 'sessionrestore_no_auto_restore', 03:41:03 INFO - 'tabpaint']}, 03:41:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:41:03 INFO - 'ts_paint', 03:41:03 INFO - 'tpaint', 03:41:03 INFO - 'sessionrestore', 03:41:03 INFO - 'sessionrestore_no_auto_restore', 03:41:03 INFO - 'tabpaint']}, 03:41:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:41:03 INFO - 'tests': ['a11yr', 03:41:03 INFO - 'ts_paint', 03:41:03 INFO - 'tpaint', 03:41:03 INFO - 'sessionrestore', 03:41:03 INFO - 'sessionrestore_no_auto_restore', 03:41:03 INFO - 'tabpaint']}, 03:41:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:41:03 INFO - 'tests': ['a11yr', 03:41:03 INFO - 'ts_paint', 03:41:03 INFO - 'tpaint', 03:41:03 INFO - 'sessionrestore', 03:41:03 INFO - 'sessionrestore_no_auto_restore', 03:41:03 INFO - 'tabpaint']}, 03:41:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:41:03 INFO - 'tests': ['tsvgx', 03:41:03 INFO - 'tsvgr_opacity', 03:41:03 INFO - 'tart', 03:41:03 INFO - 'tscrollx', 03:41:03 INFO - 'cart']}, 03:41:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:41:03 INFO - 'tsvgr_opacity', 03:41:03 INFO - 'tart', 03:41:03 INFO - 'tscrollx', 03:41:03 INFO - 'cart']}, 03:41:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:03 INFO - 'talos_options': ['--disable-e10s'], 03:41:03 INFO - 'tests': ['tp5o']}, 03:41:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:03 INFO - 'tests': ['tp5o']}, 03:41:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:03 INFO - 'talos_options': ['--disable-e10s', 03:41:03 INFO - '--xperf_path', 03:41:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:03 INFO - 'tests': ['tp5n']}, 03:41:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:03 INFO - 'talos_options': ['--xperf_path', 03:41:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:03 INFO - 'tests': ['tp5n']}}, 03:41:03 INFO - 'talos.zip': {'path': '', 03:41:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:41:03 INFO - Running post-action listener: _resource_record_post_action 03:41:03 INFO - [mozharness: 2016-10-30 10:41:03.328386Z] Finished populate-webroot step (success) 03:41:03 INFO - [mozharness: 2016-10-30 10:41:03.328475Z] Running create-virtualenv step. 03:41:03 INFO - Running pre-action listener: _resource_record_pre_action 03:41:03 INFO - Running main action method: create_virtualenv 03:41:03 INFO - Creating virtualenv /builds/slave/test/build/venv 03:41:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:41:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:41:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:41:03 INFO - Using real prefix '/usr' 03:41:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:41:03 INFO - Installing distribute.............................................................................................................................................................................................done. 03:41:05 INFO - Installing pip.................done. 03:41:05 INFO - Return code: 0 03:41:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:41: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')]} 03:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41: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')]} 03:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:05 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 0x7f093a2e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55f60>, '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 0x1c56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c571d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:41:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:41:05 INFO - Using env: {'DISPLAY': ':0', 03:41:05 INFO - 'HOME': '/home/cltbld', 03:41:05 INFO - 'LANG': 'en_US.UTF-8', 03:41:05 INFO - 'LANGUAGE': 'en_US:en', 03:41:05 INFO - 'LOGNAME': 'cltbld', 03:41:05 INFO - 'MAIL': '/var/mail/cltbld', 03:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:05 INFO - 'MOZ_NO_REMOTE': '1', 03:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:05 INFO - 'NO_EM_RESTART': '1', 03:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:05 INFO - 'PWD': '/builds/slave/test', 03:41:05 INFO - 'SHELL': '/bin/bash', 03:41:05 INFO - 'SHLVL': '1', 03:41:05 INFO - 'TERM': 'linux', 03:41:05 INFO - 'TMOUT': '86400', 03:41:05 INFO - 'USER': 'cltbld', 03:41:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 03:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:05 INFO - '_': '/tools/buildbot/bin/python'} 03:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:41:06 INFO - Cleaning up... 03:41:06 INFO - Return code: 0 03:41:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:06 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 0x7f093a2e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55f60>, '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 0x1c56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c571d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:41:06 INFO - Using env: {'DISPLAY': ':0', 03:41:06 INFO - 'HOME': '/home/cltbld', 03:41:06 INFO - 'LANG': 'en_US.UTF-8', 03:41:06 INFO - 'LANGUAGE': 'en_US:en', 03:41:06 INFO - 'LOGNAME': 'cltbld', 03:41:06 INFO - 'MAIL': '/var/mail/cltbld', 03:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:06 INFO - 'MOZ_NO_REMOTE': '1', 03:41:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:06 INFO - 'NO_EM_RESTART': '1', 03:41:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:06 INFO - 'PWD': '/builds/slave/test', 03:41:06 INFO - 'SHELL': '/bin/bash', 03:41:06 INFO - 'SHLVL': '1', 03:41:06 INFO - 'TERM': 'linux', 03:41:06 INFO - 'TMOUT': '86400', 03:41:06 INFO - 'USER': 'cltbld', 03:41:06 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 03:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:06 INFO - '_': '/tools/buildbot/bin/python'} 03:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:06 INFO - Downloading/unpacking psutil>=3.1.1 03:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:41:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:08 INFO - Installing collected packages: psutil 03:41:08 INFO - Running setup.py install for psutil 03:41:08 INFO - building 'psutil._psutil_linux' extension 03:41:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:41:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:41:08 INFO - building 'psutil._psutil_posix' extension 03:41:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:41:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:41:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:08 INFO - Successfully installed psutil 03:41:08 INFO - Cleaning up... 03:41:08 INFO - Return code: 0 03:41:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:08 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 0x7f093a2e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55f60>, '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 0x1c56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c571d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:41:08 INFO - Using env: {'DISPLAY': ':0', 03:41:08 INFO - 'HOME': '/home/cltbld', 03:41:08 INFO - 'LANG': 'en_US.UTF-8', 03:41:08 INFO - 'LANGUAGE': 'en_US:en', 03:41:08 INFO - 'LOGNAME': 'cltbld', 03:41:08 INFO - 'MAIL': '/var/mail/cltbld', 03:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:08 INFO - 'MOZ_NO_REMOTE': '1', 03:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:08 INFO - 'NO_EM_RESTART': '1', 03:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:08 INFO - 'PWD': '/builds/slave/test', 03:41:08 INFO - 'SHELL': '/bin/bash', 03:41:08 INFO - 'SHLVL': '1', 03:41:08 INFO - 'TERM': 'linux', 03:41:08 INFO - 'TMOUT': '86400', 03:41:08 INFO - 'USER': 'cltbld', 03:41:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 03:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:08 INFO - '_': '/tools/buildbot/bin/python'} 03:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:41:11 INFO - Installing collected packages: mozsystemmonitor 03:41:11 INFO - Running setup.py install for mozsystemmonitor 03:41:11 INFO - Successfully installed mozsystemmonitor 03:41:11 INFO - Cleaning up... 03:41:11 INFO - Return code: 0 03:41:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:11 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 0x7f093a2e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55f60>, '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 0x1c56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c571d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:41:11 INFO - Using env: {'DISPLAY': ':0', 03:41:11 INFO - 'HOME': '/home/cltbld', 03:41:11 INFO - 'LANG': 'en_US.UTF-8', 03:41:11 INFO - 'LANGUAGE': 'en_US:en', 03:41:11 INFO - 'LOGNAME': 'cltbld', 03:41:11 INFO - 'MAIL': '/var/mail/cltbld', 03:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:11 INFO - 'MOZ_NO_REMOTE': '1', 03:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:11 INFO - 'NO_EM_RESTART': '1', 03:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:11 INFO - 'PWD': '/builds/slave/test', 03:41:11 INFO - 'SHELL': '/bin/bash', 03:41:11 INFO - 'SHLVL': '1', 03:41:11 INFO - 'TERM': 'linux', 03:41:11 INFO - 'TMOUT': '86400', 03:41:11 INFO - 'USER': 'cltbld', 03:41:11 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 03:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:11 INFO - '_': '/tools/buildbot/bin/python'} 03:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:11 INFO - Downloading/unpacking jsonschema==2.5.1 03:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:41:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:13 INFO - Downloading functools32-3.2.3-2.tar.gz 03:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:41:13 INFO - warning: no files found matching '*.txt' 03:41:13 INFO - no previously-included directories found matching 'build' 03:41:13 INFO - no previously-included directories found matching 'dist' 03:41:13 INFO - no previously-included directories found matching '.git*' 03:41:13 INFO - Installing collected packages: jsonschema, functools32 03:41:13 INFO - Running setup.py install for functools32 03:41:13 INFO - warning: no files found matching '*.txt' 03:41:13 INFO - no previously-included directories found matching 'build' 03:41:13 INFO - no previously-included directories found matching 'dist' 03:41:13 INFO - no previously-included directories found matching '.git*' 03:41:13 INFO - Successfully installed jsonschema functools32 03:41:13 INFO - Cleaning up... 03:41:13 INFO - Return code: 0 03:41:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:13 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 0x7f093a2e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55f60>, '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 0x1c56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c571d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:41:13 INFO - Using env: {'DISPLAY': ':0', 03:41:13 INFO - 'HOME': '/home/cltbld', 03:41:13 INFO - 'LANG': 'en_US.UTF-8', 03:41:13 INFO - 'LANGUAGE': 'en_US:en', 03:41:13 INFO - 'LOGNAME': 'cltbld', 03:41:13 INFO - 'MAIL': '/var/mail/cltbld', 03:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:13 INFO - 'MOZ_NO_REMOTE': '1', 03:41:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:13 INFO - 'NO_EM_RESTART': '1', 03:41:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:13 INFO - 'PWD': '/builds/slave/test', 03:41:13 INFO - 'SHELL': '/bin/bash', 03:41:13 INFO - 'SHLVL': '1', 03:41:13 INFO - 'TERM': 'linux', 03:41:13 INFO - 'TMOUT': '86400', 03:41:13 INFO - 'USER': 'cltbld', 03:41:13 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 03:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:13 INFO - '_': '/tools/buildbot/bin/python'} 03:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:41:14 INFO - Cleaning up... 03:41:14 INFO - Return code: 0 03:41:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:14 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 0x7f093a2e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55f60>, '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 0x1c56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c571d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:41:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:41:14 INFO - Using env: {'DISPLAY': ':0', 03:41:14 INFO - 'HOME': '/home/cltbld', 03:41:14 INFO - 'LANG': 'en_US.UTF-8', 03:41:14 INFO - 'LANGUAGE': 'en_US:en', 03:41:14 INFO - 'LOGNAME': 'cltbld', 03:41:14 INFO - 'MAIL': '/var/mail/cltbld', 03:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:14 INFO - 'MOZ_NO_REMOTE': '1', 03:41:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:14 INFO - 'NO_EM_RESTART': '1', 03:41:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:14 INFO - 'PWD': '/builds/slave/test', 03:41:14 INFO - 'SHELL': '/bin/bash', 03:41:14 INFO - 'SHLVL': '1', 03:41:14 INFO - 'TERM': 'linux', 03:41:14 INFO - 'TMOUT': '86400', 03:41:14 INFO - 'USER': 'cltbld', 03:41:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 03:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:14 INFO - '_': '/tools/buildbot/bin/python'} 03:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:14 INFO - Downloading/unpacking blobuploader==1.2.4 03:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:16 INFO - Downloading blobuploader-1.2.4.tar.gz 03:41:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:41:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:41:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:16 INFO - Downloading docopt-0.6.1.tar.gz 03:41:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:41:17 INFO - Installing collected packages: blobuploader, requests, docopt 03:41:17 INFO - Running setup.py install for blobuploader 03:41:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:41:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:41:17 INFO - Running setup.py install for requests 03:41:17 INFO - Running setup.py install for docopt 03:41:17 INFO - Successfully installed blobuploader requests docopt 03:41:17 INFO - Cleaning up... 03:41:17 INFO - Return code: 0 03:41:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:17 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 0x7f093a2e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55f60>, '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 0x1c56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c571d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:17 INFO - Using env: {'DISPLAY': ':0', 03:41:17 INFO - 'HOME': '/home/cltbld', 03:41:17 INFO - 'LANG': 'en_US.UTF-8', 03:41:17 INFO - 'LANGUAGE': 'en_US:en', 03:41:17 INFO - 'LOGNAME': 'cltbld', 03:41:17 INFO - 'MAIL': '/var/mail/cltbld', 03:41:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:17 INFO - 'MOZ_NO_REMOTE': '1', 03:41:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:17 INFO - 'NO_EM_RESTART': '1', 03:41:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:17 INFO - 'PWD': '/builds/slave/test', 03:41:17 INFO - 'SHELL': '/bin/bash', 03:41:17 INFO - 'SHLVL': '1', 03:41:17 INFO - 'TERM': 'linux', 03:41:17 INFO - 'TMOUT': '86400', 03:41:17 INFO - 'USER': 'cltbld', 03:41:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 03:41:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:17 INFO - '_': '/tools/buildbot/bin/python'} 03:41:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:17 INFO - Running setup.py (path:/tmp/pip-C6VJJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:17 INFO - Running setup.py (path:/tmp/pip-gCjUCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:18 INFO - Running setup.py (path:/tmp/pip-OQT3kD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:18 INFO - Running setup.py (path:/tmp/pip-GbJHji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:18 INFO - Running setup.py (path:/tmp/pip-Qm_QaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:18 INFO - Running setup.py (path:/tmp/pip-QOYxT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:18 INFO - Running setup.py (path:/tmp/pip-phIKSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:18 INFO - Running setup.py (path:/tmp/pip-M7pH6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:18 INFO - Running setup.py (path:/tmp/pip-txNwOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:18 INFO - Running setup.py (path:/tmp/pip-ikDzPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:18 INFO - Running setup.py (path:/tmp/pip-aA6ICB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:18 INFO - Running setup.py (path:/tmp/pip-h7vNWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:18 INFO - Running setup.py (path:/tmp/pip-ziFspp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:18 INFO - Running setup.py (path:/tmp/pip-5J0Sqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:18 INFO - Running setup.py (path:/tmp/pip-I4qOv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:18 INFO - Running setup.py (path:/tmp/pip-lqCKwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:19 INFO - Running setup.py (path:/tmp/pip-fvmliC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:41:19 INFO - Running setup.py install for manifestparser 03:41:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:41:19 INFO - Running setup.py install for mozcrash 03:41:19 INFO - Running setup.py install for mozdebug 03:41:19 INFO - Running setup.py install for mozdevice 03:41:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:41:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:41:19 INFO - Running setup.py install for mozfile 03:41:19 INFO - Running setup.py install for mozhttpd 03:41:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:41:19 INFO - Running setup.py install for mozinfo 03:41:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:41:19 INFO - Running setup.py install for mozInstall 03:41:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:41:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:41:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:41:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:41:19 INFO - Running setup.py install for mozleak 03:41:19 INFO - Running setup.py install for mozlog 03:41:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:41:20 INFO - Running setup.py install for moznetwork 03:41:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:41:20 INFO - Running setup.py install for mozprocess 03:41:20 INFO - Running setup.py install for mozprofile 03:41:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:41:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:41:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:41:20 INFO - Running setup.py install for mozrunner 03:41:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:41:20 INFO - Running setup.py install for mozscreenshot 03:41:20 INFO - Running setup.py install for moztest 03:41:20 INFO - Running setup.py install for mozversion 03:41:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:41:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:41:20 INFO - Cleaning up... 03:41:20 INFO - Return code: 0 03:41:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:20 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 0x7f093a2e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55f60>, '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 0x1c56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c571d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:20 INFO - Using env: {'DISPLAY': ':0', 03:41:20 INFO - 'HOME': '/home/cltbld', 03:41:20 INFO - 'LANG': 'en_US.UTF-8', 03:41:20 INFO - 'LANGUAGE': 'en_US:en', 03:41:20 INFO - 'LOGNAME': 'cltbld', 03:41:20 INFO - 'MAIL': '/var/mail/cltbld', 03:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:20 INFO - 'MOZ_NO_REMOTE': '1', 03:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:20 INFO - 'NO_EM_RESTART': '1', 03:41:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:20 INFO - 'PWD': '/builds/slave/test', 03:41:20 INFO - 'SHELL': '/bin/bash', 03:41:20 INFO - 'SHLVL': '1', 03:41:20 INFO - 'TERM': 'linux', 03:41:20 INFO - 'TMOUT': '86400', 03:41:20 INFO - 'USER': 'cltbld', 03:41:20 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 03:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:20 INFO - '_': '/tools/buildbot/bin/python'} 03:41:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:21 INFO - Running setup.py (path:/tmp/pip-xYnwXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:21 INFO - Running setup.py (path:/tmp/pip-5CI5lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:21 INFO - Running setup.py (path:/tmp/pip-9g4axS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:21 INFO - Running setup.py (path:/tmp/pip-Hec_gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:21 INFO - Running setup.py (path:/tmp/pip-bnM_Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:21 INFO - Running setup.py (path:/tmp/pip-HZkZxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:21 INFO - Running setup.py (path:/tmp/pip-YshEaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:21 INFO - Running setup.py (path:/tmp/pip-gi2cqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:21 INFO - Running setup.py (path:/tmp/pip-fKouWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:21 INFO - Running setup.py (path:/tmp/pip-6UPt3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:21 INFO - Running setup.py (path:/tmp/pip-Hg3AjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:21 INFO - Running setup.py (path:/tmp/pip-HBsP52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:21 INFO - Running setup.py (path:/tmp/pip-Np6Y11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:22 INFO - Running setup.py (path:/tmp/pip-uW9pec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:22 INFO - Running setup.py (path:/tmp/pip-KpBn8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:22 INFO - Running setup.py (path:/tmp/pip-VE1hJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:22 INFO - Running setup.py (path:/tmp/pip-rlV0Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:24 INFO - Downloading blessings-1.6.tar.gz 03:41:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:41:24 INFO - Installing collected packages: blessings 03:41:24 INFO - Running setup.py install for blessings 03:41:24 INFO - Successfully installed blessings 03:41:24 INFO - Cleaning up... 03:41:24 INFO - Return code: 0 03:41:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:41:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:24 INFO - Reading from file tmpfile_stdout 03:41:24 INFO - Current package versions: 03:41:24 INFO - argparse == 1.2.1 03:41:24 INFO - blessings == 1.6 03:41:24 INFO - blobuploader == 1.2.4 03:41:24 INFO - docopt == 0.6.1 03:41:24 INFO - functools32 == 3.2.3-2 03:41:24 INFO - jsonschema == 2.5.1 03:41:24 INFO - manifestparser == 1.1 03:41:24 INFO - mozInstall == 1.12 03:41:24 INFO - mozcrash == 0.17 03:41:24 INFO - mozdebug == 0.1 03:41:24 INFO - mozdevice == 0.48 03:41:24 INFO - mozfile == 1.2 03:41:24 INFO - mozhttpd == 0.7 03:41:24 INFO - mozinfo == 0.9 03:41:24 INFO - mozleak == 0.1 03:41:24 INFO - mozlog == 3.4 03:41:24 INFO - moznetwork == 0.27 03:41:24 INFO - mozprocess == 0.23 03:41:24 INFO - mozprofile == 0.28 03:41:24 INFO - mozrunner == 6.12 03:41:24 INFO - mozscreenshot == 0.1 03:41:24 INFO - mozsystemmonitor == 0.3 03:41:24 INFO - moztest == 0.7 03:41:24 INFO - mozversion == 1.4 03:41:24 INFO - psutil == 3.1.1 03:41:24 INFO - requests == 1.2.3 03:41:24 INFO - wsgiref == 0.1.2 03:41:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:24 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 0x7f093a2e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55f60>, '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 0x1c56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c571d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:41:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:24 INFO - Using env: {'DISPLAY': ':0', 03:41:24 INFO - 'HOME': '/home/cltbld', 03:41:24 INFO - 'LANG': 'en_US.UTF-8', 03:41:24 INFO - 'LANGUAGE': 'en_US:en', 03:41:24 INFO - 'LOGNAME': 'cltbld', 03:41:24 INFO - 'MAIL': '/var/mail/cltbld', 03:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:24 INFO - 'MOZ_NO_REMOTE': '1', 03:41:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:24 INFO - 'NO_EM_RESTART': '1', 03:41:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:24 INFO - 'PWD': '/builds/slave/test', 03:41:24 INFO - 'SHELL': '/bin/bash', 03:41:24 INFO - 'SHLVL': '1', 03:41:24 INFO - 'TERM': 'linux', 03:41:24 INFO - 'TMOUT': '86400', 03:41:24 INFO - 'USER': 'cltbld', 03:41:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 03:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:24 INFO - '_': '/tools/buildbot/bin/python'} 03:41:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:41:25 INFO - Cleaning up... 03:41:25 INFO - Return code: 0 03:41:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:25 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 0x7f093a2e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c58ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c55f60>, '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 0x1c56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c571d0>, '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': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:41:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:41:25 INFO - Using env: {'DISPLAY': ':0', 03:41:25 INFO - 'HOME': '/home/cltbld', 03:41:25 INFO - 'LANG': 'en_US.UTF-8', 03:41:25 INFO - 'LANGUAGE': 'en_US:en', 03:41:25 INFO - 'LOGNAME': 'cltbld', 03:41:25 INFO - 'MAIL': '/var/mail/cltbld', 03:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:25 INFO - 'MOZ_NO_REMOTE': '1', 03:41:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:25 INFO - 'NO_EM_RESTART': '1', 03:41:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:25 INFO - 'PWD': '/builds/slave/test', 03:41:25 INFO - 'SHELL': '/bin/bash', 03:41:25 INFO - 'SHLVL': '1', 03:41:25 INFO - 'TERM': 'linux', 03:41:25 INFO - 'TMOUT': '86400', 03:41:25 INFO - 'USER': 'cltbld', 03:41:25 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 03:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:25 INFO - '_': '/tools/buildbot/bin/python'} 03:41:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:41:25 INFO - Cleaning up... 03:41:25 INFO - Return code: 0 03:41:25 INFO - Running post-action listener: _resource_record_post_action 03:41:25 INFO - Running post-action listener: _start_resource_monitoring 03:41:25 INFO - Starting resource monitoring. 03:41:25 INFO - [mozharness: 2016-10-30 10:41:25.295609Z] Finished create-virtualenv step (success) 03:41:25 INFO - [mozharness: 2016-10-30 10:41:25.296054Z] Running install step. 03:41:25 INFO - Running pre-action listener: _resource_record_pre_action 03:41:25 INFO - Running main action method: install 03:41:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:25 INFO - Reading from file tmpfile_stdout 03:41:25 INFO - Detecting whether we're running mozinstall >=1.0... 03:41:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:41:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:41:25 INFO - Reading from file tmpfile_stdout 03:41:25 INFO - Output received: 03:41:25 INFO - Usage: mozinstall [options] installer 03:41:25 INFO - Options: 03:41:25 INFO - -h, --help show this help message and exit 03:41:25 INFO - -d DEST, --destination=DEST 03:41:25 INFO - Directory to install application into. [default: 03:41:25 INFO - "/builds/slave/test"] 03:41:25 INFO - --app=APP Application being installed. [default: firefox] 03:41:25 INFO - mkdir: /builds/slave/test/build/application 03:41:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:41:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:41:41 INFO - Reading from file tmpfile_stdout 03:41:41 INFO - Output received: 03:41:41 INFO - /builds/slave/test/build/application/firefox/firefox 03:41:41 INFO - Running post-action listener: _resource_record_post_action 03:41:41 INFO - [mozharness: 2016-10-30 10:41:41.545272Z] Finished install step (success) 03:41:41 INFO - [mozharness: 2016-10-30 10:41:41.545519Z] Running run-tests step. 03:41:41 INFO - Running pre-action listener: _resource_record_pre_action 03:41:41 INFO - Running main action method: run_tests 03:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:41:41 INFO - Python 2.7.3 03:41:41 INFO - Return code: 0 03:41:41 INFO - grabbing minidump binary from tooltool 03:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:41:41 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 0x1c55f60>, '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 0x1c56d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c571d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:41:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:41:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:41:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:41:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:41:41 INFO - Return code: 0 03:41:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:41:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:41:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:41:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:41:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:41:41 INFO - Using env: {'DISPLAY': ':0', 03:41:41 INFO - 'HOME': '/home/cltbld', 03:41:41 INFO - 'LANG': 'en_US.UTF-8', 03:41:41 INFO - 'LANGUAGE': 'en_US:en', 03:41:41 INFO - 'LOGNAME': 'cltbld', 03:41:41 INFO - 'MAIL': '/var/mail/cltbld', 03:41:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:41:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:41 INFO - 'MOZ_NO_REMOTE': '1', 03:41:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:41 INFO - 'NO_EM_RESTART': '1', 03:41:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:41 INFO - 'PWD': '/builds/slave/test', 03:41:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:41:41 INFO - 'SHELL': '/bin/bash', 03:41:41 INFO - 'SHLVL': '1', 03:41:41 INFO - 'TERM': 'linux', 03:41:41 INFO - 'TMOUT': '86400', 03:41:41 INFO - 'USER': 'cltbld', 03:41:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772', 03:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:41 INFO - '_': '/tools/buildbot/bin/python'} 03:41:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:41:41 INFO - mozversion application_buildid: 20161030004007 03:41:41 INFO - mozversion application_changeset: c683b0d41a52ffab980165b79b9c82590001354b 03:41:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:41:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:41:41 INFO - mozversion application_name: Firefox 03:41:41 INFO - mozversion application_remotingname: firefox-dev 03:41:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:41 INFO - mozversion application_vendor: Mozilla 03:41:41 INFO - mozversion application_version: 51.0a2 03:41:41 INFO - mozversion platform_buildid: 20161030004007 03:41:41 INFO - mozversion platform_changeset: c683b0d41a52ffab980165b79b9c82590001354b 03:41:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:41 INFO - mozversion platform_version: 51.0a2 03:41:41 INFO - using testdate: 1477824101 03:41:41 INFO - actual date: 1477824101 03:41:41 INFO - starting webserver on 'localhost:52785' 03:41:41 INFO - SUITE-START | Running 2 tests 03:41:41 INFO - TEST-START | dromaeo_css 03:41:41 INFO - operating with platform_type : linux_ 03:41:41 INFO - Initialising browser for dromaeo_css test... 03:41:41 INFO - TEST-INFO | started process 18895 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg2f3_v/profile http://localhost:52785/getInfo.html) 03:41:46 INFO - PROCESS | 18895 | __metrics Screen width/height:1600/1200 03:41:46 INFO - PROCESS | 18895 | colorDepth:24 03:41:46 INFO - PROCESS | 18895 | Browser inner width/height: 1024/697 03:41:46 INFO - PROCESS | 18895 | __metrics 03:41:46 INFO - PROCESS | 18895 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:41:46 INFO - PROCESS | 18895 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:41:47 INFO - PROCESS | 18895 | console.error: PushService: 03:41:47 INFO - PROCESS | 18895 | stateChangeProcessEnqueue: Error transitioning state 03:41:47 INFO - PROCESS | 18895 | UnknownError 03:41:47 INFO - TEST-INFO | 18895: exit 0 03:41:47 INFO - Browser initialized. 03:41:47 INFO - Running cycle 1/1 for dromaeo_css test... 03:41:47 INFO - TEST-INFO | started process 18986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg2f3_v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:59 INFO - PROCESS | 18986 | RSS: Main: 145137664 03:41:59 INFO - PROCESS | 18986 | 03:42:50 INFO - PROCESS | 18986 | 1477824170940 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:45:00 INFO - PROCESS | 18986 | Cycle 1(1): loaded http://localhost:52785/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52785/tests/dromaeo/cssquery-ext.html) 03:45:01 INFO - PROCESS | 18986 | RSS: Main: 249856000 03:45:01 INFO - PROCESS | 18986 | 03:48:03 INFO - PROCESS | 18986 | Cycle 1(1): loaded http://localhost:52785/tests/dromaeo/cssquery-ext.html (next: http://localhost:52785/tests/dromaeo/cssquery-jquery.html) 03:48:04 INFO - PROCESS | 18986 | RSS: Main: 230772736 03:48:04 INFO - PROCESS | 18986 | 03:51:06 INFO - PROCESS | 18986 | Cycle 1(1): loaded http://localhost:52785/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52785/tests/dromaeo/cssquery-mootools.html) 03:51:06 INFO - PROCESS | 18986 | RSS: Main: 206909440 03:51:06 INFO - PROCESS | 18986 | 03:54:08 INFO - PROCESS | 18986 | Cycle 1(1): loaded http://localhost:52785/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52785/tests/dromaeo/cssquery-prototype.html) 03:54:09 INFO - PROCESS | 18986 | RSS: Main: 174555136 03:54:09 INFO - PROCESS | 18986 | 03:57:11 INFO - PROCESS | 18986 | Cycle 1(1): loaded http://localhost:52785/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52785/tests/dromaeo/cssquery-yui.html) 03:57:12 INFO - PROCESS | 18986 | RSS: Main: 177111040 03:57:12 INFO - PROCESS | 18986 | 04:00:15 INFO - PROCESS | 18986 | Cycle 1(1): loaded http://localhost:52785/tests/dromaeo/cssquery-yui.html (next: http://localhost:52785/tests/dromaeo/cssquery-dojo.html) 04:00:15 INFO - PROCESS | 18986 | RSS: Main: 266461184 04:00:15 INFO - PROCESS | 18986 | 04:00:15 INFO - PROCESS | 18986 | __start_tp_report 04:00:15 INFO - PROCESS | 18986 | _x_x_mozilla_page_load 04:00:15 INFO - PROCESS | 18986 | _x_x_mozilla_page_load_details 04:00:15 INFO - PROCESS | 18986 | |i|pagename|runs| 04:00:15 INFO - PROCESS | 18986 | |0;dojo.html;3147.3075923296874;3191.6489186189515;3196.504541796021;3208.6149662040557;3231.660675629059;5605.355384130826;5700.629459085157;5708.800191993281;5709.514691251244;5756.079027355619;5619.7471113799875;5667.263255776754;5682.573806964484;5687.061634830258;5731.14032895066;5092.465291144441;5117.7185254810975;5132.281480592701;5155.046316431453;5204.505571970657;5094.694318340893;5213.556847667934;5215.1655735082395;5218;5236.502532259448;5078.7968481260705;5091.516305950929;5127.5128862758165;5170.431252562215;5196;5161;5180.4042535108565;5234.81678141267;5244.187150991603;5270.472952704698;5016.297718319438;5066.898662026776;5134.255532947702;5200.401953775327;5217.773823151556;5523.751431185607;5526.917096243519;5567;5580.553555715574;5591.329040515124;5999.220101386835;6000.489958353545;6113.602615829956;6115.48018418435;6122.387761223887;5979.043353063533;6139.815805525842;6146.508279337642;6159.168512250833;6161.599496032788;5627.409122042168;5669.744861481202;5695.373508913975;5720.313562372458;5744;6310.432061114522;6330.113784070234;6340.334264902119;6342.619442833445;6343.429091381798;5841.094630332305;6054.424829641177;6074.847607171736;6077.544184186204;6097.451229389376;5979.222701048923;5994.460498555151;6045.697715114226;6068.544859135494;6120.660465672121;6061.363556826558;6061.484773794189;6070.726817293233;6099.359567245376;6114.2357205349335;6024.608400453956;6072.7570897164505;6085.148079268906;6086.878262434727;6089.086637004485;4566.246569316092;4599.494055653875;4629.814807407666;4659.254519276899;4662.440507139165;4158.563350848178;4162.167566486714;4168.312228482328;4168.937465938014;4190.308599081118;5665.858353541194;5666.320041595035;5684.6589204647025;5686.5735069869925;5690.089585666274;5926.111083337448;5985.281766188085;5986.401359864066;6061;6164.383561643889;5731;5736.483716465538;5740.6268592541355;5762.164486149569;5767.711614419262;5265.236540701577;5267.051930652519;5280.762365693477;5280.788768449296;5281.735913204325;6117.755289788359;6149.938500615115;6166.784162554379;6300.810975670737;6351.936480635227;5980.252468441445;6053.303870055;6054.576179667381;6090.908636370546;6093;6252.874942501216;6272.059191121186;6285.811425657238;6286.245650521967;6293.779717709858;5829.067349224104;5844.795432159854;5949.613275137102;5950.732217050329;5985.6408615483215;5909.468147866713;5909.497692696169;5963.4334738199805;6017.428344307284;6044.879102417839;5804.593678442468;5845.09401042822;5849.151872978309;5852;5854.121881717776;5756.079027355603;5852.209951656472;5854.326752423526;5861.9413805861395;5865.032269675456;5837.503812176013;5840.415958404125;5844.386339434468;5889.352171261072;5981.401859813984;5975.970120149545;5976.880462390641;5977.910331344946;5979.5814292999075;5982.850428739316;5714.771409143587;5753.827385178452;5834.883302333845;5844.181814546052;5846.912296315644 04:00:15 INFO - PROCESS | 18986 | |1;ext.html;565.6719102920307;586.797554843579;615.7198474694014;618.4032408725581;644.2591020326621;34669.47995780065;45625.77187114064;47293.76353118238;47470.762646186806;47495.287570686465;48289;48651.27023094647;48799;48841.755791220996;48857;8449.112843151473;9348.672796452109;9488.288378371615;9508.239340852715;9508.572114254841;8384.916150838506;10985.780284394308;11224.943875280613;11249.943750281238;11657.766844663143;11382.430878456085;11444.828327575051;11456.599019034335;11459.140564457657;11462.541498340057;8549.187827156411;8775.561221938942;11175.664730058112;11254.94372528132;11259.155563332783;8479.194476524783;8542.359323050796;10750.892491075067;11098.223124381297;11105.222634415593;46526;46752;46854.531454685355;46897.29654055192;46926.76536617329;3561.216532362876;3584.8028358440274;3708.9443658345144;3911.1395492991496;4025.1144748155357;32557.348853023042;33599.49600755991;33865.6613433865;33893.49159762605;34401.6559834401;4375.781210939472;4380.802863871133;4429.468463784334;4466.151431228089;4510.165619360396;368277;369065;370219;370636;371061.9999999973;64422;64787.35212647813;65082.67458662677;65093.349066509676;65133;60524.39475605276;60685.69657151686;60753.39246607477;60773.696131519944;60941.39058609357;18765.812341876408;19474.415767526996;19506.609867802847;19509.512262193275;19548.315808946903;13473.393697283645;13810;13831.930840345734;13899.583012509642;14269.78595321071;18247.361342352953;18421.53946151357;18567.72148417775;18583.90708046478;18657.253709851455;6768.849295619756;7075.433965282765;7109.249883120646;7114.324139206767;7187.101612298463;908.5411867007119;998.8601595776597;1029.8867124616286;1031.4636389077637;1064.9254552181274;33186.3362732744;33686.66313336884;33709.83145084259;33993.83003084969;34046.65953340485;1072.7639919217759;1080.189857606795;1084.1868598551087;1116.0625074937093;1118.4016551145098;16876.409325673543;17997.268004745958;19217;19379.903100484407;19561.706574401396;569512;573915;575878;576066;576300;63415.365846340945;63587;63743.68128159329;63991.36008639947;64035.67982160152;1273.4587800184884;1333.6332508560029;1356.7422189783908;1401.5655146904492;1422.7083447893158;30234.84882575573;34212.82893585516;35003.299934000665;35057.8247108773;35144.297114058085;53174;53720.731396342766;53847.46152538424;53856.46143538514;53948.73025634847;412906;418094;418764;419288;421234;30401.23996900095;31691;31824.772265941163;32819.17952051122;32827.34345313033;49774.25338619996;50176.749116254185;50282.497175027784;51274;51306;42096.789516052224;42201.78899105485;42299.1540169201;42530.5746942539;44130.11739765122;41616.1676766469;42375.3643695351;42720;42930.57069429391;44166.558334416244;42116.78941605395;42606.5739342615;43744.78127609342;43908.560914390444;43970;34757.826210868785;37273.70389527795;37295.6270437303;37914;38074.80962595169;28854;29368;29776.10671679853;29832;29849.70150298556 04:00:15 INFO - PROCESS | 18986 | |2;jquery.html;384.7245132032644;438.6797637724461;445.1297712971141;445.13643531548814;452.8845144488155;18559.164837582306;19945.30191443298;21079.367618971417;21178.89410552949;21242.36272911811;14136.929315353409;16513.00921944684;19759.70360444591;20233.898830505826;20353.49116272094;5599.80400685975;5837.211976383176;5837.270341207349;5843;5844.327902291248;5032.798688052473;6181.134641150243;6215.937840621604;6221.626702397871;6252;5616.5787565932515;6194.659293738842;6195.473384762301;6196.566240363177;6204.379562043805;5811.244538210027;5920.822375328747;5951.22634057574;5984.611000284989;5992.640441573498;5744.3394009689;5853.414658534155;5867.178594996704;5868.853278668024;5936.020556608154;13349.132306400053;13450.798238026437;13536.729265414735;16289.837101628951;24623.876880615662;2342.554914566227;2349.8237632177484;2359.858408495496;2419.52819200256;2957.985210073957;11201.271917325348;11477.827832582518;11935.522579096825;12473.75052498954;14316.141031538036;1963.4894927318858;2074.4606402335503;2080.4070839810734;2125.2986514450195;2129.7337832770904;87357.56321218354;87927.56036219842;91894;92303;92357;10498.895011049945;11265.54937802495;12001.759964800654;12161.270323780602;12536.310502922426;14583.489577864935;16420.507384778477;17602.471925842245;17613.38353157633;17717.11414429299;8239.299659529008;8344.541050242295;8401.95799021001;8531.488110713377;8533.317334613215;8211.71259005932;8216.46592971455;8235;8377.120402357787;8429.620667069996;4598.563136502027;4622.214223581999;4626.190416677068;4633.208474483551;4692.882677933079;2135.829133669303;2151.5159089204803;2155.9353219403442;2181.7054697615936;2188.1794327127327;922.3497434308796;985.7979114281555;1004.9648262310784;1025.7435641089728;1056.8784589772274;19732.693489856993;19982.90008549948;20061.598768024556;20187.697184542245;20375;969.5103972493846;971.7862070344654;1002.0280328081749;1061.686802393296;1101.8898110188918;10492.632757853591;10885.41950709213;10948.45257737126;10962.177836662282;11040.227184097035;486120;491687;498864;509788;537891;58868;67897.66051169712;92907.53546232225;93240;93336.53331733299;990.6384169778123;999.4403134244847;1024.446798728693;1029.1355261580309;1030.577463240083;16631.750523742394;17183.226754796313;17414;17578.472645820646;17650.29398824084;43764.781176093915;43839.56160438482;43939.34090988702;44293;45413.772931135136;57537.42462575488;58816.411835881096;59441;59783.402165977786;60024.49938751566;7915.0897646771355;8251.133630968901;8410.369222308229;8544.74365769003;8992.550372481219;10585.9470702646;13319.400626972003;13380.732385352043;13491.527796527074;13752;11934.820977685515;11964.341961192218;11986.741392154046;12147.635570932885;12226.388680566113;11455.656330310105;11604.767904642029;11741;11924.582639607572;12123.211991220542;11000;11762;12218.389080546114;12248.020158387486;12461;7789.688412463438;9044.276457883221;9098.499582523025;9421.528923553658;9530.475823829756;10847.186461015297;11450.807665095408;11573.479193436484;11583.189176757545;12146.514139434325 04:00:15 INFO - PROCESS | 18986 | |3;mootools.html;1448.5147475595675;1562.7108984837805;1567.0362726922942;1763.6825371433144;1909.6849019911715;8553.358498112642;9142.90857091429;9576.61693532258;9586.041395860411;9914.851277230848;9683.564239609217;9765.95117024414;9779.266555008368;9781.559829807658;9786.119249267564;2573.9999999999955;2602.3884387169;2605.557055300594;2606.609008648699;2607.439400528886;2493.9002439902383;2551.8468891866455;2552.1833013435707;2558.769710726034;2562.0392352867675;2508.3352911478473;2523.558377283968;2554.910578129766;2558.0663057983793;2559.539282929072;2462.2982450001664;2489.439876027888;2496.226169887341;2497.4880149569294;2497.887595058218;2426.502566973784;2445.7431969643108;2449.3386785567977;2455.9508809823706;2468.4445999650115;9349.485778282191;9596.376235544667;9817.067378599022;9824.557894894748;9841.114299712988;5633.774649014034;5845.824625261249;5851;5860.472557469806;5867.237259156283;3676.3382591133586;3701.407774756053;3774.0942173878348;3819.102510909934;3831.8275677594297;1241.6275117464725;1264.974700505994;1267.1889990406148;1295.7538067767189;1320.2936429010529;13416;13455.32723363828;13533.39099740514;13583.388747506386;13627.04610677243;4854.101991131652;4875.488073752276;4891.241857512091;4939.2838038484215;5062.443131255559;10579.84130238047;10581.84127238092;10591.84112238317;10604.151667866552;10615.203859710553;5735.0250457422335;5740.971295143498;5743.971280143573;5744;5744.971275143597;4623.56076172763;4807.18277892759;4960.007998400334;4960.875978100504;5379.811706590251;4183.435236243068;4248.129133527619;4352.499462561846;4368.344748287719;4369.9126017479475;1288.664947113757;1306.6406738146895;1322.2661422910185;1322.7751282282036;1329.322045756671;821.3470291118575;821.5645707774889;882.642529775442;896.3053633434141;974.6004138303261;5905.350411454737;6102.9694851525455;6172.814815555541;6179.62922224668;6548.607083575001;473.96682232244103;507.59138893190595;523.4765234765234;532.8508017755034;532.9920051199235;4415.84544540946;4419.248727716296;4534.59188673021;4543.114092751882;4557.589816916494;11368.772624547462;11605.59380421698;11694.94152529249;11698.47356868943;11750.412479375997;11369.31784092957;11844.526218951145;11845.526178952918;12250.693732656755;12278.570250041384;8701.738947831574;8813.206811387006;8827.602757876039;8865.64537418509;8868.423552469068;6327.240731112296;6604.405603495708;6615.4376877965915;6678.860935360567;6700.162479690039;10691.57233710674;11135.721606959567;11211.047060999581;11255.66233013011;11259.09927205838;10122.089011988955;10278.33190842593;11520;11575.652730418102;11669.824952625548;7982.321502672338;8353.958230209053;8385.706500272461;8398.328133749408;8402.285805706584;9345.439273643604;9369.672061477815;9378.812423751624;9403.153716165578;9406.764830879009;8338.833223335621;8410.663573456994;8432.831343372976;8528.976522817302;8603.397762156588;8124.146964568635;8226.712065077932;8279;8414.158584141536;8638.26574741154;7429.368503677032;7515.361194298546;7616.276453736886;7665.348445382205;7748.418868584991;5324.387695414922;5376.542993845567;5424.972875135599;5427.755750991294;5536.972315138399;5454.372747134131;5515.834524964257;5643.238162847963;5651.321841379061;5817.0983497557945 04:00:15 INFO - PROCESS | 18986 | |4;prototype.html;361.1603022971591;368.63320995609365;371.088976562539;372.21834148288616;373.07105307783627;5616.831495055149;5617.775288988446;5654.519365853902;5659.320881494216;5667.093265077583;5308.416074231841;5537.58468114892;5549.1676248562735;5559.8888022239535;5581.469760372758;4371.519132895379;4404.889877753049;4426.734395936254;4432.8005239764125;4451.310046942729;4429.5348988356245;4441.2908126043085;4443.60007599316;4445.444319460067;4464.866054018385;4375.58431948966;4382;4383.890402739925;4387.692861499696;4428.202923473789;4252.787360631972;4323.783810809478;4336.327869180266;4350.12997400518;4351.5648435156545;3890.1441682830014;3895.4935858338517;3908.882733517999;3910.335243008695;3910.7262491625597;5410.594205434608;5445.319335083114;5473.562115030788;5478.616496845222;5513.228148059275;4791.185498465235;4972.881101752113;5010.248462730619;5024.799008039674;5090;5781.075027995543;5801.7099145042575;5812.651240925558;5818.505427038707;5823.737931793079;4230.259704551691;4236.894077648052;4261.637760790337;4266.743995360288;4273.18809426208;5753.7986170484255;5858.179854820329;5869.475648923533;6000.36996115406;6061.969690151565;4182.372644103348;4278.0374415756205;4282.528921818597;4285.121550082225;4285.18581469526;4339.305711086211;4377.956220437755;4384.386185933972;4388.780560972003;4422.358757980075;4750.643701722384;4836.250381190921;5019.397672279277;5049.2173713074535;5052.418971818214;5614.550835933115;5801.0856417382165;5804.622699524517;5813.215215945793;5826.970865145647;1507.1785876697006;1515.8332583415815;1518.9696206075816;1526.6946610677687;1527.2287494815048;943.8961714211431;963.4219468319093;984.1487113646645;989.4854675568664;992.7170756334555;4909.950900491021;4912.361393018885;4919.90160196794;4943.678660887031;4962.255661650781;5238.633295669267;5261.5264626183825;5265.656782731648;5267.920981185285;5302.3637163540625;4678.8128474861305;4892.908329130185;4914.827981020719;4959.561727099101;5053.772580233898;2840.4887120318126;2846.814957027828;2851.344190836119;2851.472477591652;2869.985650071778;5329.973350133225;5371.435999220103;5492.313460817398;5496;5506.944930550723;4950.702957822542;5271.262023316739;5281.656692315064;5361.973190134102;5368.3826359968325;5437.90039677388;5451.591130665216;5470.878469913659;5479.917801232985;5485.080221922375;5273.709945953009;5279.287296214962;5298.97350513245;5303.893922121613;5310.778520940283;5629.605927585029;6002.079334613057;6031.396860314109;6031.457168854824;6037.547183961133;5939.316978547522;6062.242219722535;6075.270967483753;6201.317855036033;6244.157038799885;4359.782010899506;4380.233459144701;4386.583274588909;4395.780210989502;4397.560243975705;5849.210356601974;6037.939620603914;6066.545009124422;6071.5446341523675;6082.665453400105;5846.853828654148;5847.8245652630485;5849.181114643869;5866.560007999503;5869.8239052828485;5809.5352371811;5839.970800145972;5847.649141051551;5855.092460668603;5855.531557475307;5620.662760234399;5827.94172058274;5841.766329346779;5843.181954526454;5857.26784151981;5879.529637629065;5918.496927761188;5918.822435326947;5929.229200204119;5961.940380596312;5619.157126431068;5794.333651630117;5813.883722325614;5817.854553636193;5819.915444814255 04:00:15 INFO - PROCESS | 18986 | |5;yui.html;810.3388054488297;813.0446725098009;813.4590497319283;823.7034667519696;856.9400141990061;16873.40943066993;18231.817681823177;18274.634507309846;18291.634167316646;18300.816991830077;16293.266802993865;16459.67080658386;16530.256138473767;16532.09073500957;16545.834541654578;705.0411440440996;728.9927100729004;844.5819319436887;869.0614136732346;872.6378552900538;862.4092496639822;863.7840539865034;863.8401895649325;864.3690106222462;864.567716141929;759.9240075992412;932.3287233192091;934.1639232886563;935.9812803743955;937.6202637931615;770.3182683325269;917.1928702741578;938.2072149034055;950.3442624589012;953.0802775321779;671.8924972004456;672.5661948043534;673.7810211681223;675.6790524500872;675.8614484030762;16054.357825686959;16058.43795467153;16138.435154769644;16147.192640367935;16155.43455979035;16739.414120505844;16941.152942352834;17087.572810679834;17928.013959232238;17975.1012449377;13689.589312320646;13736.450541978309;13821.930890345484;13999.790003149961;14190.787138192936;3950.249452603996;4014.7189696721243;4021.2158629067344;4031.173609410064;4044.2315959967514;89187.55406222992;90226.54886725525;92197;93168.06831931662;93422.53288733581;12003.759924801456;12627.558035468715;12749.00794143508;13001.219926804422;13007.934960325138;25639;25682.229533114038;25700.100496482908;25713;25718.09986650458;8924;9079.909200908038;9136.634534618674;9348.205402540723;9386.765330866647;4813.205821039489;4825.179719447702;4944.184209605447;4976.353074100344;5030.4718004608985;3857.1321452672923;4012.61880121388;4093.570175131628;4098.692598055158;4098.7130900836655;664.7872680742213;676.5298117808175;678.1218322272669;680.1532092544813;684.8596037812237;576.9048107062372;585.7569108819878;662.215274899246;681.7750142452978;752.7779305105007;10066.69799906004;10223.488825558692;10454.215933804995;10597.099246563974;10645.361278323171;643.2409756487297;662.1855118204635;668.4485299627827;669.5045666206972;703.8170075780334;4399.802008909607;4550.431196100488;4646.163690535736;4684.484706682262;4690.343351930733;77707.61146194345;78825.21174788293;138113.3094334542;139273.30363348118;139731;89232;89613;91060;106993;107126;83354;87446;92085.07914920899;92188.53905730428;96828.99999999859;9722.173615242784;10678.46607669629;10678.946605266923;10812.945935270272;10924.563017479211;48021.519784801705;54735.45264547304;54892;55792.16311755246;55860.16209756938;70317.29682703108;75692;79127;79707.60146199232;82441.58779206066;12426.875731242571;12911.806322904977;13084.934575327063;13265.33673316311;13854.238016909167;13234.205947643171;13316.667083322995;13467.865321347053;13746.518871839839;13916.304184790517;11068.319072095466;13680.31598420095;14036.908539176988;14603.415863365346;14831.11013339203;13909.095908765898;13920.025598208029;14113.576592702235;14585.92707036458;15005.32476038559;13560.86439135596;14362.784558231844;14366.784498232326;14422.350994205495;14638.341274642453;11643.41782910834;12254.816177757519;12296.077794165294;12417.62747117588;12512.74974500523;11697.883021169679;11986;12086.939565302117;12248.632541023784;12290.815637765261 04:00:15 INFO - PROCESS | 18986 | __end_tp_report 04:00:15 INFO - PROCESS | 18986 | __start_cc_report 04:00:15 INFO - PROCESS | 18986 | _x_x_mozilla_cycle_collect,891 04:00:15 INFO - PROCESS | 18986 | __end_cc_report 04:00:15 INFO - PROCESS | 18986 | __startTimestamp1477825215346__endTimestamp 04:00:15 INFO - PROCESS | 18986 | 04:00:15 INFO - PROCESS | 18986 | ------- Summary: start ------- 04:00:15 INFO - PROCESS | 18986 | Number of tests: 6 04:00:15 INFO - PROCESS | 18986 | 04:00:15 INFO - PROCESS | 18986 | [#0] dojo.html Cycles:165 Average:5626.12 Median:5840.42 stddev:645.19 (11.0%) stddev-sans-first:617.17 04:00:15 INFO - PROCESS | 18986 | Values: 3147.3 3191.6 3196.5 3208.6 3231.7 5605.4 5700.6 5708.8 5709.5 5756.1 5619.7 5667.3 5682.6 5687.1 5731.1 5092.5 5117.7 5132.3 5155.0 5204.5 5094.7 5213.6 5215.2 5218.0 5236.5 5078.8 5091.5 5127.5 5170.4 5196.0 5161.0 5180.4 5234.8 5244.2 5270.5 5016.3 5066.9 5134.3 5200.4 5217.8 5523.8 5526.9 5567.0 5580.6 5591.3 5999.2 6000.5 6113.6 6115.5 6122.4 5979.0 6139.8 6146.5 6159.2 6161.6 5627.4 5669.7 5695.4 5720.3 5744.0 6310.4 6330.1 6340.3 6342.6 6343.4 5841.1 6054.4 6074.8 6077.5 6097.5 5979.2 5994.5 6045.7 6068.5 6120.7 6061.4 6061.5 6070.7 6099.4 6114.2 6024.6 6072.8 6085.1 6086.9 6089.1 4566.2 4599.5 4629.8 4659.3 4662.4 4158.6 4162.2 4168.3 4168.9 4190.3 5665.9 5666.3 5684.7 5686.6 5690.1 5926.1 5985.3 5986.4 6061.0 6164.4 5731.0 5736.5 5740.6 5762.2 5767.7 5265.2 5267.1 5280.8 5280.8 5281.7 6117.8 6149.9 6166.8 6300.8 6351.9 5980.3 6053.3 6054.6 6090.9 6093.0 6252.9 6272.1 6285.8 6286.2 6293.8 5829.1 5844.8 5949.6 5950.7 5985.6 5909.5 5909.5 5963.4 6017.4 6044.9 5804.6 5845.1 5849.2 5852.0 5854.1 5756.1 5852.2 5854.3 5861.9 5865.0 5837.5 5840.4 5844.4 5889.4 5981.4 5976.0 5976.9 5977.9 5979.6 5982.9 5714.8 5753.8 5834.9 5844.2 5846.9 04:00:15 INFO - PROCESS | 18986 | 04:00:15 INFO - PROCESS | 18986 | [#1] ext.html Cycles:180 Average:62934.43 Median:229855.08 stddev:122465.70 (53.3%) stddev-sans-first:122719.72 04:00:15 INFO - PROCESS | 18986 | Values: 565.7 586.8 615.7 618.4 644.3 34669.5 45625.8 47293.8 47470.8 47495.3 48289.0 48651.3 48799.0 48841.8 48857.0 8449.1 9348.7 9488.3 9508.2 9508.6 8384.9 10985.8 11224.9 11249.9 11657.8 11382.4 11444.8 11456.6 11459.1 11462.5 8549.2 8775.6 11175.7 11254.9 11259.2 8479.2 8542.4 10750.9 11098.2 11105.2 46526.0 46752.0 46854.5 46897.3 46926.8 3561.2 3584.8 3708.9 3911.1 4025.1 32557.3 33599.5 33865.7 33893.5 34401.7 4375.8 4380.8 4429.5 4466.2 4510.2 368277.0 369065.0 370219.0 370636.0 371062.0 64422.0 64787.4 65082.7 65093.3 65133.0 60524.4 60685.7 60753.4 60773.7 60941.4 18765.8 19474.4 19506.6 19509.5 19548.3 13473.4 13810.0 13831.9 13899.6 14269.8 18247.4 18421.5 18567.7 18583.9 18657.3 6768.8 7075.4 7109.2 7114.3 7187.1 908.5 998.9 1029.9 1031.5 1064.9 33186.3 33686.7 33709.8 33993.8 34046.7 1072.8 1080.2 1084.2 1116.1 1118.4 16876.4 17997.3 19217.0 19379.9 19561.7 569512.0 573915.0 575878.0 576066.0 576300.0 63415.4 63587.0 63743.7 63991.4 64035.7 1273.5 1333.6 1356.7 1401.6 1422.7 30234.8 34212.8 35003.3 35057.8 35144.3 53174.0 53720.7 53847.5 53856.5 53948.7 412906.0 418094.0 418764.0 419288.0 421234.0 30401.2 31691.0 31824.8 32819.2 32827.3 49774.3 50176.7 50282.5 51274.0 51306.0 42096.8 42201.8 42299.2 42530.6 44130.1 41616.2 42375.4 42720.0 42930.6 44166.6 42116.8 42606.6 43744.8 43908.6 43970.0 34757.8 37273.7 37295.6 37914.0 38074.8 28854.0 29368.0 29776.1 29832.0 29849.7 04:00:15 INFO - PROCESS | 18986 | 04:00:15 INFO - PROCESS | 18986 | [#2] jquery.html Cycles:180 Average:29512.56 Median:2389.69 stddev:83228.61 (3482.8%) stddev-sans-first:83433.35 04:00:15 INFO - PROCESS | 18986 | Values: 384.7 438.7 445.1 445.1 452.9 18559.2 19945.3 21079.4 21178.9 21242.4 14136.9 16513.0 19759.7 20233.9 20353.5 5599.8 5837.2 5837.3 5843.0 5844.3 5032.8 6181.1 6215.9 6221.6 6252.0 5616.6 6194.7 6195.5 6196.6 6204.4 5811.2 5920.8 5951.2 5984.6 5992.6 5744.3 5853.4 5867.2 5868.9 5936.0 13349.1 13450.8 13536.7 16289.8 24623.9 2342.6 2349.8 2359.9 2419.5 2958.0 11201.3 11477.8 11935.5 12473.8 14316.1 1963.5 2074.5 2080.4 2125.3 2129.7 87357.6 87927.6 91894.0 92303.0 92357.0 10498.9 11265.5 12001.8 12161.3 12536.3 14583.5 16420.5 17602.5 17613.4 17717.1 8239.3 8344.5 8402.0 8531.5 8533.3 8211.7 8216.5 8235.0 8377.1 8429.6 4598.6 4622.2 4626.2 4633.2 4692.9 2135.8 2151.5 2155.9 2181.7 2188.2 922.3 985.8 1005.0 1025.7 1056.9 19732.7 19982.9 20061.6 20187.7 20375.0 969.5 971.8 1002.0 1061.7 1101.9 10492.6 10885.4 10948.5 10962.2 11040.2 486120.0 491687.0 498864.0 509788.0 537891.0 58868.0 67897.7 92907.5 93240.0 93336.5 990.6 999.4 1024.4 1029.1 1030.6 16631.8 17183.2 17414.0 17578.5 17650.3 43764.8 43839.6 43939.3 44293.0 45413.8 57537.4 58816.4 59441.0 59783.4 60024.5 7915.1 8251.1 8410.4 8544.7 8992.6 10585.9 13319.4 13380.7 13491.5 13752.0 11934.8 11964.3 11986.7 12147.6 12226.4 11455.7 11604.8 11741.0 11924.6 12123.2 11000.0 11762.0 12218.4 12248.0 12461.0 7789.7 9044.3 9098.5 9421.5 9530.5 10847.2 11450.8 11573.5 11583.2 12146.5 04:00:15 INFO - PROCESS | 18986 | 04:00:15 INFO - PROCESS | 18986 | [#3] mootools.html Cycles:180 Average:6265.00 Median:4915.26 stddev:3605.82 (73.4%) stddev-sans-first:3597.77 04:00:15 INFO - PROCESS | 18986 | Values: 1448.5 1562.7 1567.0 1763.7 1909.7 8553.4 9142.9 9576.6 9586.0 9914.9 9683.6 9766.0 9779.3 9781.6 9786.1 2574.0 2602.4 2605.6 2606.6 2607.4 2493.9 2551.8 2552.2 2558.8 2562.0 2508.3 2523.6 2554.9 2558.1 2559.5 2462.3 2489.4 2496.2 2497.5 2497.9 2426.5 2445.7 2449.3 2456.0 2468.4 9349.5 9596.4 9817.1 9824.6 9841.1 5633.8 5845.8 5851.0 5860.5 5867.2 3676.3 3701.4 3774.1 3819.1 3831.8 1241.6 1265.0 1267.2 1295.8 1320.3 13416.0 13455.3 13533.4 13583.4 13627.0 4854.1 4875.5 4891.2 4939.3 5062.4 10579.8 10581.8 10591.8 10604.2 10615.2 5735.0 5741.0 5744.0 5744.0 5745.0 4623.6 4807.2 4960.0 4960.9 5379.8 4183.4 4248.1 4352.5 4368.3 4369.9 1288.7 1306.6 1322.3 1322.8 1329.3 821.3 821.6 882.6 896.3 974.6 5905.4 6103.0 6172.8 6179.6 6548.6 474.0 507.6 523.5 532.9 533.0 4415.8 4419.2 4534.6 4543.1 4557.6 11368.8 11605.6 11694.9 11698.5 11750.4 11369.3 11844.5 11845.5 12250.7 12278.6 8701.7 8813.2 8827.6 8865.6 8868.4 6327.2 6604.4 6615.4 6678.9 6700.2 10691.6 11135.7 11211.0 11255.7 11259.1 10122.1 10278.3 11520.0 11575.7 11669.8 7982.3 8354.0 8385.7 8398.3 8402.3 9345.4 9369.7 9378.8 9403.2 9406.8 8338.8 8410.7 8432.8 8529.0 8603.4 8124.1 8226.7 8279.0 8414.2 8638.3 7429.4 7515.4 7616.3 7665.3 7748.4 5324.4 5376.5 5425.0 5427.8 5537.0 5454.4 5515.8 5643.2 5651.3 5817.1 04:00:15 INFO - PROCESS | 18986 | 04:00:15 INFO - PROCESS | 18986 | [#4] prototype.html Cycles:180 Average:4786.24 Median:5303.13 stddev:1375.47 (25.9%) stddev-sans-first:1338.63 04:00:15 INFO - PROCESS | 18986 | Values: 361.2 368.6 371.1 372.2 373.1 5616.8 5617.8 5654.5 5659.3 5667.1 5308.4 5537.6 5549.2 5559.9 5581.5 4371.5 4404.9 4426.7 4432.8 4451.3 4429.5 4441.3 4443.6 4445.4 4464.9 4375.6 4382.0 4383.9 4387.7 4428.2 4252.8 4323.8 4336.3 4350.1 4351.6 3890.1 3895.5 3908.9 3910.3 3910.7 5410.6 5445.3 5473.6 5478.6 5513.2 4791.2 4972.9 5010.2 5024.8 5090.0 5781.1 5801.7 5812.7 5818.5 5823.7 4230.3 4236.9 4261.6 4266.7 4273.2 5753.8 5858.2 5869.5 6000.4 6062.0 4182.4 4278.0 4282.5 4285.1 4285.2 4339.3 4378.0 4384.4 4388.8 4422.4 4750.6 4836.3 5019.4 5049.2 5052.4 5614.6 5801.1 5804.6 5813.2 5827.0 1507.2 1515.8 1519.0 1526.7 1527.2 943.9 963.4 984.1 989.5 992.7 4910.0 4912.4 4919.9 4943.7 4962.3 5238.6 5261.5 5265.7 5267.9 5302.4 4678.8 4892.9 4914.8 4959.6 5053.8 2840.5 2846.8 2851.3 2851.5 2870.0 5330.0 5371.4 5492.3 5496.0 5506.9 4950.7 5271.3 5281.7 5362.0 5368.4 5437.9 5451.6 5470.9 5479.9 5485.1 5273.7 5279.3 5299.0 5303.9 5310.8 5629.6 6002.1 6031.4 6031.5 6037.5 5939.3 6062.2 6075.3 6201.3 6244.2 4359.8 4380.2 4386.6 4395.8 4397.6 5849.2 6037.9 6066.5 6071.5 6082.7 5846.9 5847.8 5849.2 5866.6 5869.8 5809.5 5840.0 5847.6 5855.1 5855.5 5620.7 5827.9 5841.8 5843.2 5857.3 5879.5 5918.5 5918.8 5929.2 5961.9 5619.2 5794.3 5813.9 5817.9 5819.9 04:00:15 INFO - PROCESS | 18986 | 04:00:15 INFO - PROCESS | 18986 | [#5] yui.html Cycles:180 Average:22023.77 Median:4068.90 stddev:31423.76 (772.3%) stddev-sans-first:31471.54 04:00:15 INFO - PROCESS | 18986 | Values: 810.3 813.0 813.5 823.7 856.9 16873.4 18231.8 18274.6 18291.6 18300.8 16293.3 16459.7 16530.3 16532.1 16545.8 705.0 729.0 844.6 869.1 872.6 862.4 863.8 863.8 864.4 864.6 759.9 932.3 934.2 936.0 937.6 770.3 917.2 938.2 950.3 953.1 671.9 672.6 673.8 675.7 675.9 16054.4 16058.4 16138.4 16147.2 16155.4 16739.4 16941.2 17087.6 17928.0 17975.1 13689.6 13736.5 13821.9 13999.8 14190.8 3950.2 4014.7 4021.2 4031.2 4044.2 89187.6 90226.5 92197.0 93168.1 93422.5 12003.8 12627.6 12749.0 13001.2 13007.9 25639.0 25682.2 25700.1 25713.0 25718.1 8924.0 9079.9 9136.6 9348.2 9386.8 4813.2 4825.2 4944.2 4976.4 5030.5 3857.1 4012.6 4093.6 4098.7 4098.7 664.8 676.5 678.1 680.2 684.9 576.9 585.8 662.2 681.8 752.8 10066.7 10223.5 10454.2 10597.1 10645.4 643.2 662.2 668.4 669.5 703.8 4399.8 4550.4 4646.2 4684.5 4690.3 77707.6 78825.2 138113.3 139273.3 139731.0 89232.0 89613.0 91060.0 106993.0 107126.0 83354.0 87446.0 92085.1 92188.5 96829.0 9722.2 10678.5 10678.9 10812.9 10924.6 48021.5 54735.5 54892.0 55792.2 55860.2 70317.3 75692.0 79127.0 79707.6 82441.6 12426.9 12911.8 13084.9 13265.3 13854.2 13234.2 13316.7 13467.9 13746.5 13916.3 11068.3 13680.3 14036.9 14603.4 14831.1 13909.1 13920.0 14113.6 14585.9 15005.3 13560.9 14362.8 14366.8 14422.4 14638.3 11643.4 12254.8 12296.1 12417.6 12512.7 11697.9 11986.0 12086.9 12248.6 12290.8 04:00:15 INFO - PROCESS | 18986 | -------- Summary: end -------- 04:00:15 INFO - PROCESS | 18986 | 04:00:16 INFO - TEST-INFO | 18986: exit 0 04:00:16 INFO - TEST-OK | dromaeo_css | took 1114285ms 04:00:16 INFO - TEST-START | kraken 04:00:16 INFO - operating with platform_type : linux_ 04:00:16 INFO - Initialising browser for kraken test... 04:00:16 INFO - TEST-INFO | started process 19303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW3oiJL/profile http://localhost:52785/getInfo.html) 04:00:20 INFO - PROCESS | 19303 | __metrics Screen width/height:1600/1200 04:00:20 INFO - PROCESS | 19303 | colorDepth:24 04:00:20 INFO - PROCESS | 19303 | Browser inner width/height: 1024/697 04:00:20 INFO - PROCESS | 19303 | __metrics 04:00:20 INFO - PROCESS | 19303 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:00:20 INFO - PROCESS | 19303 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:00:21 INFO - PROCESS | 19303 | console.error: PushService: 04:00:21 INFO - PROCESS | 19303 | stateChangeProcessEnqueue: Error transitioning state 04:00:21 INFO - PROCESS | 19303 | UnknownError 04:00:21 INFO - TEST-INFO | 19303: exit 0 04:00:21 INFO - Browser initialized. 04:00:21 INFO - Running cycle 1/1 for kraken test... 04:00:21 INFO - TEST-INFO | started process 19391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW3oiJL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:33 INFO - PROCESS | 19391 | RSS: Main: 145129472 04:00:33 INFO - PROCESS | 19391 | 04:00:36 INFO - PROCESS | 19391 | Cycle 1(1): loaded http://localhost:52785/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52785/tests/kraken/driver.html?testName=audio-beat-detection) 04:00:37 INFO - PROCESS | 19391 | RSS: Main: 186646528 04:00:37 INFO - PROCESS | 19391 | 04:00:39 INFO - PROCESS | 19391 | Cycle 1(1): loaded http://localhost:52785/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52785/tests/kraken/driver.html?testName=audio-dft) 04:00:40 INFO - PROCESS | 19391 | RSS: Main: 176189440 04:00:40 INFO - PROCESS | 19391 | 04:00:43 INFO - PROCESS | 19391 | Cycle 1(1): loaded http://localhost:52785/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52785/tests/kraken/driver.html?testName=audio-fft) 04:00:43 INFO - PROCESS | 19391 | RSS: Main: 267145216 04:00:43 INFO - PROCESS | 19391 | 04:00:45 INFO - PROCESS | 19391 | Cycle 1(1): loaded http://localhost:52785/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52785/tests/kraken/driver.html?testName=audio-oscillator) 04:00:46 INFO - PROCESS | 19391 | RSS: Main: 173981696 04:00:46 INFO - PROCESS | 19391 | 04:00:48 INFO - PROCESS | 19391 | Cycle 1(1): loaded http://localhost:52785/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52785/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:00:48 INFO - PROCESS | 19391 | RSS: Main: 175910912 04:00:48 INFO - PROCESS | 19391 | 04:00:51 INFO - PROCESS | 19391 | Cycle 1(1): loaded http://localhost:52785/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52785/tests/kraken/driver.html?testName=imaging-darkroom) 04:00:52 INFO - PROCESS | 19391 | RSS: Main: 211890176 04:00:52 INFO - PROCESS | 19391 | 04:00:55 INFO - PROCESS | 19391 | Cycle 1(1): loaded http://localhost:52785/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52785/tests/kraken/driver.html?testName=imaging-desaturate) 04:00:56 INFO - PROCESS | 19391 | RSS: Main: 210612224 04:00:56 INFO - PROCESS | 19391 | 04:00:59 INFO - PROCESS | 19391 | Cycle 1(1): loaded http://localhost:52785/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52785/tests/kraken/driver.html?testName=json-parse-financial) 04:00:59 INFO - PROCESS | 19391 | RSS: Main: 210210816 04:00:59 INFO - PROCESS | 19391 | 04:01:01 INFO - PROCESS | 19391 | Cycle 1(1): loaded http://localhost:52785/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52785/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:01:01 INFO - PROCESS | 19391 | RSS: Main: 172937216 04:01:01 INFO - PROCESS | 19391 | 04:01:03 INFO - PROCESS | 19391 | Cycle 1(1): loaded http://localhost:52785/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52785/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:01:04 INFO - PROCESS | 19391 | RSS: Main: 179802112 04:01:04 INFO - PROCESS | 19391 | 04:01:06 INFO - PROCESS | 19391 | Cycle 1(1): loaded http://localhost:52785/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52785/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:01:06 INFO - PROCESS | 19391 | RSS: Main: 188755968 04:01:06 INFO - PROCESS | 19391 | 04:01:09 INFO - PROCESS | 19391 | Cycle 1(1): loaded http://localhost:52785/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52785/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:01:09 INFO - PROCESS | 19391 | RSS: Main: 197697536 04:01:09 INFO - PROCESS | 19391 | 04:01:12 INFO - PROCESS | 19391 | Cycle 1(1): loaded http://localhost:52785/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52785/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:01:13 INFO - PROCESS | 19391 | RSS: Main: 194355200 04:01:13 INFO - PROCESS | 19391 | 04:01:14 INFO - PROCESS | 19391 | Cycle 1(1): loaded http://localhost:52785/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52785/tests/kraken/driver.html?testName=ai-astar) 04:01:15 INFO - PROCESS | 19391 | RSS: Main: 245506048 04:01:15 INFO - PROCESS | 19391 | 04:01:15 INFO - PROCESS | 19391 | __start_tp_report 04:01:15 INFO - PROCESS | 19391 | _x_x_mozilla_page_load 04:01:15 INFO - PROCESS | 19391 | _x_x_mozilla_page_load_details 04:01:15 INFO - PROCESS | 19391 | |i|pagename|runs| 04:01:15 INFO - PROCESS | 19391 | |0;ai-astar;107;110;109;111;109;109;109;109;109;110 04:01:15 INFO - PROCESS | 19391 | |1;audio-beat-detection;145;116;115;160;121;119;121;117;149;123 04:01:15 INFO - PROCESS | 19391 | |2;audio-dft;160;159;161;160;160;159;161;160;160;159 04:01:15 INFO - PROCESS | 19391 | |3;audio-fft;74;78;77;115;76;77;75;77;99;75 04:01:15 INFO - PROCESS | 19391 | |4;audio-oscillator;81;81;112;83;83;82;100;80;80;105 04:01:15 INFO - PROCESS | 19391 | |5;imaging-gaussian-blur;117;117;116;117;116;117;116;117;116;116 04:01:15 INFO - PROCESS | 19391 | |6;imaging-darkroom;146;146;145;145;145;145;145;145;145;145 04:01:15 INFO - PROCESS | 19391 | |7;imaging-desaturate;94;94;95;95;95;94;95;95;95;95 04:01:15 INFO - PROCESS | 19391 | |8;json-parse-financial;50;50;50;51;51;50;51;51;50;50 04:01:15 INFO - PROCESS | 19391 | |9;json-stringify-tinderbox;58;58;57;61;58;58;58;59;59;59 04:01:15 INFO - PROCESS | 19391 | |10;stanford-crypto-aes;74;73;73;74;73;74;73;73;72;80 04:01:15 INFO - PROCESS | 19391 | |11;stanford-crypto-ccm;120;130;128;121;132;130;118;119;153;126 04:01:15 INFO - PROCESS | 19391 | |12;stanford-crypto-pbkdf2;157;152;153;165;159;155;152;154;151;151 04:01:15 INFO - PROCESS | 19391 | |13;stanford-crypto-sha256-iterative;62;62;61;61;66;62;63;62;61;62 04:01:15 INFO - PROCESS | 19391 | __end_tp_report 04:01:15 INFO - PROCESS | 19391 | __start_cc_report 04:01:15 INFO - PROCESS | 19391 | _x_x_mozilla_cycle_collect,1633 04:01:15 INFO - PROCESS | 19391 | __end_cc_report 04:01:15 INFO - PROCESS | 19391 | __startTimestamp1477825275061__endTimestamp 04:01:15 INFO - PROCESS | 19391 | 04:01:15 INFO - PROCESS | 19391 | ------- Summary: start ------- 04:01:15 INFO - PROCESS | 19391 | Number of tests: 14 04:01:15 INFO - PROCESS | 19391 | 04:01:15 INFO - PROCESS | 19391 | [#0] ai-astar Cycles:10 Average:109.20 Median:109.00 stddev:1.03 (0.9%) stddev-sans-first:0.73 04:01:15 INFO - PROCESS | 19391 | Values: 107.0 110.0 109.0 111.0 109.0 109.0 109.0 109.0 109.0 110.0 04:01:15 INFO - PROCESS | 19391 | 04:01:15 INFO - PROCESS | 19391 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:122.00 stddev:16.29 (13.4%) stddev-sans-first:16.16 04:01:15 INFO - PROCESS | 19391 | Values: 145.0 116.0 115.0 160.0 121.0 119.0 121.0 117.0 149.0 123.0 04:01:15 INFO - PROCESS | 19391 | 04:01:15 INFO - PROCESS | 19391 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 04:01:15 INFO - PROCESS | 19391 | Values: 160.0 159.0 161.0 160.0 160.0 159.0 161.0 160.0 160.0 159.0 04:01:15 INFO - PROCESS | 19391 | 04:01:15 INFO - PROCESS | 19391 | [#3] audio-fft Cycles:10 Average:82.30 Median:77.00 stddev:13.61 (17.7%) stddev-sans-first:14.10 04:01:15 INFO - PROCESS | 19391 | Values: 74.0 78.0 77.0 115.0 76.0 77.0 75.0 77.0 99.0 75.0 04:01:15 INFO - PROCESS | 19391 | 04:01:15 INFO - PROCESS | 19391 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:81.00 stddev:12.09 (14.9%) stddev-sans-first:12.50 04:01:15 INFO - PROCESS | 19391 | Values: 81.0 81.0 112.0 83.0 83.0 82.0 100.0 80.0 80.0 105.0 04:01:15 INFO - PROCESS | 19391 | 04:01:15 INFO - PROCESS | 19391 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:01:15 INFO - PROCESS | 19391 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 116.0 116.0 04:01:15 INFO - PROCESS | 19391 | 04:01:15 INFO - PROCESS | 19391 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 04:01:15 INFO - PROCESS | 19391 | Values: 146.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 04:01:15 INFO - PROCESS | 19391 | 04:01:15 INFO - PROCESS | 19391 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 04:01:15 INFO - PROCESS | 19391 | Values: 94.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 04:01:15 INFO - PROCESS | 19391 | 04:01:15 INFO - PROCESS | 19391 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:50.50 stddev:0.52 (1.0%) stddev-sans-first:0.53 04:01:15 INFO - PROCESS | 19391 | Values: 50.0 50.0 50.0 51.0 51.0 50.0 51.0 51.0 50.0 50.0 04:01:15 INFO - PROCESS | 19391 | 04:01:15 INFO - PROCESS | 19391 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:58.50 stddev:1.08 (1.8%) stddev-sans-first:1.13 04:01:15 INFO - PROCESS | 19391 | Values: 58.0 58.0 57.0 61.0 58.0 58.0 58.0 59.0 59.0 59.0 04:01:15 INFO - PROCESS | 19391 | 04:01:15 INFO - PROCESS | 19391 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:73.50 stddev:2.23 (3.0%) stddev-sans-first:2.37 04:01:15 INFO - PROCESS | 19391 | Values: 74.0 73.0 73.0 74.0 73.0 74.0 73.0 73.0 72.0 80.0 04:01:15 INFO - PROCESS | 19391 | 04:01:15 INFO - PROCESS | 19391 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:129.00 stddev:10.25 (7.9%) stddev-sans-first:10.49 04:01:15 INFO - PROCESS | 19391 | Values: 120.0 130.0 128.0 121.0 132.0 130.0 118.0 119.0 153.0 126.0 04:01:15 INFO - PROCESS | 19391 | 04:01:15 INFO - PROCESS | 19391 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:154.50 stddev:4.41 (2.9%) stddev-sans-first:4.61 04:01:15 INFO - PROCESS | 19391 | Values: 157.0 152.0 153.0 165.0 159.0 155.0 152.0 154.0 151.0 151.0 04:01:15 INFO - PROCESS | 19391 | 04:01:15 INFO - PROCESS | 19391 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:1.48 (2.4%) stddev-sans-first:1.56 04:01:15 INFO - PROCESS | 19391 | Values: 62.0 62.0 61.0 61.0 66.0 62.0 63.0 62.0 61.0 62.0 04:01:15 INFO - PROCESS | 19391 | -------- Summary: end -------- 04:01:15 INFO - PROCESS | 19391 | 04:01:16 INFO - TEST-INFO | 19391: exit 0 04:01:16 INFO - TEST-OK | kraken | took 59938ms 04:01:16 INFO - SUITE-END | took 1174s 04:01:16 INFO - Completed test suite (00:19:34) 04:01:16 INFO - javascript benchmark 04:01:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3147.3075923296874, 3191.6489186189515, 3196.504541796021, 3208.6149662040557, 3231.660675629059, 5605.355384130826, 5700.629459085157, 5708.800191993281, 5709.514691251244, 5756.079027355619, 5619.7471113799875, 5667.263255776754, 5682.573806964484, 5687.061634830258, 5731.14032895066, 5092.465291144441, 5117.7185254810975, 5132.281480592701, 5155.046316431453, 5204.505571970657, 5094.694318340893, 5213.556847667934, 5215.1655735082395, 5218.0, 5236.502532259448, 5078.7968481260705, 5091.516305950929, 5127.5128862758165, 5170.431252562215, 5196.0, 5161.0, 5180.4042535108565, 5234.81678141267, 5244.187150991603, 5270.472952704698, 5016.297718319438, 5066.898662026776, 5134.255532947702, 5200.401953775327, 5217.773823151556, 5523.751431185607, 5526.917096243519, 5567.0, 5580.553555715574, 5591.329040515124, 5999.220101386835, 6000.489958353545, 6113.602615829956, 6115.48018418435, 6122.387761223887, 5979.043353063533, 6139.815805525842, 6146.508279337642, 6159.168512250833, 6161.599496032788, 5627.409122042168, 5669.744861481202, 5695.373508913975, 5720.313562372458, 5744.0, 6310.432061114522, 6330.113784070234, 6340.334264902119, 6342.619442833445, 6343.429091381798, 5841.094630332305, 6054.424829641177, 6074.847607171736, 6077.544184186204, 6097.451229389376, 5979.222701048923, 5994.460498555151, 6045.697715114226, 6068.544859135494, 6120.660465672121, 6061.363556826558, 6061.484773794189, 6070.726817293233, 6099.359567245376, 6114.2357205349335, 6024.608400453956, 6072.7570897164505, 6085.148079268906, 6086.878262434727, 6089.086637004485, 4566.246569316092, 4599.494055653875, 4629.814807407666, 4659.254519276899, 4662.440507139165, 4158.563350848178, 4162.167566486714, 4168.312228482328, 4168.937465938014, 4190.308599081118, 5665.858353541194, 5666.320041595035, 5684.6589204647025, 5686.5735069869925, 5690.089585666274, 5926.111083337448, 5985.281766188085, 5986.401359864066, 6061.0, 6164.383561643889, 5731.0, 5736.483716465538, 5740.6268592541355, 5762.164486149569, 5767.711614419262, 5265.236540701577, 5267.051930652519, 5280.762365693477, 5280.788768449296, 5281.735913204325, 6117.755289788359, 6149.938500615115, 6166.784162554379, 6300.810975670737, 6351.936480635227, 5980.252468441445, 6053.303870055, 6054.576179667381, 6090.908636370546, 6093.0, 6252.874942501216, 6272.059191121186, 6285.811425657238, 6286.245650521967, 6293.779717709858, 5829.067349224104, 5844.795432159854, 5949.613275137102, 5950.732217050329, 5985.6408615483215, 5909.468147866713, 5909.497692696169, 5963.4334738199805, 6017.428344307284, 6044.879102417839, 5804.593678442468, 5845.09401042822, 5849.151872978309, 5852.0, 5854.121881717776, 5756.079027355603, 5852.209951656472, 5854.326752423526, 5861.9413805861395, 5865.032269675456, 5837.503812176013, 5840.415958404125, 5844.386339434468, 5889.352171261072, 5981.401859813984, 5975.970120149545, 5976.880462390641, 5977.910331344946, 5979.5814292999075, 5982.850428739316, 5714.771409143587, 5753.827385178452, 5834.883302333845, 5844.181814546052, 5846.912296315644], "value": 5581.572278360907, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.6719102920307, 586.797554843579, 615.7198474694014, 618.4032408725581, 644.2591020326621, 34669.47995780065, 45625.77187114064, 47293.76353118238, 47470.762646186806, 47495.287570686465, 48289.0, 48651.27023094647, 48799.0, 48841.755791220996, 48857.0, 8449.112843151473, 9348.672796452109, 9488.288378371615, 9508.239340852715, 9508.572114254841, 8384.916150838506, 10985.780284394308, 11224.943875280613, 11249.943750281238, 11657.766844663143, 11382.430878456085, 11444.828327575051, 11456.599019034335, 11459.140564457657, 11462.541498340057, 8549.187827156411, 8775.561221938942, 11175.664730058112, 11254.94372528132, 11259.155563332783, 8479.194476524783, 8542.359323050796, 10750.892491075067, 11098.223124381297, 11105.222634415593, 46526.0, 46752.0, 46854.531454685355, 46897.29654055192, 46926.76536617329, 3561.216532362876, 3584.8028358440274, 3708.9443658345144, 3911.1395492991496, 4025.1144748155357, 32557.348853023042, 33599.49600755991, 33865.6613433865, 33893.49159762605, 34401.6559834401, 4375.781210939472, 4380.802863871133, 4429.468463784334, 4466.151431228089, 4510.165619360396, 368277.0, 369065.0, 370219.0, 370636.0, 371061.9999999973, 64422.0, 64787.35212647813, 65082.67458662677, 65093.349066509676, 65133.0, 60524.39475605276, 60685.69657151686, 60753.39246607477, 60773.696131519944, 60941.39058609357, 18765.812341876408, 19474.415767526996, 19506.609867802847, 19509.512262193275, 19548.315808946903, 13473.393697283645, 13810.0, 13831.930840345734, 13899.583012509642, 14269.78595321071, 18247.361342352953, 18421.53946151357, 18567.72148417775, 18583.90708046478, 18657.253709851455, 6768.849295619756, 7075.433965282765, 7109.249883120646, 7114.324139206767, 7187.101612298463, 908.5411867007119, 998.8601595776597, 1029.8867124616286, 1031.4636389077637, 1064.9254552181274, 33186.3362732744, 33686.66313336884, 33709.83145084259, 33993.83003084969, 34046.65953340485, 1072.7639919217759, 1080.189857606795, 1084.1868598551087, 1116.0625074937093, 1118.4016551145098, 16876.409325673543, 17997.268004745958, 19217.0, 19379.903100484407, 19561.706574401396, 569512.0, 573915.0, 575878.0, 576066.0, 576300.0, 63415.365846340945, 63587.0, 63743.68128159329, 63991.36008639947, 64035.67982160152, 1273.4587800184884, 1333.6332508560029, 1356.7422189783908, 1401.5655146904492, 1422.7083447893158, 30234.84882575573, 34212.82893585516, 35003.299934000665, 35057.8247108773, 35144.297114058085, 53174.0, 53720.731396342766, 53847.46152538424, 53856.46143538514, 53948.73025634847, 412906.0, 418094.0, 418764.0, 419288.0, 421234.0, 30401.23996900095, 31691.0, 31824.772265941163, 32819.17952051122, 32827.34345313033, 49774.25338619996, 50176.749116254185, 50282.497175027784, 51274.0, 51306.0, 42096.789516052224, 42201.78899105485, 42299.1540169201, 42530.5746942539, 44130.11739765122, 41616.1676766469, 42375.3643695351, 42720.0, 42930.57069429391, 44166.558334416244, 42116.78941605395, 42606.5739342615, 43744.78127609342, 43908.560914390444, 43970.0, 34757.826210868785, 37273.70389527795, 37295.6270437303, 37914.0, 38074.80962595169, 28854.0, 29368.0, 29776.10671679853, 29832.0, 29849.70150298556], "value": 21369.06832950911, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.7245132032644, 438.6797637724461, 445.1297712971141, 445.13643531548814, 452.8845144488155, 18559.164837582306, 19945.30191443298, 21079.367618971417, 21178.89410552949, 21242.36272911811, 14136.929315353409, 16513.00921944684, 19759.70360444591, 20233.898830505826, 20353.49116272094, 5599.80400685975, 5837.211976383176, 5837.270341207349, 5843.0, 5844.327902291248, 5032.798688052473, 6181.134641150243, 6215.937840621604, 6221.626702397871, 6252.0, 5616.5787565932515, 6194.659293738842, 6195.473384762301, 6196.566240363177, 6204.379562043805, 5811.244538210027, 5920.822375328747, 5951.22634057574, 5984.611000284989, 5992.640441573498, 5744.3394009689, 5853.414658534155, 5867.178594996704, 5868.853278668024, 5936.020556608154, 13349.132306400053, 13450.798238026437, 13536.729265414735, 16289.837101628951, 24623.876880615662, 2342.554914566227, 2349.8237632177484, 2359.858408495496, 2419.52819200256, 2957.985210073957, 11201.271917325348, 11477.827832582518, 11935.522579096825, 12473.75052498954, 14316.141031538036, 1963.4894927318858, 2074.4606402335503, 2080.4070839810734, 2125.2986514450195, 2129.7337832770904, 87357.56321218354, 87927.56036219842, 91894.0, 92303.0, 92357.0, 10498.895011049945, 11265.54937802495, 12001.759964800654, 12161.270323780602, 12536.310502922426, 14583.489577864935, 16420.507384778477, 17602.471925842245, 17613.38353157633, 17717.11414429299, 8239.299659529008, 8344.541050242295, 8401.95799021001, 8531.488110713377, 8533.317334613215, 8211.71259005932, 8216.46592971455, 8235.0, 8377.120402357787, 8429.620667069996, 4598.563136502027, 4622.214223581999, 4626.190416677068, 4633.208474483551, 4692.882677933079, 2135.829133669303, 2151.5159089204803, 2155.9353219403442, 2181.7054697615936, 2188.1794327127327, 922.3497434308796, 985.7979114281555, 1004.9648262310784, 1025.7435641089728, 1056.8784589772274, 19732.693489856993, 19982.90008549948, 20061.598768024556, 20187.697184542245, 20375.0, 969.5103972493846, 971.7862070344654, 1002.0280328081749, 1061.686802393296, 1101.8898110188918, 10492.632757853591, 10885.41950709213, 10948.45257737126, 10962.177836662282, 11040.227184097035, 486120.0, 491687.0, 498864.0, 509788.0, 537891.0, 58868.0, 67897.66051169712, 92907.53546232225, 93240.0, 93336.53331733299, 990.6384169778123, 999.4403134244847, 1024.446798728693, 1029.1355261580309, 1030.577463240083, 16631.750523742394, 17183.226754796313, 17414.0, 17578.472645820646, 17650.29398824084, 43764.781176093915, 43839.56160438482, 43939.34090988702, 44293.0, 45413.772931135136, 57537.42462575488, 58816.411835881096, 59441.0, 59783.402165977786, 60024.49938751566, 7915.0897646771355, 8251.133630968901, 8410.369222308229, 8544.74365769003, 8992.550372481219, 10585.9470702646, 13319.400626972003, 13380.732385352043, 13491.527796527074, 13752.0, 11934.820977685515, 11964.341961192218, 11986.741392154046, 12147.635570932885, 12226.388680566113, 11455.656330310105, 11604.767904642029, 11741.0, 11924.582639607572, 12123.211991220542, 11000.0, 11762.0, 12218.389080546114, 12248.020158387486, 12461.0, 7789.688412463438, 9044.276457883221, 9098.499582523025, 9421.528923553658, 9530.475823829756, 10847.186461015297, 11450.807665095408, 11573.479193436484, 11583.189176757545, 12146.514139434325], "value": 9429.139633112303, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.5147475595675, 1562.7108984837805, 1567.0362726922942, 1763.6825371433144, 1909.6849019911715, 8553.358498112642, 9142.90857091429, 9576.61693532258, 9586.041395860411, 9914.851277230848, 9683.564239609217, 9765.95117024414, 9779.266555008368, 9781.559829807658, 9786.119249267564, 2573.9999999999955, 2602.3884387169, 2605.557055300594, 2606.609008648699, 2607.439400528886, 2493.9002439902383, 2551.8468891866455, 2552.1833013435707, 2558.769710726034, 2562.0392352867675, 2508.3352911478473, 2523.558377283968, 2554.910578129766, 2558.0663057983793, 2559.539282929072, 2462.2982450001664, 2489.439876027888, 2496.226169887341, 2497.4880149569294, 2497.887595058218, 2426.502566973784, 2445.7431969643108, 2449.3386785567977, 2455.9508809823706, 2468.4445999650115, 9349.485778282191, 9596.376235544667, 9817.067378599022, 9824.557894894748, 9841.114299712988, 5633.774649014034, 5845.824625261249, 5851.0, 5860.472557469806, 5867.237259156283, 3676.3382591133586, 3701.407774756053, 3774.0942173878348, 3819.102510909934, 3831.8275677594297, 1241.6275117464725, 1264.974700505994, 1267.1889990406148, 1295.7538067767189, 1320.2936429010529, 13416.0, 13455.32723363828, 13533.39099740514, 13583.388747506386, 13627.04610677243, 4854.101991131652, 4875.488073752276, 4891.241857512091, 4939.2838038484215, 5062.443131255559, 10579.84130238047, 10581.84127238092, 10591.84112238317, 10604.151667866552, 10615.203859710553, 5735.0250457422335, 5740.971295143498, 5743.971280143573, 5744.0, 5744.971275143597, 4623.56076172763, 4807.18277892759, 4960.007998400334, 4960.875978100504, 5379.811706590251, 4183.435236243068, 4248.129133527619, 4352.499462561846, 4368.344748287719, 4369.9126017479475, 1288.664947113757, 1306.6406738146895, 1322.2661422910185, 1322.7751282282036, 1329.322045756671, 821.3470291118575, 821.5645707774889, 882.642529775442, 896.3053633434141, 974.6004138303261, 5905.350411454737, 6102.9694851525455, 6172.814815555541, 6179.62922224668, 6548.607083575001, 473.96682232244103, 507.59138893190595, 523.4765234765234, 532.8508017755034, 532.9920051199235, 4415.84544540946, 4419.248727716296, 4534.59188673021, 4543.114092751882, 4557.589816916494, 11368.772624547462, 11605.59380421698, 11694.94152529249, 11698.47356868943, 11750.412479375997, 11369.31784092957, 11844.526218951145, 11845.526178952918, 12250.693732656755, 12278.570250041384, 8701.738947831574, 8813.206811387006, 8827.602757876039, 8865.64537418509, 8868.423552469068, 6327.240731112296, 6604.405603495708, 6615.4376877965915, 6678.860935360567, 6700.162479690039, 10691.57233710674, 11135.721606959567, 11211.047060999581, 11255.66233013011, 11259.09927205838, 10122.089011988955, 10278.33190842593, 11520.0, 11575.652730418102, 11669.824952625548, 7982.321502672338, 8353.958230209053, 8385.706500272461, 8398.328133749408, 8402.285805706584, 9345.439273643604, 9369.672061477815, 9378.812423751624, 9403.153716165578, 9406.764830879009, 8338.833223335621, 8410.663573456994, 8432.831343372976, 8528.976522817302, 8603.397762156588, 8124.146964568635, 8226.712065077932, 8279.0, 8414.158584141536, 8638.26574741154, 7429.368503677032, 7515.361194298546, 7616.276453736886, 7665.348445382205, 7748.418868584991, 5324.387695414922, 5376.542993845567, 5424.972875135599, 5427.755750991294, 5536.972315138399, 5454.372747134131, 5515.834524964257, 5643.238162847963, 5651.321841379061, 5817.0983497557945], "value": 4908.160678335836, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.1603022971591, 368.63320995609365, 371.088976562539, 372.21834148288616, 373.07105307783627, 5616.831495055149, 5617.775288988446, 5654.519365853902, 5659.320881494216, 5667.093265077583, 5308.416074231841, 5537.58468114892, 5549.1676248562735, 5559.8888022239535, 5581.469760372758, 4371.519132895379, 4404.889877753049, 4426.734395936254, 4432.8005239764125, 4451.310046942729, 4429.5348988356245, 4441.2908126043085, 4443.60007599316, 4445.444319460067, 4464.866054018385, 4375.58431948966, 4382.0, 4383.890402739925, 4387.692861499696, 4428.202923473789, 4252.787360631972, 4323.783810809478, 4336.327869180266, 4350.12997400518, 4351.5648435156545, 3890.1441682830014, 3895.4935858338517, 3908.882733517999, 3910.335243008695, 3910.7262491625597, 5410.594205434608, 5445.319335083114, 5473.562115030788, 5478.616496845222, 5513.228148059275, 4791.185498465235, 4972.881101752113, 5010.248462730619, 5024.799008039674, 5090.0, 5781.075027995543, 5801.7099145042575, 5812.651240925558, 5818.505427038707, 5823.737931793079, 4230.259704551691, 4236.894077648052, 4261.637760790337, 4266.743995360288, 4273.18809426208, 5753.7986170484255, 5858.179854820329, 5869.475648923533, 6000.36996115406, 6061.969690151565, 4182.372644103348, 4278.0374415756205, 4282.528921818597, 4285.121550082225, 4285.18581469526, 4339.305711086211, 4377.956220437755, 4384.386185933972, 4388.780560972003, 4422.358757980075, 4750.643701722384, 4836.250381190921, 5019.397672279277, 5049.2173713074535, 5052.418971818214, 5614.550835933115, 5801.0856417382165, 5804.622699524517, 5813.215215945793, 5826.970865145647, 1507.1785876697006, 1515.8332583415815, 1518.9696206075816, 1526.6946610677687, 1527.2287494815048, 943.8961714211431, 963.4219468319093, 984.1487113646645, 989.4854675568664, 992.7170756334555, 4909.950900491021, 4912.361393018885, 4919.90160196794, 4943.678660887031, 4962.255661650781, 5238.633295669267, 5261.5264626183825, 5265.656782731648, 5267.920981185285, 5302.3637163540625, 4678.8128474861305, 4892.908329130185, 4914.827981020719, 4959.561727099101, 5053.772580233898, 2840.4887120318126, 2846.814957027828, 2851.344190836119, 2851.472477591652, 2869.985650071778, 5329.973350133225, 5371.435999220103, 5492.313460817398, 5496.0, 5506.944930550723, 4950.702957822542, 5271.262023316739, 5281.656692315064, 5361.973190134102, 5368.3826359968325, 5437.90039677388, 5451.591130665216, 5470.878469913659, 5479.917801232985, 5485.080221922375, 5273.709945953009, 5279.287296214962, 5298.97350513245, 5303.893922121613, 5310.778520940283, 5629.605927585029, 6002.079334613057, 6031.396860314109, 6031.457168854824, 6037.547183961133, 5939.316978547522, 6062.242219722535, 6075.270967483753, 6201.317855036033, 6244.157038799885, 4359.782010899506, 4380.233459144701, 4386.583274588909, 4395.780210989502, 4397.560243975705, 5849.210356601974, 6037.939620603914, 6066.545009124422, 6071.5446341523675, 6082.665453400105, 5846.853828654148, 5847.8245652630485, 5849.181114643869, 5866.560007999503, 5869.8239052828485, 5809.5352371811, 5839.970800145972, 5847.649141051551, 5855.092460668603, 5855.531557475307, 5620.662760234399, 5827.94172058274, 5841.766329346779, 5843.181954526454, 5857.26784151981, 5879.529637629065, 5918.496927761188, 5918.822435326947, 5929.229200204119, 5961.940380596312, 5619.157126431068, 5794.333651630117, 5813.883722325614, 5817.854553636193, 5819.915444814255], "value": 4356.503375478632, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.3388054488297, 813.0446725098009, 813.4590497319283, 823.7034667519696, 856.9400141990061, 16873.40943066993, 18231.817681823177, 18274.634507309846, 18291.634167316646, 18300.816991830077, 16293.266802993865, 16459.67080658386, 16530.256138473767, 16532.09073500957, 16545.834541654578, 705.0411440440996, 728.9927100729004, 844.5819319436887, 869.0614136732346, 872.6378552900538, 862.4092496639822, 863.7840539865034, 863.8401895649325, 864.3690106222462, 864.567716141929, 759.9240075992412, 932.3287233192091, 934.1639232886563, 935.9812803743955, 937.6202637931615, 770.3182683325269, 917.1928702741578, 938.2072149034055, 950.3442624589012, 953.0802775321779, 671.8924972004456, 672.5661948043534, 673.7810211681223, 675.6790524500872, 675.8614484030762, 16054.357825686959, 16058.43795467153, 16138.435154769644, 16147.192640367935, 16155.43455979035, 16739.414120505844, 16941.152942352834, 17087.572810679834, 17928.013959232238, 17975.1012449377, 13689.589312320646, 13736.450541978309, 13821.930890345484, 13999.790003149961, 14190.787138192936, 3950.249452603996, 4014.7189696721243, 4021.2158629067344, 4031.173609410064, 4044.2315959967514, 89187.55406222992, 90226.54886725525, 92197.0, 93168.06831931662, 93422.53288733581, 12003.759924801456, 12627.558035468715, 12749.00794143508, 13001.219926804422, 13007.934960325138, 25639.0, 25682.229533114038, 25700.100496482908, 25713.0, 25718.09986650458, 8924.0, 9079.909200908038, 9136.634534618674, 9348.205402540723, 9386.765330866647, 4813.205821039489, 4825.179719447702, 4944.184209605447, 4976.353074100344, 5030.4718004608985, 3857.1321452672923, 4012.61880121388, 4093.570175131628, 4098.692598055158, 4098.7130900836655, 664.7872680742213, 676.5298117808175, 678.1218322272669, 680.1532092544813, 684.8596037812237, 576.9048107062372, 585.7569108819878, 662.215274899246, 681.7750142452978, 752.7779305105007, 10066.69799906004, 10223.488825558692, 10454.215933804995, 10597.099246563974, 10645.361278323171, 643.2409756487297, 662.1855118204635, 668.4485299627827, 669.5045666206972, 703.8170075780334, 4399.802008909607, 4550.431196100488, 4646.163690535736, 4684.484706682262, 4690.343351930733, 77707.61146194345, 78825.21174788293, 138113.3094334542, 139273.30363348118, 139731.0, 89232.0, 89613.0, 91060.0, 106993.0, 107126.0, 83354.0, 87446.0, 92085.07914920899, 92188.53905730428, 96828.99999999859, 9722.173615242784, 10678.46607669629, 10678.946605266923, 10812.945935270272, 10924.563017479211, 48021.519784801705, 54735.45264547304, 54892.0, 55792.16311755246, 55860.16209756938, 70317.29682703108, 75692.0, 79127.0, 79707.60146199232, 82441.58779206066, 12426.875731242571, 12911.806322904977, 13084.934575327063, 13265.33673316311, 13854.238016909167, 13234.205947643171, 13316.667083322995, 13467.865321347053, 13746.518871839839, 13916.304184790517, 11068.319072095466, 13680.31598420095, 14036.908539176988, 14603.415863365346, 14831.11013339203, 13909.095908765898, 13920.025598208029, 14113.576592702235, 14585.92707036458, 15005.32476038559, 13560.86439135596, 14362.784558231844, 14366.784498232326, 14422.350994205495, 14638.341274642453, 11643.41782910834, 12254.816177757519, 12296.077794165294, 12417.62747117588, 12512.74974500523, 11697.883021169679, 11986.0, 12086.939565302117, 12248.632541023784, 12290.815637765261], "value": 8024.051442932272, "unit": "score"}], "name": "dromaeo_css", "value": 7601.8285839574055, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 109.0, 111.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 115.0, 160.0, 121.0, 119.0, 121.0, 117.0, 149.0, 123.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 161.0, 160.0, 160.0, 159.0, 161.0, 160.0, 160.0, 159.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 77.0, 115.0, 76.0, 77.0, 75.0, 77.0, 99.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 112.0, 83.0, 83.0, 82.0, 100.0, 80.0, 80.0, 105.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 51.0, 51.0, 50.0, 51.0, 51.0, 50.0, 50.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 61.0, 58.0, 58.0, 58.0, 59.0, 59.0, 59.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 74.0, 73.0, 74.0, 73.0, 73.0, 72.0, 80.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 130.0, 128.0, 121.0, 132.0, 130.0, 118.0, 119.0, 153.0, 126.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 152.0, 153.0, 165.0, 159.0, 155.0, 152.0, 154.0, 151.0, 151.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 66.0, 62.0, 63.0, 62.0, 61.0, 62.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1452.7000000000003, "alertThreshold": 2.0}]} 04:01:16 INFO - Return code: 0 04:01:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:01:16 INFO - # TBPL SUCCESS # 04:01:16 INFO - Running post-action listener: _resource_record_post_action 04:01:16 INFO - [mozharness: 2016-10-30 11:01:16.404734Z] Finished run-tests step (success) 04:01:16 INFO - Running post-run listener: _resource_record_post_run 04:01:16 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 1994752; Write bytes: 356368384; Read time: 60; Write time: 263544 04:01:16 INFO - TinderboxPrint: CPU usage
13.0% 04:01:16 INFO - TinderboxPrint: I/O read bytes / time
1,994,752 / 60 04:01:16 INFO - TinderboxPrint: I/O write bytes / time
356,368,384 / 263,544 04:01:16 INFO - TinderboxPrint: CPU idle
8,270.0 (87.0%) 04:01:16 INFO - TinderboxPrint: CPU user
1,189.2 (12.5%) 04:01:16 INFO - TinderboxPrint: Swap in / out
0 / 0 04:01:16 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108015616; Read time: 0; Write time: 98316 04:01:16 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248352768; Read time: 28; Write time: 165228 04:01:17 INFO - Running post-run listener: _upload_blobber_files 04:01:17 INFO - Blob upload gear active. 04:01:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:01:17 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 04:01:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:01:17 INFO - (blobuploader) - INFO - Open directory for files ... 04:01:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:01:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:01:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:20 INFO - (blobuploader) - INFO - Done attempting. 04:01:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:01:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:01:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:21 INFO - (blobuploader) - INFO - Done attempting. 04:01:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:01:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:01:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:22 INFO - (blobuploader) - INFO - Done attempting. 04:01:22 INFO - (blobuploader) - INFO - Iteration through files over. 04:01:22 INFO - Return code: 0 04:01:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:01:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:01:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dddf2095244854d5b3dbbc96c8bd6ee5aef3473110d32375e9abab6410a7748d99e9306b000640474e334485e2ee4e2d3c75e5cce4fbadb27378a9c0c1b133db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e9351e10380697f9a050fb3c3789f5cf3a2c478838eb26c8926c927f535bcae53149c104204039445e41f909f0a0da3667c5b664c2358da454ddad9810434a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/366a9985d04c19b91a14d86b0b1a944f51bcbf4e2b67f46a6b1a50ce67d06a3e3e32528f8607b98a6962bf9f93343798194321f2e74de52f32c34440a099dc54"} 04:01:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:01:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:01:22 INFO - Contents: 04:01:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dddf2095244854d5b3dbbc96c8bd6ee5aef3473110d32375e9abab6410a7748d99e9306b000640474e334485e2ee4e2d3c75e5cce4fbadb27378a9c0c1b133db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e9351e10380697f9a050fb3c3789f5cf3a2c478838eb26c8926c927f535bcae53149c104204039445e41f909f0a0da3667c5b664c2358da454ddad9810434a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/366a9985d04c19b91a14d86b0b1a944f51bcbf4e2b67f46a6b1a50ce67d06a3e3e32528f8607b98a6962bf9f93343798194321f2e74de52f32c34440a099dc54"} 04:01:22 INFO - Running post-run listener: copy_logs_to_upload_dir 04:01:22 INFO - Copying logs to upload dir... 04:01:22 INFO - mkdir: /builds/slave/test/build/upload/logs 04:01:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.285807 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-30 04:01:21.376427) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 04:01:21.381790) ========= 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=fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dddf2095244854d5b3dbbc96c8bd6ee5aef3473110d32375e9abab6410a7748d99e9306b000640474e334485e2ee4e2d3c75e5cce4fbadb27378a9c0c1b133db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e9351e10380697f9a050fb3c3789f5cf3a2c478838eb26c8926c927f535bcae53149c104204039445e41f909f0a0da3667c5b664c2358da454ddad9810434a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/366a9985d04c19b91a14d86b0b1a944f51bcbf4e2b67f46a6b1a50ce67d06a3e3e32528f8607b98a6962bf9f93343798194321f2e74de52f32c34440a099dc54"} build_url:https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011472 build_url: 'https://queue.taskcluster.net/v1/task/BZHqJBKuTX2vjuGeQuINZQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dddf2095244854d5b3dbbc96c8bd6ee5aef3473110d32375e9abab6410a7748d99e9306b000640474e334485e2ee4e2d3c75e5cce4fbadb27378a9c0c1b133db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e9351e10380697f9a050fb3c3789f5cf3a2c478838eb26c8926c927f535bcae53149c104204039445e41f909f0a0da3667c5b664c2358da454ddad9810434a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/366a9985d04c19b91a14d86b0b1a944f51bcbf4e2b67f46a6b1a50ce67d06a3e3e32528f8607b98a6962bf9f93343798194321f2e74de52f32c34440a099dc54"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 04:01:21.407062) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 04:01:21.407416) ========= 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=fa44defc139c4ba8574fe040000001db-1477815275.538544-276992772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 04:01:21.492276) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 04:01:21.492597) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 04:01:21.492904) ========= ========= Total master_lag: 0.16 =========