builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1483102429.21 results: success (0) buildid: 20161230030919 builduid: 5d61c68c47004798acd504c02cb44838 revision: 31e8e7e5ef88b5d4f17e5139beb1eb6efd46a9fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 04:53:49.215131) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 04:53:49.216158) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 04:53:49.216677) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 04:53:49.232329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 04:53:49.232811) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-30 04:53:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 28.3M=0s 2016-12-30 04:53:50 (28.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.074478 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 04:53:49.486884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 04:53:49.487484) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021607 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 04:53:49.549881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 04:53:49.550497) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 31e8e7e5ef88b5d4f17e5139beb1eb6efd46a9fe --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-beta --rev 31e8e7e5ef88b5d4f17e5139beb1eb6efd46a9fe --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=a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-30 04:53:50,442 truncating revision to first 12 chars 2016-12-30 04:53:50,442 Setting DEBUG logging. 2016-12-30 04:53:50,442 attempt 1/10 2016-12-30 04:53:50,442 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/31e8e7e5ef88?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-30 04:53:50,756 unpacking tar archive at: mozilla-beta-31e8e7e5ef88/testing/mozharness/ program finished with exit code 0 elapsedTime=0.690313 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 04:53:50.262064) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 04:53:50.262409) ========= script_repo_revision: 31e8e7e5ef88b5d4f17e5139beb1eb6efd46a9fe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 04:53:50.262840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 04:53:50.263137) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 04:53:50.273668) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-12-30 04:53:50.274089) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:53:51 INFO - MultiFileLogger online at 20161230 04:53:51 in /builds/slave/test 04:53:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:53:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:53:51 INFO - {'append_to_log': False, 04:53:51 INFO - 'base_work_dir': '/builds/slave/test', 04:53:51 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:53:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:53:51 INFO - 'branch': 'Mozilla-Beta', 04:53:51 INFO - 'buildbot_json_path': 'buildprops.json', 04:53:51 INFO - 'config_files': ('talos/linux_config.py',), 04:53:51 INFO - 'default_actions': ('clobber', 04:53:51 INFO - 'read-buildbot-config', 04:53:51 INFO - 'download-and-extract', 04:53:51 INFO - 'populate-webroot', 04:53:51 INFO - 'create-virtualenv', 04:53:51 INFO - 'install', 04:53:51 INFO - 'run-tests'), 04:53:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:53:51 INFO - 'download_minidump_stackwalk': True, 04:53:51 INFO - 'download_symbols': 'ondemand', 04:53:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:53:51 INFO - 'tooltool.py': '/tools/tooltool.py', 04:53:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:53:51 INFO - '/tools/misc-python/virtualenv.py')}, 04:53:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:53:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:53:51 INFO - 'installer_path': 'installer.exe', 04:53:51 INFO - 'log_level': 'info', 04:53:51 INFO - 'log_name': 'talos', 04:53:51 INFO - 'log_to_console': True, 04:53:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:53:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:53:51 INFO - 'opt_config_files': (), 04:53:51 INFO - 'pip_index': False, 04:53:51 INFO - 'sps_profile': False, 04:53:51 INFO - 'sps_profile_interval': 0, 04:53:51 INFO - 'suite': 'dromaeojs', 04:53:51 INFO - 'system_bits': '32', 04:53:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:53:51 INFO - 'title': 'talos-linux64-ix-064', 04:53:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:53:51 INFO - 'use_talos_json': True, 04:53:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:53:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:53:51 INFO - 'work_dir': 'build'} 04:53:51 INFO - [mozharness: 2016-12-30 12:53:51.261679Z] Running clobber step. 04:53:51 INFO - Running pre-action listener: _resource_record_pre_action 04:53:51 INFO - Running main action method: clobber 04:53:51 INFO - rmtree: /builds/slave/test/build 04:53:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:53:52 INFO - Running post-action listener: _resource_record_post_action 04:53:52 INFO - [mozharness: 2016-12-30 12:53:52.231759Z] Finished clobber step (success) 04:53:52 INFO - [mozharness: 2016-12-30 12:53:52.231858Z] Running read-buildbot-config step. 04:53:52 INFO - Running pre-action listener: _resource_record_pre_action 04:53:52 INFO - Running main action method: read_buildbot_config 04:53:52 INFO - Using buildbot properties: 04:53:52 INFO - { 04:53:52 INFO - "project": "", 04:53:52 INFO - "product": "firefox", 04:53:52 INFO - "script_repo_revision": "production", 04:53:52 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 04:53:52 INFO - "repository": "", 04:53:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 04:53:52 INFO - "buildid": "20161230030919", 04:53:52 INFO - "pgo_build": "True", 04:53:52 INFO - "basedir": "/builds/slave/test", 04:53:52 INFO - "buildnumber": 38, 04:53:52 INFO - "slavename": "talos-linux64-ix-064", 04:53:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:53:52 INFO - "platform": "ubuntu64_hw", 04:53:52 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:53:52 INFO - "branch": "mozilla-beta", 04:53:52 INFO - "repo_path": "releases/mozilla-beta", 04:53:52 INFO - "revision": "31e8e7e5ef88b5d4f17e5139beb1eb6efd46a9fe", 04:53:52 INFO - "stage_platform": "linux64-pgo", 04:53:52 INFO - "builduid": "5d61c68c47004798acd504c02cb44838", 04:53:52 INFO - "slavebuilddir": "test" 04:53:52 INFO - } 04:53:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 04:53:52 INFO - Running post-action listener: _resource_record_post_action 04:53:52 INFO - [mozharness: 2016-12-30 12:53:52.234378Z] Finished read-buildbot-config step (success) 04:53:52 INFO - [mozharness: 2016-12-30 12:53:52.234469Z] Running download-and-extract step. 04:53:52 INFO - Running pre-action listener: _resource_record_pre_action 04:53:52 INFO - Running main action method: download_and_extract 04:53:52 INFO - mkdir: /builds/slave/test/build/tests 04:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:52 INFO - trying https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 04:53:52 INFO - Downloading https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 04:53:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:53:52 INFO - Downloaded 1327 bytes. 04:53:52 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 04:53:52 INFO - Using the following test package requirements: 04:53:52 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 04:53:52 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 04:53:52 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:53:52 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 04:53:52 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 04:53:52 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 04:53:52 INFO - u'jsshell-linux-x86_64.zip'], 04:53:52 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 04:53:52 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:53:52 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 04:53:52 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 04:53:52 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 04:53:52 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 04:53:52 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 04:53:52 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 04:53:52 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:53:52 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 04:53:52 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:53:52 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:53:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 04:53:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:53:52 INFO - Fetch https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 04:53:53 INFO - Expected file size: 21963638 04:53:57 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:53:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 04:53:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:53:57 INFO - Fetch https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 04:53:58 INFO - Expected file size: 21963638 04:54:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 04:54:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:54:02 INFO - Fetch https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 04:54:03 INFO - Expected file size: 14414089 04:54:03 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')]} 04:54:03 INFO - trying https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 04:54:03 INFO - Downloading https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 04:54:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:54:04 INFO - Downloaded 56959268 bytes. 04:54:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 04:54:04 INFO - mkdir: /builds/slave/test/properties 04:54:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:54:04 INFO - Writing to file /builds/slave/test/properties/build_url 04:54:04 INFO - Contents: 04:54:04 INFO - build_url:https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 04:54:05 INFO - Running post-action listener: _resource_record_post_action 04:54:05 INFO - Running post-action listener: set_extra_try_arguments 04:54:05 INFO - [mozharness: 2016-12-30 12:54:05.590437Z] Finished download-and-extract step (success) 04:54:05 INFO - [mozharness: 2016-12-30 12:54:05.590737Z] Running populate-webroot step. 04:54:05 INFO - Running pre-action listener: _resource_record_pre_action 04:54:05 INFO - Running main action method: populate_webroot 04:54:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:54:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:54:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:54:05 INFO - '--tppagecycles', 04:54:05 INFO - '7'], 04:54:05 INFO - 'tests': ['tsvgm']}}, 04:54:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:54:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:54:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:54:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:54:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:54:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:54:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:05 INFO - 'talos_options': ['--disable-e10s'], 04:54:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:05 INFO - 'talos_options': ['--disable-e10s'], 04:54:05 INFO - 'tests': ['damp', 'tps']}, 04:54:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:05 INFO - 'tests': ['damp', 'tps']}, 04:54:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:54:05 INFO - 'tests': ['dromaeo_dom']}, 04:54:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:54:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:54:05 INFO - 'tests': ['basic_compositor_video']}, 04:54:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:54:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:54:05 INFO - 'tests': ['a11yr', 04:54:05 INFO - 'ts_paint', 04:54:05 INFO - 'tpaint', 04:54:05 INFO - 'sessionrestore', 04:54:05 INFO - 'sessionrestore_no_auto_restore', 04:54:05 INFO - 'tabpaint']}, 04:54:05 INFO - 'other-e10s': {'tests': ['a11yr', 04:54:05 INFO - 'ts_paint', 04:54:05 INFO - 'tpaint', 04:54:05 INFO - 'sessionrestore', 04:54:05 INFO - 'sessionrestore_no_auto_restore', 04:54:05 INFO - 'tabpaint']}, 04:54:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:54:05 INFO - 'ts_paint', 04:54:05 INFO - 'tpaint', 04:54:05 INFO - 'sessionrestore', 04:54:05 INFO - 'sessionrestore_no_auto_restore', 04:54:05 INFO - 'tabpaint']}, 04:54:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:54:05 INFO - 'ts_paint', 04:54:05 INFO - 'tpaint', 04:54:05 INFO - 'sessionrestore', 04:54:05 INFO - 'sessionrestore_no_auto_restore', 04:54:05 INFO - 'tabpaint']}, 04:54:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:54:05 INFO - 'tests': ['a11yr', 04:54:05 INFO - 'ts_paint', 04:54:05 INFO - 'tpaint', 04:54:05 INFO - 'sessionrestore', 04:54:05 INFO - 'sessionrestore_no_auto_restore', 04:54:05 INFO - 'tabpaint']}, 04:54:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:54:05 INFO - 'tests': ['a11yr', 04:54:05 INFO - 'ts_paint', 04:54:05 INFO - 'tpaint', 04:54:05 INFO - 'sessionrestore', 04:54:05 INFO - 'sessionrestore_no_auto_restore', 04:54:05 INFO - 'tabpaint']}, 04:54:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:54:05 INFO - 'tests': ['tsvgx', 04:54:05 INFO - 'tsvgr_opacity', 04:54:05 INFO - 'tart', 04:54:05 INFO - 'tscrollx', 04:54:05 INFO - 'cart']}, 04:54:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:54:05 INFO - 'tsvgr_opacity', 04:54:05 INFO - 'tart', 04:54:05 INFO - 'tscrollx', 04:54:05 INFO - 'cart']}, 04:54:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:05 INFO - 'talos_options': ['--disable-e10s'], 04:54:05 INFO - 'tests': ['tp5o']}, 04:54:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:05 INFO - 'tests': ['tp5o']}, 04:54:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:05 INFO - 'talos_options': ['--disable-e10s', 04:54:05 INFO - '--xperf_path', 04:54:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:05 INFO - 'tests': ['tp5n']}, 04:54:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:54:05 INFO - 'talos_options': ['--xperf_path', 04:54:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:05 INFO - 'tests': ['tp5n']}}, 04:54:05 INFO - 'talos.zip': {'path': '', 04:54:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:54:05 INFO - Running post-action listener: _resource_record_post_action 04:54:05 INFO - [mozharness: 2016-12-30 12:54:05.610619Z] Finished populate-webroot step (success) 04:54:05 INFO - [mozharness: 2016-12-30 12:54:05.610730Z] Running create-virtualenv step. 04:54:05 INFO - Running pre-action listener: _resource_record_pre_action 04:54:05 INFO - Running main action method: create_virtualenv 04:54:05 INFO - Creating virtualenv /builds/slave/test/build/venv 04:54:05 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 04:54:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:54:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:54:05 INFO - Using real prefix '/usr' 04:54:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:54:06 INFO - Installing distribute.............................................................................................................................................................................................done. 04:54:08 INFO - Installing pip.................done. 04:54:08 INFO - Return code: 0 04:54:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7251974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', '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 04:54: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', 'pip>=1.5'] in /builds/slave/test/build 04:54: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 pip>=1.5 04:54:08 INFO - Using env: {'DISPLAY': ':0', 04:54:08 INFO - 'HOME': '/home/cltbld', 04:54:08 INFO - 'LANG': 'en_US.UTF-8', 04:54:08 INFO - 'LANGUAGE': 'en_US:en', 04:54:08 INFO - 'LOGNAME': 'cltbld', 04:54:08 INFO - 'MAIL': '/var/mail/cltbld', 04:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:08 INFO - 'MOZ_NO_REMOTE': '1', 04:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:08 INFO - 'NO_EM_RESTART': '1', 04:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:08 INFO - 'PWD': '/builds/slave/test', 04:54:08 INFO - 'SHELL': '/bin/bash', 04:54:08 INFO - 'SHLVL': '1', 04:54:08 INFO - 'TERM': 'linux', 04:54:08 INFO - 'TMOUT': '86400', 04:54:08 INFO - 'USER': 'cltbld', 04:54:08 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', 04:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:08 INFO - '_': '/tools/buildbot/bin/python'} 04:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:08 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 04:54:08 INFO - Cleaning up... 04:54:08 INFO - Return code: 0 04:54:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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', '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 0x7f7251974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', '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 04:54: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:54: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 psutil>=3.1.1 04:54:08 INFO - Using env: {'DISPLAY': ':0', 04:54:08 INFO - 'HOME': '/home/cltbld', 04:54:08 INFO - 'LANG': 'en_US.UTF-8', 04:54:08 INFO - 'LANGUAGE': 'en_US:en', 04:54:08 INFO - 'LOGNAME': 'cltbld', 04:54:08 INFO - 'MAIL': '/var/mail/cltbld', 04:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:08 INFO - 'MOZ_NO_REMOTE': '1', 04:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:08 INFO - 'NO_EM_RESTART': '1', 04:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:08 INFO - 'PWD': '/builds/slave/test', 04:54:08 INFO - 'SHELL': '/bin/bash', 04:54:08 INFO - 'SHLVL': '1', 04:54:08 INFO - 'TERM': 'linux', 04:54:08 INFO - 'TMOUT': '86400', 04:54:08 INFO - 'USER': 'cltbld', 04:54:08 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', 04:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:08 INFO - '_': '/tools/buildbot/bin/python'} 04:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:08 INFO - Downloading/unpacking psutil>=3.1.1 04:54:08 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 04:54:08 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 04:54:08 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 04:54:08 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 04:54:08 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 04:54:08 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 04:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:54:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:10 INFO - Installing collected packages: psutil 04:54:10 INFO - Running setup.py install for psutil 04:54:10 INFO - building 'psutil._psutil_linux' extension 04:54:10 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 04:54:10 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 04:54:11 INFO - building 'psutil._psutil_posix' extension 04:54:11 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 04:54:11 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 04:54:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:11 INFO - Successfully installed psutil 04:54:11 INFO - Cleaning up... 04:54:11 INFO - Return code: 0 04:54:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7251974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', '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 04:54: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:54: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 mozsystemmonitor==0.3 04:54:11 INFO - Using env: {'DISPLAY': ':0', 04:54:11 INFO - 'HOME': '/home/cltbld', 04:54:11 INFO - 'LANG': 'en_US.UTF-8', 04:54:11 INFO - 'LANGUAGE': 'en_US:en', 04:54:11 INFO - 'LOGNAME': 'cltbld', 04:54:11 INFO - 'MAIL': '/var/mail/cltbld', 04:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:11 INFO - 'MOZ_NO_REMOTE': '1', 04:54:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:11 INFO - 'NO_EM_RESTART': '1', 04:54:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:11 INFO - 'PWD': '/builds/slave/test', 04:54:11 INFO - 'SHELL': '/bin/bash', 04:54:11 INFO - 'SHLVL': '1', 04:54:11 INFO - 'TERM': 'linux', 04:54:11 INFO - 'TMOUT': '86400', 04:54:11 INFO - 'USER': 'cltbld', 04:54:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', 04:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:11 INFO - '_': '/tools/buildbot/bin/python'} 04:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:54:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:54:13 INFO - Installing collected packages: mozsystemmonitor 04:54:13 INFO - Running setup.py install for mozsystemmonitor 04:54:13 INFO - Successfully installed mozsystemmonitor 04:54:13 INFO - Cleaning up... 04:54:13 INFO - Return code: 0 04:54:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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', '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 0x7f7251974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', '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 04:54: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:54: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 jsonschema==2.5.1 04:54:13 INFO - Using env: {'DISPLAY': ':0', 04:54:13 INFO - 'HOME': '/home/cltbld', 04:54:13 INFO - 'LANG': 'en_US.UTF-8', 04:54:13 INFO - 'LANGUAGE': 'en_US:en', 04:54:13 INFO - 'LOGNAME': 'cltbld', 04:54:13 INFO - 'MAIL': '/var/mail/cltbld', 04:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:13 INFO - 'MOZ_NO_REMOTE': '1', 04:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:13 INFO - 'NO_EM_RESTART': '1', 04:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:13 INFO - 'PWD': '/builds/slave/test', 04:54:13 INFO - 'SHELL': '/bin/bash', 04:54:13 INFO - 'SHLVL': '1', 04:54:13 INFO - 'TERM': 'linux', 04:54:13 INFO - 'TMOUT': '86400', 04:54:13 INFO - 'USER': 'cltbld', 04:54:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', 04:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:13 INFO - '_': '/tools/buildbot/bin/python'} 04:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:13 INFO - Downloading/unpacking jsonschema==2.5.1 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:54:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:54:15 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 04:54:15 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 04:54:15 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 04:54:15 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 04:54:15 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 04:54:15 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 04:54:16 INFO - Downloading functools32-3.2.3-2.tar.gz 04:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:54:16 INFO - warning: no files found matching '*.txt' 04:54:16 INFO - no previously-included directories found matching 'build' 04:54:16 INFO - no previously-included directories found matching 'dist' 04:54:16 INFO - no previously-included directories found matching '.git*' 04:54:16 INFO - Installing collected packages: jsonschema, functools32 04:54:16 INFO - Running setup.py install for functools32 04:54:16 INFO - warning: no files found matching '*.txt' 04:54:16 INFO - no previously-included directories found matching 'build' 04:54:16 INFO - no previously-included directories found matching 'dist' 04:54:16 INFO - no previously-included directories found matching '.git*' 04:54:16 INFO - Successfully installed jsonschema functools32 04:54:16 INFO - Cleaning up... 04:54:16 INFO - Return code: 0 04:54:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:54:16 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')]} 04:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:16 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')]} 04:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:16 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 0x7f7251974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', '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 04:54:16 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 04:54:16 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 04:54:16 INFO - Using env: {'DISPLAY': ':0', 04:54:16 INFO - 'HOME': '/home/cltbld', 04:54:16 INFO - 'LANG': 'en_US.UTF-8', 04:54:16 INFO - 'LANGUAGE': 'en_US:en', 04:54:16 INFO - 'LOGNAME': 'cltbld', 04:54:16 INFO - 'MAIL': '/var/mail/cltbld', 04:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:16 INFO - 'MOZ_NO_REMOTE': '1', 04:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:16 INFO - 'NO_EM_RESTART': '1', 04:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:16 INFO - 'PWD': '/builds/slave/test', 04:54:16 INFO - 'SHELL': '/bin/bash', 04:54:16 INFO - 'SHLVL': '1', 04:54:16 INFO - 'TERM': 'linux', 04:54:16 INFO - 'TMOUT': '86400', 04:54:16 INFO - 'USER': 'cltbld', 04:54:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', 04:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:16 INFO - '_': '/tools/buildbot/bin/python'} 04:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:54:16 INFO - Cleaning up... 04:54:16 INFO - Return code: 0 04:54:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:54:16 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')]} 04:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:16 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')]} 04:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:16 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 0x7f7251974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', '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 04:54:16 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 04:54:16 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 04:54:16 INFO - Using env: {'DISPLAY': ':0', 04:54:16 INFO - 'HOME': '/home/cltbld', 04:54:16 INFO - 'LANG': 'en_US.UTF-8', 04:54:16 INFO - 'LANGUAGE': 'en_US:en', 04:54:16 INFO - 'LOGNAME': 'cltbld', 04:54:16 INFO - 'MAIL': '/var/mail/cltbld', 04:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:16 INFO - 'MOZ_NO_REMOTE': '1', 04:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:16 INFO - 'NO_EM_RESTART': '1', 04:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:16 INFO - 'PWD': '/builds/slave/test', 04:54:16 INFO - 'SHELL': '/bin/bash', 04:54:16 INFO - 'SHLVL': '1', 04:54:16 INFO - 'TERM': 'linux', 04:54:16 INFO - 'TMOUT': '86400', 04:54:16 INFO - 'USER': 'cltbld', 04:54:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', 04:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:16 INFO - '_': '/tools/buildbot/bin/python'} 04:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:16 INFO - Downloading/unpacking blobuploader==1.2.4 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54: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 04:54:18 INFO - Downloading blobuploader-1.2.4.tar.gz 04:54:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:54:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:54:18 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 04:54:18 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 04:54:18 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 04:54:18 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 04:54:18 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 04:54:18 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 04:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:54:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:54:19 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 04:54:19 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 04:54:19 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 04:54:19 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 04:54:19 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 04:54:19 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 04:54:19 INFO - Downloading docopt-0.6.1.tar.gz 04:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:54:19 INFO - Installing collected packages: blobuploader, requests, docopt 04:54:19 INFO - Running setup.py install for blobuploader 04:54:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:54:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:54:19 INFO - Running setup.py install for requests 04:54:20 INFO - Running setup.py install for docopt 04:54:20 INFO - Successfully installed blobuploader requests docopt 04:54:20 INFO - Cleaning up... 04:54:20 INFO - Return code: 0 04:54:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:20 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 0x7f7251974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', '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 04:54:20 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 04:54:20 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 04:54:20 INFO - Using env: {'DISPLAY': ':0', 04:54:20 INFO - 'HOME': '/home/cltbld', 04:54:20 INFO - 'LANG': 'en_US.UTF-8', 04:54:20 INFO - 'LANGUAGE': 'en_US:en', 04:54:20 INFO - 'LOGNAME': 'cltbld', 04:54:20 INFO - 'MAIL': '/var/mail/cltbld', 04:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:20 INFO - 'MOZ_NO_REMOTE': '1', 04:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:20 INFO - 'NO_EM_RESTART': '1', 04:54:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:20 INFO - 'PWD': '/builds/slave/test', 04:54:20 INFO - 'SHELL': '/bin/bash', 04:54:20 INFO - 'SHLVL': '1', 04:54:20 INFO - 'TERM': 'linux', 04:54:20 INFO - 'TMOUT': '86400', 04:54:20 INFO - 'USER': 'cltbld', 04:54:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', 04:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:20 INFO - '_': '/tools/buildbot/bin/python'} 04:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:20 INFO - Running setup.py (path:/tmp/pip-QqWWo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:20 INFO - Running setup.py (path:/tmp/pip-gWUtLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:20 INFO - Running setup.py (path:/tmp/pip-FkqGaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:20 INFO - Running setup.py (path:/tmp/pip-MA5jdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:20 INFO - Running setup.py (path:/tmp/pip-jM7yiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:20 INFO - Running setup.py (path:/tmp/pip-BQjEMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:20 INFO - Running setup.py (path:/tmp/pip-6xiy1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:20 INFO - Running setup.py (path:/tmp/pip-dOo5oL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:21 INFO - Running setup.py (path:/tmp/pip-6Jvvuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:21 INFO - Running setup.py (path:/tmp/pip-2nTLDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:21 INFO - Running setup.py (path:/tmp/pip-77jnS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:21 INFO - Running setup.py (path:/tmp/pip-4GGCE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:21 INFO - Running setup.py (path:/tmp/pip-fWwD0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:21 INFO - Running setup.py (path:/tmp/pip-IroDEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:21 INFO - Running setup.py (path:/tmp/pip-3Uj2ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:21 INFO - Running setup.py (path:/tmp/pip-QgtbSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:21 INFO - Running setup.py (path:/tmp/pip-tzEfzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:54:21 INFO - Running setup.py install for manifestparser 04:54:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:54:21 INFO - Running setup.py install for mozcrash 04:54:21 INFO - Running setup.py install for mozdebug 04:54:21 INFO - Running setup.py install for mozdevice 04:54:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:54:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:54:22 INFO - Running setup.py install for mozfile 04:54:22 INFO - Running setup.py install for mozhttpd 04:54:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:54:22 INFO - Running setup.py install for mozinfo 04:54:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:54:22 INFO - Running setup.py install for mozInstall 04:54:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:54:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:54:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:54:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:54:22 INFO - Running setup.py install for mozleak 04:54:22 INFO - Running setup.py install for mozlog 04:54:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:54:22 INFO - Running setup.py install for moznetwork 04:54:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:54:22 INFO - Running setup.py install for mozprocess 04:54:22 INFO - Running setup.py install for mozprofile 04:54:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:54:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:54:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:54:23 INFO - Running setup.py install for mozrunner 04:54:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:54:23 INFO - Running setup.py install for mozscreenshot 04:54:23 INFO - Running setup.py install for moztest 04:54:23 INFO - Running setup.py install for mozversion 04:54:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:54:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:54:23 INFO - Cleaning up... 04:54:23 INFO - Return code: 0 04:54:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:23 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')]} 04:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:23 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')]} 04:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:23 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 0x7f7251974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', '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 04:54:23 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 04:54:23 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 04:54:23 INFO - Using env: {'DISPLAY': ':0', 04:54:23 INFO - 'HOME': '/home/cltbld', 04:54:23 INFO - 'LANG': 'en_US.UTF-8', 04:54:23 INFO - 'LANGUAGE': 'en_US:en', 04:54:23 INFO - 'LOGNAME': 'cltbld', 04:54:23 INFO - 'MAIL': '/var/mail/cltbld', 04:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:23 INFO - 'MOZ_NO_REMOTE': '1', 04:54:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:23 INFO - 'NO_EM_RESTART': '1', 04:54:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:23 INFO - 'PWD': '/builds/slave/test', 04:54:23 INFO - 'SHELL': '/bin/bash', 04:54:23 INFO - 'SHLVL': '1', 04:54:23 INFO - 'TERM': 'linux', 04:54:23 INFO - 'TMOUT': '86400', 04:54:23 INFO - 'USER': 'cltbld', 04:54:23 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', 04:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:23 INFO - '_': '/tools/buildbot/bin/python'} 04:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:23 INFO - Running setup.py (path:/tmp/pip-iRBNkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:23 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)) 04:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:23 INFO - Running setup.py (path:/tmp/pip-7Ka5Vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:23 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)) 04:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:23 INFO - Running setup.py (path:/tmp/pip-O_Rc1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:23 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)) 04:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:23 INFO - Running setup.py (path:/tmp/pip-k2rulj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:23 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)) 04:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:23 INFO - Running setup.py (path:/tmp/pip-722QA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:24 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)) 04:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:24 INFO - Running setup.py (path:/tmp/pip-bzQWm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:24 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)) 04:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:24 INFO - Running setup.py (path:/tmp/pip-k1wZQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:24 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)) 04:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:24 INFO - Running setup.py (path:/tmp/pip-2MIwCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:24 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)) 04:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:24 INFO - Running setup.py (path:/tmp/pip-gkqa9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:24 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)) 04:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:24 INFO - Running setup.py (path:/tmp/pip-OVIqJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:24 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)) 04:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:24 INFO - Running setup.py (path:/tmp/pip-EEsp2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:24 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)) 04:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:24 INFO - Running setup.py (path:/tmp/pip-H3KcJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:24 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)) 04:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:24 INFO - Running setup.py (path:/tmp/pip-iWxZ7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:24 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)) 04:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:24 INFO - Running setup.py (path:/tmp/pip-cTUTgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:24 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)) 04:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:24 INFO - Running setup.py (path:/tmp/pip-V4wEJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:24 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)) 04:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:24 INFO - Running setup.py (path:/tmp/pip-ULKCV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:24 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)) 04:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:24 INFO - Running setup.py (path:/tmp/pip-PLVJIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:24 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)) 04:54:24 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)) 04:54:24 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)) 04:54:24 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)) 04:54:24 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)) 04:54:24 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)) 04:54:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:54:24 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 04:54:24 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 04:54:24 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 04:54:24 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 04:54:24 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 04:54:24 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 04:54:26 INFO - Downloading blessings-1.6.tar.gz 04:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:54:26 INFO - Installing collected packages: blessings 04:54:26 INFO - Running setup.py install for blessings 04:54:27 INFO - Successfully installed blessings 04:54:27 INFO - Cleaning up... 04:54:27 INFO - Return code: 0 04:54:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:54:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:27 INFO - Reading from file tmpfile_stdout 04:54:27 INFO - Current package versions: 04:54:27 INFO - argparse == 1.2.1 04:54:27 INFO - blessings == 1.6 04:54:27 INFO - blobuploader == 1.2.4 04:54:27 INFO - docopt == 0.6.1 04:54:27 INFO - functools32 == 3.2.3-2 04:54:27 INFO - jsonschema == 2.5.1 04:54:27 INFO - manifestparser == 1.1 04:54:27 INFO - mozInstall == 1.12 04:54:27 INFO - mozcrash == 0.17 04:54:27 INFO - mozdebug == 0.1 04:54:27 INFO - mozdevice == 0.48 04:54:27 INFO - mozfile == 1.2 04:54:27 INFO - mozhttpd == 0.7 04:54:27 INFO - mozinfo == 0.9 04:54:27 INFO - mozleak == 0.1 04:54:27 INFO - mozlog == 3.4 04:54:27 INFO - moznetwork == 0.27 04:54:27 INFO - mozprocess == 0.23 04:54:27 INFO - mozprofile == 0.28 04:54:27 INFO - mozrunner == 6.12 04:54:27 INFO - mozscreenshot == 0.1 04:54:27 INFO - mozsystemmonitor == 0.3 04:54:27 INFO - moztest == 0.7 04:54:27 INFO - mozversion == 1.4 04:54:27 INFO - psutil == 3.1.1 04:54:27 INFO - requests == 1.2.3 04:54:27 INFO - wsgiref == 0.1.2 04:54:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:27 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 0x7f7251974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', '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 04:54:27 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 04:54:27 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 04:54:27 INFO - Using env: {'DISPLAY': ':0', 04:54:27 INFO - 'HOME': '/home/cltbld', 04:54:27 INFO - 'LANG': 'en_US.UTF-8', 04:54:27 INFO - 'LANGUAGE': 'en_US:en', 04:54:27 INFO - 'LOGNAME': 'cltbld', 04:54:27 INFO - 'MAIL': '/var/mail/cltbld', 04:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:27 INFO - 'MOZ_NO_REMOTE': '1', 04:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:27 INFO - 'NO_EM_RESTART': '1', 04:54:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:27 INFO - 'PWD': '/builds/slave/test', 04:54:27 INFO - 'SHELL': '/bin/bash', 04:54:27 INFO - 'SHLVL': '1', 04:54:27 INFO - 'TERM': 'linux', 04:54:27 INFO - 'TMOUT': '86400', 04:54:27 INFO - 'USER': 'cltbld', 04:54:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', 04:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:27 INFO - '_': '/tools/buildbot/bin/python'} 04:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:27 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)) 04:54:27 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)) 04:54:27 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)) 04:54:27 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)) 04:54:27 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)) 04:54:27 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)) 04:54:27 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)) 04:54:27 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)) 04:54:27 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)) 04:54:27 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)) 04:54:27 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)) 04:54:27 INFO - Cleaning up... 04:54:27 INFO - Return code: 0 04:54:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7251974f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', '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 04:54:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:54:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:54:27 INFO - Using env: {'DISPLAY': ':0', 04:54:27 INFO - 'HOME': '/home/cltbld', 04:54:27 INFO - 'LANG': 'en_US.UTF-8', 04:54:27 INFO - 'LANGUAGE': 'en_US:en', 04:54:27 INFO - 'LOGNAME': 'cltbld', 04:54:27 INFO - 'MAIL': '/var/mail/cltbld', 04:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:27 INFO - 'MOZ_NO_REMOTE': '1', 04:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:27 INFO - 'NO_EM_RESTART': '1', 04:54:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:27 INFO - 'PWD': '/builds/slave/test', 04:54:27 INFO - 'SHELL': '/bin/bash', 04:54:27 INFO - 'SHLVL': '1', 04:54:27 INFO - 'TERM': 'linux', 04:54:27 INFO - 'TMOUT': '86400', 04:54:27 INFO - 'USER': 'cltbld', 04:54:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', 04:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:27 INFO - '_': '/tools/buildbot/bin/python'} 04:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:54:27 INFO - Cleaning up... 04:54:27 INFO - Return code: 0 04:54:27 INFO - Running post-action listener: _resource_record_post_action 04:54:27 INFO - Running post-action listener: _start_resource_monitoring 04:54:27 INFO - Starting resource monitoring. 04:54:27 INFO - [mozharness: 2016-12-30 12:54:27.850366Z] Finished create-virtualenv step (success) 04:54:27 INFO - [mozharness: 2016-12-30 12:54:27.850873Z] Running install step. 04:54:27 INFO - Running pre-action listener: _resource_record_pre_action 04:54:27 INFO - Running main action method: install 04:54:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:28 INFO - Reading from file tmpfile_stdout 04:54:28 INFO - Detecting whether we're running mozinstall >=1.0... 04:54:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:54:28 INFO - Reading from file tmpfile_stdout 04:54:28 INFO - Output received: 04:54:28 INFO - Usage: mozinstall [options] installer 04:54:28 INFO - Options: 04:54:28 INFO - -h, --help show this help message and exit 04:54:28 INFO - -d DEST, --destination=DEST 04:54:28 INFO - Directory to install application into. [default: 04:54:28 INFO - "/builds/slave/test"] 04:54:28 INFO - --app=APP Application being installed. [default: firefox] 04:54:28 INFO - mkdir: /builds/slave/test/build/application 04:54:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:54:41 INFO - Reading from file tmpfile_stdout 04:54:41 INFO - Output received: 04:54:41 INFO - /builds/slave/test/build/application/firefox/firefox 04:54:41 INFO - Running post-action listener: _resource_record_post_action 04:54:41 INFO - [mozharness: 2016-12-30 12:54:41.650955Z] Finished install step (success) 04:54:41 INFO - [mozharness: 2016-12-30 12:54:41.651197Z] Running run-tests step. 04:54:41 INFO - Running pre-action listener: _resource_record_pre_action 04:54:41 INFO - Running main action method: run_tests 04:54:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:54:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:54:41 INFO - Python 2.7.3 04:54:41 INFO - Return code: 0 04:54:41 INFO - grabbing minidump binary from tooltool 04:54: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')]} 04:54: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 0x16b0f60>, '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 0x16b1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b21d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:54: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 04:54: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 04:54: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 04:54:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:54:41 INFO - Return code: 0 04:54:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:54:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:54:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:54:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:54:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:54:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 04:54:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 04:54:41 INFO - Using env: {'DISPLAY': ':0', 04:54:41 INFO - 'HOME': '/home/cltbld', 04:54:41 INFO - 'LANG': 'en_US.UTF-8', 04:54:41 INFO - 'LANGUAGE': 'en_US:en', 04:54:41 INFO - 'LOGNAME': 'cltbld', 04:54:41 INFO - 'MAIL': '/var/mail/cltbld', 04:54:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:54:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:41 INFO - 'MOZ_NO_REMOTE': '1', 04:54:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:54:41 INFO - 'NO_EM_RESTART': '1', 04:54:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:41 INFO - 'PWD': '/builds/slave/test', 04:54:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:54:41 INFO - 'SHELL': '/bin/bash', 04:54:41 INFO - 'SHLVL': '1', 04:54:41 INFO - 'TERM': 'linux', 04:54:41 INFO - 'TMOUT': '86400', 04:54:41 INFO - 'USER': 'cltbld', 04:54:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847', 04:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:41 INFO - '_': '/tools/buildbot/bin/python'} 04:54:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 04:54:41 INFO - mozversion application_buildid: 20161230030919 04:54:41 INFO - mozversion application_changeset: 31e8e7e5ef88b5d4f17e5139beb1eb6efd46a9fe 04:54:41 INFO - mozversion application_display_name: Firefox 04:54:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:54:41 INFO - mozversion application_name: Firefox 04:54:41 INFO - mozversion application_remotingname: firefox 04:54:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:54:41 INFO - mozversion application_vendor: Mozilla 04:54:41 INFO - mozversion application_version: 51.0 04:54:41 INFO - mozversion platform_buildid: 20161230030919 04:54:41 INFO - mozversion platform_changeset: 31e8e7e5ef88b5d4f17e5139beb1eb6efd46a9fe 04:54:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:54:41 INFO - mozversion platform_version: 51.0 04:54:41 INFO - using testdate: 1483102481 04:54:41 INFO - actual date: 1483102481 04:54:41 INFO - starting webserver on 'localhost:42101' 04:54:41 INFO - SUITE-START | Running 2 tests 04:54:41 INFO - TEST-START | dromaeo_css 04:54:41 INFO - operating with platform_type : linux_ 04:54:41 INFO - Initialising browser for dromaeo_css test... 04:54:41 INFO - TEST-INFO | started process 24272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphtplXZ/profile http://localhost:42101/getInfo.html) 04:54:46 INFO - PROCESS | 24272 | __metrics Screen width/height:1600/1200 04:54:46 INFO - PROCESS | 24272 | colorDepth:24 04:54:46 INFO - PROCESS | 24272 | Browser inner width/height: 1024/697 04:54:46 INFO - PROCESS | 24272 | __metrics 04:54:46 INFO - PROCESS | 24272 | 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:54:46 INFO - PROCESS | 24272 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:54:47 INFO - PROCESS | 24272 | console.error: PushService: 04:54:47 INFO - PROCESS | 24272 | stateChangeProcessEnqueue: Error transitioning state 04:54:47 INFO - PROCESS | 24272 | UnknownError 04:54:48 INFO - TEST-INFO | 24272: exit 0 04:54:48 INFO - Browser initialized. 04:54:48 INFO - Running cycle 1/1 for dromaeo_css test... 04:54:48 INFO - TEST-INFO | started process 24364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphtplXZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:59 INFO - PROCESS | 24364 | RSS: Main: 143122432 04:54:59 INFO - PROCESS | 24364 | 04:55:50 INFO - PROCESS | 24364 | 1483102550777 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] 04:57:59 INFO - PROCESS | 24364 | Cycle 1(1): loaded http://localhost:42101/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42101/tests/dromaeo/cssquery-ext.html) 04:58:00 INFO - PROCESS | 24364 | RSS: Main: 241213440 04:58:00 INFO - PROCESS | 24364 | 05:01:03 INFO - PROCESS | 24364 | Cycle 1(1): loaded http://localhost:42101/tests/dromaeo/cssquery-ext.html (next: http://localhost:42101/tests/dromaeo/cssquery-jquery.html) 05:01:03 INFO - PROCESS | 24364 | RSS: Main: 231211008 05:01:03 INFO - PROCESS | 24364 | 05:04:05 INFO - PROCESS | 24364 | Cycle 1(1): loaded http://localhost:42101/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42101/tests/dromaeo/cssquery-mootools.html) 05:04:06 INFO - PROCESS | 24364 | RSS: Main: 174886912 05:04:06 INFO - PROCESS | 24364 | 05:07:08 INFO - PROCESS | 24364 | Cycle 1(1): loaded http://localhost:42101/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42101/tests/dromaeo/cssquery-prototype.html) 05:07:08 INFO - PROCESS | 24364 | RSS: Main: 222113792 05:07:08 INFO - PROCESS | 24364 | 05:10:11 INFO - PROCESS | 24364 | Cycle 1(1): loaded http://localhost:42101/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42101/tests/dromaeo/cssquery-yui.html) 05:10:11 INFO - PROCESS | 24364 | RSS: Main: 176328704 05:10:11 INFO - PROCESS | 24364 | 05:13:14 INFO - PROCESS | 24364 | Cycle 1(1): loaded http://localhost:42101/tests/dromaeo/cssquery-yui.html (next: http://localhost:42101/tests/dromaeo/cssquery-dojo.html) 05:13:14 INFO - PROCESS | 24364 | RSS: Main: 264814592 05:13:14 INFO - PROCESS | 24364 | 05:13:14 INFO - PROCESS | 24364 | __start_tp_report 05:13:14 INFO - PROCESS | 24364 | _x_x_mozilla_page_load 05:13:14 INFO - PROCESS | 24364 | _x_x_mozilla_page_load_details 05:13:14 INFO - PROCESS | 24364 | |i|pagename|runs| 05:13:14 INFO - PROCESS | 24364 | |0;dojo.html;3081.2450949517365;3124.515700066489;3135.482645363515;3151.243701511638;3170.096522491089;5453.64551304165;5523.392426833055;5549;5555.527780138688;5576.4702353276425;5541.612087153901;5597.412271711472;5607.186957891114;5620;5627.943720562793;5061.721605311715;5077.238414237875;5122.257272695457;5132.28148059272;5156.767945442445;4973.254011898226;4979.8008079676765;5141.935193834071;5185.662931909414;5215.739213039333;5021.949780502203;5024.799008039692;5056.570191533724;5078.1874900016;5106.387233531981;5125.461826508219;5135.050015747099;5161.4322424533275;5211.817586384496;5219.634625576211;4874.512548745132;5103.030424219386;5121.308623335839;5149.176131818928;5186.92219616706;5428.294321738149;5447;5518.862028449281;5543.584231182637;5573.498385145356;5965.55258355625;5970.402959704038;5975.163477113208;5977.731002104916;5986.880262394728;5832.795852145155;6009.429104235091;6009.789657361971;6025.758969641209;6027.457528822427;5500.147477141049;5532.972335138298;5600.0759874620635;5603.075492543766;5685.403032681592;6130.601510901777;6147.754089836357;6153.753849846045;6159.891219580519;6170.876582468415;5930.199423077829;5932.79235226765;5935.228420305332;5936.376680448577;5939.643621382645;5825.621334613236;5832.475077243069;5913.349531551526;5982.760689572368;5987.760489580368;5996.460318571262;6009.609375390585;6012;6012.188354572077;6020.217371741734;6038.577299589075;6039.275286965592;6042.818715438456;6044.24446944132;6070.696465176724;4479.641628669699;4489.19194544985;4535.070310586322;4589.908201835945;4647.674662773574;4085.428040074392;4087.652549533323;4095.5904409558807;4112.157007813391;4127.587241275848;5705.857353566111;5711.114777209539;5712;5715.171300161536;5739.741711622987;5849.88300233993;5879.353271140171;5924.733386997509;6023.915695174911;6027.8794424111275;5645.661260324394;5676.432356764373;5710.371859095496;5718.571107166979;5724.914126288109;5192.273081768555;5206.0368831766245;5207.791688332424;5209.739513024334;5214.217867319932;5915.1718759373725;6038.033914573735;6160.10678451631;6170.7223174957235;6173.197484327098;5880.382559831156;5948;5966.49284810796;6007.068904319837;6016.909746353896;6121.173641558333;6153.753849845956;6160.414760597736;6161.784337548164;6169.352218017044;5744.655320680772;5822.359540450462;5882.794102206402;5885.764569417347;5886.705664716833;5829.242198514166;5942.6731529766275;6014.759409623566;6018.909716354346;6109.266887973472;5933.436323549256;5936.28764548257;5942.049272116441;5942.7920022799;5944.821655350346;5935.881282374242;5942.376050514634;5944.256967879015;5945.583809133319;5949.077892926603;5558.888822223452;5676;5715.114157305624;5724.0555308375315;5746.741396637245;5838.5621078418435;5889.823305300848;5907.911381329198;5917.615355001911;5918.17145599625;5648.971755141198;5771.422857714195;5776;5779.624324418899;5781.682007489629 05:13:14 INFO - PROCESS | 24364 | |1;ext.html;593.7239183779544;608.1303735658008;626.555145846449;637.4613451633368;639.1212083385345;33662.15844603883;36627;45581.7720911395;45772.77113614427;46377.07245855081;45915.77042114785;46241.768791156;46333;46361.53638463614;46381.30428043582;9086.13681700239;9254.86117708235;9255.629774809;9269;9351.859722104175;8462.788430289262;8655;10815.242932994694;11046.944765276163;11049.226554141213;11211.271267367636;11307.886921130807;11309.038731707815;11311.208215424924;11311.717207069847;11077.723056923562;11165;11167.329960202414;11178.608748693798;11183.944080279587;10708.464576771208;10768.623098191603;10774.030337269684;10774.19193560486;10776.084032857216;43319.566804331866;43353.566464335585;43402.782986084865;43567.78216108931;43785.56214437878;3761.5110035695184;3799.620037996206;3867.864624738149;3870.2453021660785;3966.504186976628;33448.331033379196;33591.6640833591;33612.49581256283;34030.31939361223;35455.4681679775;4486.887827804331;4579.152856721517;4606.930896036562;4648.209804333272;4735.810567577293;336012;338166;339040;341008;341247;38098.42852357217;39000.41499377511;61214.38785612087;61430;61509;40766.59233407628;40969.79515102405;40992.59007409888;40993.590064099575;41029.58970410317;17108.05905675175;17261;17265.482035538953;17271.13644317779;17286.22212000463;13068.673283167807;13272.73454530904;14433.35049922756;14558.199299038655;14558.272086395638;9162.541872906462;9388.342816002814;9405.20055795265;9463.101005404476;9543.61825526985;3548.183917698944;3619.2218672985437;3627.6009638939695;3687.1335236219466;3723;964.392432767352;1032.5456799008562;1055.7044027672264;1060.125396547851;1076;32715;33040.33919321648;33215.335693286;33384.83307583447;33646.66353336435;1112.6884472347756;1125.611663975927;1159.750653609478;1181.2735167871697;1232.4269214815154;17591.824081759274;17626.559336016446;17646.294148233927;17721.911390443223;17722.5569360767;594427;600339;601126;601411;603448;61163;62127.689361552904;62348.688256558424;62429;62501.37498625046;1329.0962145740796;1333.6399172223446;1365.911215770952;1374.7181827725292;1375.5254437219144;30930.690693093682;34942.65057349394;35104;35486.82256588701;35560.644393556766;53393.466065340406;54123.458765413416;54147;54188.45811541834;54245.72877135747;496125;500633;503860;505784;520268;35805.46291805573;45508.544914551756;46039;46907.76546117248;50075;50294.748526257135;51058.48941510686;51225.2071177507;51302;51871.481285186666;42452.57547424486;42603.36094958516;42649.36025959675;43120;44718;42473.150536989706;43635.34546981861;44354.36196267269;44866.77566612277;44998.77500612476;42837.14325713406;43522;44027.77986110177;44123.77938110289;44150.33774493321;36907.6309236915;39216.803915980236;39464;39875.40186897257;40128.1974360517;29055;29450.852745736134;29645.407091858473;29689.406211876074;29698 05:13:14 INFO - PROCESS | 24364 | |2;jquery.html;408.481228839374;415.97088203825746;418.2325432830756;421.17449798395137;437.89271628451036;19686.803131968674;19762.011899405024;20473.897630511845;20485.385438436835;20647.896760516178;18994.335198268065;19440.70838937417;20003.899980500115;20156.496087597818;20298.594028119467;5959.225300710912;6195.659238741868;6213.658248796314;6220.533459990496;6232.875342493147;4367.650587952956;4658.673892827504;4730.053989202173;6086.7565297388055;6164.445199932005;6788.049673045777;6827;6912.032315475837;6947.166340039203;6948.200956889972;6651.567648102882;6767.052612634235;6801.251862295144;6803.523753337268;6920.723171073176;5874.23634927461;5966.940330596682;5967.313758917737;5978.880422391528;5979.760809567612;23944.760552394426;24150.516989660286;24285.392865178335;24365.512689746105;24449.511009779882;2739.7260273972643;2743.8353698777937;3081.938361232763;3088.366884788613;3163.572917656133;14969.176695281754;15228.46700365493;15398.615034624225;15416.229188540528;15529;2014.1137899324397;2054.209129485144;2060.9690854637192;2109.325015994882;2111.883846388448;76667.6166619169;83977.58011209966;84387;84563;85261.57369213176;11485.253458525169;11638.301701897914;11985.52057917691;12017.218880772896;12097.879021209852;17130.229139688745;17331;17343.3062677494;17348.219330130174;17353.65292694139;8862.601182946783;8911.821763564822;9023.323250756219;9028.909710902939;9174.633014679472;8606.053334133241;8661.870071948926;8665.263452606472;8885.333599980027;8889.244414224733;5073.568746656576;5108.59131269505;5151.484851514819;5162.09663308927;5170.526399975989;1946.5425624978118;2078.7193728846714;2111.5987962287118;2121.840861935361;2125.5536337369017;964.4213471916934;1021.3055122516612;1026.8499280805545;1083.8374243863484;1088.2056099047738;19582;19715.507112322306;20511.4872128198;20568.28011019637;20879;997.9051990060933;1010.4998025977188;1013.7972405518926;1057.7091299892438;1078.8327809189589;10626.840597391045;11248.94375528117;11249.381284029458;11284.774304513863;11387.14596405273;506969;511430;511538;515042;517949;70701;73031;96073.5196324014;99714;101343.49328253459;984.2618036472645;998.7503124218945;1031.6286136990677;1035.0580971316067;1038.2732087538752;17815.910920445316;18143.455696329132;18656.720149198045;18709.54933492169;18834.24663013519;44810.55189448064;44824.77587612171;45386.31920521261;45408.54591454043;45838.31242531431;57169.42830571807;57262;57367;62730.372696272454;64846;8845.601947912231;8907.421017633833;8953.059928707653;9025.548722563977;9259.583318750538;11561;13427.798583021458;13515.662108447368;13710.314484275947;13806.792898106336;6173.228346456693;8270;10517.94820517942;11604.187706860439;11800.17398782077;11380.146489013523;11588.47851846652;11630.94184529072;11788.823167652321;11916.76166476683;11490.138239632228;11687;11725.589604363806;11853.051755859684;12377;8157.836843262983;8352.373571982247;9098.363114581916;9191.86212206804;9230.307726920373;9434.95282523583;11482.540698371971;11642.24325418845;12051.939740301243;12085.577004804789 05:13:14 INFO - PROCESS | 24364 | |3;mootools.html;1469.5150600301902;1513.7956375889255;1624.325904749529;1760.6302676437947;1771.0967406622626;8711.651533938642;9287.907120928789;9292.72121836346;9296.302777291696;9311.487868167256;7712.460127791057;8009.799755006128;8610.827783444327;8992.640294388217;9157.908420915788;2403.7596240375997;2431.1977047574346;2435.1355268879556;2435.744246854081;2437.5734246506877;2405.0379848060743;2410.2889647553925;2448.8530688158767;2450.901963921441;2452.435939733862;2393.1265088242753;2404.7715467030694;2405.278416475059;2429.890654920524;2434.172381390327;2329.801966832813;2336.4158960259933;2337.4390146364835;2342.508073304591;2381.071382160959;2329.5457385809773;2340.426595484117;2342.601757701178;2348.659444380555;2352.4589344450874;9206.815863682688;9254.120858518498;9317.301202409846;9318.161365477139;9356.157945784911;5325.733713314357;5490.80782172626;5504;5521.613487055908;5521.834344969658;3300.227808640753;3355.3457075870215;3355.76509644325;3427.0404286799735;3427.4002049641213;1176.7646470705808;1180.1738782852037;1185.6857932647856;1225.5649244518156;1229.7479016801535;12596.68508287291;12673.93663031688;12747.808782868264;12761.489540418372;12920.289384083871;4716.575508204278;4778.498257682893;4778.593819525309;4815.470298267188;4953.157963146274;10833.079188268928;10835.241533092609;10838.891611083789;10841.349519028883;10848;5476.616636835383;5495.422980586981;5505.917411238835;5533.363663178786;5542.722863856791;4418.668599855024;4596.35651008859;4846.636502262274;4994.200927851526;5056.544910957958;4169.60388763067;4190.695117685261;4223.5142958559545;4258.552851950562;4308.202982448257;1304.4912484131196;1311.5868501422021;1324.423875614111;1335.0988083043906;1344.227069435059;1016.6899095775859;1042.7705904700954;1044.1229367331478;1048.501961568249;1048.5596049659162;6107.175531303217;6336.778212762531;6421.775237866652;6610.008498725229;6688.331166883273;453.74263041368926;468.9413823272091;474.85991632468506;476.1168033298182;486.4527406667499;4333.198358303724;4367.497737760198;4442.378067070613;4461.866144015685;4468.218061839165;10521.789564208673;11035.724106897393;11064.446777661085;11080.944595276973;11091.27906686079;11020.944895275472;11034.172437067253;11044.226904116795;11054.170937179744;11082.058025067798;8058.1538938411795;8258.463199891989;8459.873101903477;8464.280536154372;8645.308375329958;6161;6227.252729672468;6246.531510136667;6316.652584107918;6467.062275970052;10135.594576217163;10203.693889183336;10208.438535880598;10329.896701033194;10437.112845408225;10169.88131305541;10344.896551034695;10408.219383546113;10645.733856653645;10670.413127278074;7004.544704594185;7554.622268886644;8125.065617454068;8126.065502467292;8330.750077497685;9032.187103160748;9097.09029097085;9117.133872282122;9119.589618467053;9122.680706175252;7937.206279372017;8048.5975701215875;8076.273135417606;8161.470383936972;8273.048599411144;7750.186230445947;7802.375809935305;7939.6030198491;7980.521168729895;7988.800279993046;6986.6157361343585;7367.1527774304495;7524;7535.397168226638;7539.396848252017;5198.948010519846;5238.895222095461;5352.678839269656;5359.812406565751;5389.1107967186545;5308.2568440419145;5385.3268341457315;5409.540189083972;5415.40430552631;5495.945040549544 05:13:14 INFO - PROCESS | 24364 | |4;prototype.html;320.5752378099019;328.5121594432268;337.2075622287626;339.1064544924126;341.66687479707286;5566.192902029208;5617;5627.155926611011;5628.943710562893;5646.661200327983;5211.400688920775;5321.707306098163;5393;5403.729813509329;5506.669599824013;4316.892077698051;4318.093200427898;4321.956780432195;4327.870163895088;4338.8047537860875;4320.919770057486;4332.61356365963;4352.477702675684;4358.368036634686;4385.56144385562;4042.6361627453525;4284.935725964113;4292.141571685675;4294.892627684301;4300.591443812833;4266.360045993095;4276.037891474424;4277.160820847019;4288.6140247377725;4292.699511034229;3784.2053168834577;3790;3791.7535360201773;3801.8099095045413;3803.2583646189005;5266.815661451869;5300.575953923715;5428.538574221196;5447.373552041527;5465.672059676393;4891.5353041461;4900.215965445547;4903.53416425439;4913.140200464904;4917.680350777224;5718.656880587137;5728.3126024876865;5735.770569177228;5750.856228594277;5769.798057068025;4051.2910240707756;4119.97940010301;4162.313218318974;4181.832726690929;4184.644305234028;5827.679477628729;5870.888429132567;5888.351261646746;5893.823185304448;5983.222181116427;4261.232978063978;4264.637505811978;4308.784560772012;4311.698181127291;4316.115196384733;4251.787410629518;4270.167317373144;4284.778838031146;4285.871423857289;4369.868903932824;4853.830115945925;4856.490068542752;4861.975690121527;4867.659263851568;4882.170031094723;5808.244928159313;5844.532437404998;5861.472467477947;5875.6474611523445;5881.617694849821;1387.555982085723;1418.6949805791805;1424.893133015028;1468.9706205876037;1494;976.5410257179115;1005.3465247588979;1006.6627679727227;1010.9797804043878;1017.6387382479261;5422.020962348794;5555.2778138841695;5557.166425036196;5573.303337082864;5609.02721557567;5854.2974843018255;5859.912101318484;5860.824175274749;5892.558058145656;5902.970485147547;5427.538659214011;5508.862278442991;5592.804251851166;5597.048501754712;5599.7480113394995;3060.32672811981;3101.7828751987145;3114.3926934247606;3124.562561241428;3134.843257837099;5901.3508514063415;5905.4685078343155;5906.202662640574;5915.733791979371;5924.637333413253;5763.682997435098;5967.701614919237;6011.355003798315;6084.30030546484;6133.84665383369;6114.144019837227;6122.663253521099;6131.325554189036;6142.293636231891;6142.662153581507;5744.540436764965;5974.22335096452;6007.879842403215;6014.248218972629;6041.305249896318;5857.26784151981;5931.881362372642;5938.940610593839;5941.316748573797;5943.405659434022;6123.510119190365;6134.693265336805;6148.907766383419;6151.169592105009;6163.599366041193;4035.1929614076716;4238.0888109056705;4264.168487144977;4294.484661840599;4297.05464797744;5977.521798256216;5981.342052374148;5985.431384018511;5986.281646202309;5989.011813050972;5608.943910560843;5632.352279487911;5754.741036653444;5832.708364581669;5851.1515830205235;5822.912656310074;5827.1841942127285;5830.53355731549;5843.853903652443;5844.12338149281;5639.887202256014;5752.424757524214;5763.279590051244;5790.218320526675;5791.971040144772;5769.884602307847;5800.01399762033;5837.67892765902;5853.326867410132;5860.589758717019;5743.9138412923;5747.655140691572;5749.712514374348;5749.798757043483;5756.453136951983 05:13:14 INFO - PROCESS | 24364 | |5;yui.html;804.899387576553;821.6097353756966;854.2695994924339;862.6463150108457;895.073598825216;14766.114033158017;15907.602309942256;16130.83869161308;16149.273282702292;16293;13629.25039122848;14000.089994150374;14018.018738688295;14063.156210627369;14138.222397768119;834.1700008491545;855.1619412975288;857.9313654907593;858.0432817408575;858.4420126917522;714.6141083814733;731.7475470962536;824.5011767880436;852.3692467574012;857.5883575883548;844.535505471991;845.5349557743217;846.1158089796147;846.6867259114106;848.6859861851124;850.0988951711175;850.1838235294125;851.3912552524912;851.4933614499332;851.7402192331336;632.0582332324849;632.5540493951798;633.7560039384824;633.9175907132043;634.7365843175077;14284.714305713931;14312.28438578067;14316.498922537765;14334.49829255971;14335.641608959755;15359.769603455958;15366.00120992132;15414.152221627806;15675.372985080583;15892.52322430329;12143;12180.756384872342;12311.507539698401;12335.198212116273;12584.244945303311;4061.451704019949;4105.958940410617;4130.442390277334;4196.538380778112;4199.097194103252;72573.637131814;74394.88407673943;74565;74804;74921;11666.358350290815;12187.268763874195;12436.81344779829;12450.688732781753;12580.4338804754;24162.87918560396;24437.02251909904;24547.14085007052;24630.13794517183;24871.378215544755;9277.257819374434;9300.887295071876;9362.297827662816;9481;9490.145886870216;5064.82273120439;5189.248219205311;5229.607779416559;5255;5329.493698098674;3479.9304013920087;3580.480830279595;3601.8019008954757;3607.2785442911522;3609.242059167552;622.1414448061736;626.5833220908136;627.3506920337429;641.3041849593244;670.8155257304182;580.1840240048621;602.90956356546;669.7388018672722;699.951003429755;778.1246098139593;9256.444613323221;9406.623735050522;9417.764555886157;9447.480388578557;9503.097205765442;706.2831226305304;726.8691635505554;735.503535113796;740.4187712645547;743.6727839750492;4212.157568486315;4369.934450983238;4444.088961762831;4465.24090904547;4542.568455996675;74579.25420745832;75034;76311;104460.47769761254;107918;100235;103113.48443257736;103346;104413;105064;57401.71299143561;59514.404855951754;66410.33589664138;78831.21168788354;89044;9789.021097890154;9935.15551178129;9948.303618746619;9964.501774911081;10020;52027;52514.687132821986;52768.472315276354;53372;54132.18801718056;71501.6424917872;71659.64170179116;72725.27274727396;80763.19236807557;81525.59237203776;13520.59438216855;14013.229272390117;14066.156030638194;14069.648258793612;14179.220142891827;15270.694586108439;15341.539753807403;15540.68918621644;15844.841551584337;15980.360785568912;13115.213087214797;13715.588532344045;13914.4434222634;14179.929100354433;14974.101553906801;14040;14479.782803258171;14712.117272963656;14837.92581037088;15154.696906061596;13162.40769165409;13476.865231347561;13877.722445551235;14131.081479703786;14853.331600078238;11630.883691163319;12430.689232769253;12508;12591.685207869876;12631.305278209418;11945.761084778429;12224.266544007032;12232.266064036186;12254.509819607116;12326.753464930473 05:13:14 INFO - PROCESS | 24364 | __end_tp_report 05:13:14 INFO - PROCESS | 24364 | __start_cc_report 05:13:14 INFO - PROCESS | 24364 | _x_x_mozilla_cycle_collect,884 05:13:14 INFO - PROCESS | 24364 | __end_cc_report 05:13:14 INFO - PROCESS | 24364 | __startTimestamp1483103594319__endTimestamp 05:13:14 INFO - PROCESS | 24364 | 05:13:14 INFO - PROCESS | 24364 | ------- Summary: start ------- 05:13:14 INFO - PROCESS | 24364 | Number of tests: 6 05:13:14 INFO - PROCESS | 24364 | 05:13:14 INFO - PROCESS | 24364 | [#0] dojo.html Cycles:165 Average:5555.81 Median:5771.42 stddev:639.44 (11.1%) stddev-sans-first:611.22 05:13:14 INFO - PROCESS | 24364 | Values: 3081.2 3124.5 3135.5 3151.2 3170.1 5453.6 5523.4 5549.0 5555.5 5576.5 5541.6 5597.4 5607.2 5620.0 5627.9 5061.7 5077.2 5122.3 5132.3 5156.8 4973.3 4979.8 5141.9 5185.7 5215.7 5021.9 5024.8 5056.6 5078.2 5106.4 5125.5 5135.1 5161.4 5211.8 5219.6 4874.5 5103.0 5121.3 5149.2 5186.9 5428.3 5447.0 5518.9 5543.6 5573.5 5965.6 5970.4 5975.2 5977.7 5986.9 5832.8 6009.4 6009.8 6025.8 6027.5 5500.1 5533.0 5600.1 5603.1 5685.4 6130.6 6147.8 6153.8 6159.9 6170.9 5930.2 5932.8 5935.2 5936.4 5939.6 5825.6 5832.5 5913.3 5982.8 5987.8 5996.5 6009.6 6012.0 6012.2 6020.2 6038.6 6039.3 6042.8 6044.2 6070.7 4479.6 4489.2 4535.1 4589.9 4647.7 4085.4 4087.7 4095.6 4112.2 4127.6 5705.9 5711.1 5712.0 5715.2 5739.7 5849.9 5879.4 5924.7 6023.9 6027.9 5645.7 5676.4 5710.4 5718.6 5724.9 5192.3 5206.0 5207.8 5209.7 5214.2 5915.2 6038.0 6160.1 6170.7 6173.2 5880.4 5948.0 5966.5 6007.1 6016.9 6121.2 6153.8 6160.4 6161.8 6169.4 5744.7 5822.4 5882.8 5885.8 5886.7 5829.2 5942.7 6014.8 6018.9 6109.3 5933.4 5936.3 5942.0 5942.8 5944.8 5935.9 5942.4 5944.3 5945.6 5949.1 5558.9 5676.0 5715.1 5724.1 5746.7 5838.6 5889.8 5907.9 5917.6 5918.2 5649.0 5771.4 5776.0 5779.6 5781.7 05:13:14 INFO - PROCESS | 24364 | 05:13:14 INFO - PROCESS | 24364 | [#1] ext.html Cycles:180 Average:64151.14 Median:40001.80 stddev:131309.62 (328.3%) stddev-sans-first:131591.27 05:13:14 INFO - PROCESS | 24364 | Values: 593.7 608.1 626.6 637.5 639.1 33662.2 36627.0 45581.8 45772.8 46377.1 45915.8 46241.8 46333.0 46361.5 46381.3 9086.1 9254.9 9255.6 9269.0 9351.9 8462.8 8655.0 10815.2 11046.9 11049.2 11211.3 11307.9 11309.0 11311.2 11311.7 11077.7 11165.0 11167.3 11178.6 11183.9 10708.5 10768.6 10774.0 10774.2 10776.1 43319.6 43353.6 43402.8 43567.8 43785.6 3761.5 3799.6 3867.9 3870.2 3966.5 33448.3 33591.7 33612.5 34030.3 35455.5 4486.9 4579.2 4606.9 4648.2 4735.8 336012.0 338166.0 339040.0 341008.0 341247.0 38098.4 39000.4 61214.4 61430.0 61509.0 40766.6 40969.8 40992.6 40993.6 41029.6 17108.1 17261.0 17265.5 17271.1 17286.2 13068.7 13272.7 14433.4 14558.2 14558.3 9162.5 9388.3 9405.2 9463.1 9543.6 3548.2 3619.2 3627.6 3687.1 3723.0 964.4 1032.5 1055.7 1060.1 1076.0 32715.0 33040.3 33215.3 33384.8 33646.7 1112.7 1125.6 1159.8 1181.3 1232.4 17591.8 17626.6 17646.3 17721.9 17722.6 594427.0 600339.0 601126.0 601411.0 603448.0 61163.0 62127.7 62348.7 62429.0 62501.4 1329.1 1333.6 1365.9 1374.7 1375.5 30930.7 34942.7 35104.0 35486.8 35560.6 53393.5 54123.5 54147.0 54188.5 54245.7 496125.0 500633.0 503860.0 505784.0 520268.0 35805.5 45508.5 46039.0 46907.8 50075.0 50294.7 51058.5 51225.2 51302.0 51871.5 42452.6 42603.4 42649.4 43120.0 44718.0 42473.2 43635.3 44354.4 44866.8 44998.8 42837.1 43522.0 44027.8 44123.8 44150.3 36907.6 39216.8 39464.0 39875.4 40128.2 29055.0 29450.9 29645.4 29689.4 29698.0 05:13:14 INFO - PROCESS | 24364 | 05:13:14 INFO - PROCESS | 24364 | [#2] jquery.html Cycles:180 Average:30204.95 Median:2912.89 stddev:84327.78 (2895.0%) stddev-sans-first:84534.66 05:13:14 INFO - PROCESS | 24364 | Values: 408.5 416.0 418.2 421.2 437.9 19686.8 19762.0 20473.9 20485.4 20647.9 18994.3 19440.7 20003.9 20156.5 20298.6 5959.2 6195.7 6213.7 6220.5 6232.9 4367.7 4658.7 4730.1 6086.8 6164.4 6788.0 6827.0 6912.0 6947.2 6948.2 6651.6 6767.1 6801.3 6803.5 6920.7 5874.2 5966.9 5967.3 5978.9 5979.8 23944.8 24150.5 24285.4 24365.5 24449.5 2739.7 2743.8 3081.9 3088.4 3163.6 14969.2 15228.5 15398.6 15416.2 15529.0 2014.1 2054.2 2061.0 2109.3 2111.9 76667.6 83977.6 84387.0 84563.0 85261.6 11485.3 11638.3 11985.5 12017.2 12097.9 17130.2 17331.0 17343.3 17348.2 17353.7 8862.6 8911.8 9023.3 9028.9 9174.6 8606.1 8661.9 8665.3 8885.3 8889.2 5073.6 5108.6 5151.5 5162.1 5170.5 1946.5 2078.7 2111.6 2121.8 2125.6 964.4 1021.3 1026.8 1083.8 1088.2 19582.0 19715.5 20511.5 20568.3 20879.0 997.9 1010.5 1013.8 1057.7 1078.8 10626.8 11248.9 11249.4 11284.8 11387.1 506969.0 511430.0 511538.0 515042.0 517949.0 70701.0 73031.0 96073.5 99714.0 101343.5 984.3 998.8 1031.6 1035.1 1038.3 17815.9 18143.5 18656.7 18709.5 18834.2 44810.6 44824.8 45386.3 45408.5 45838.3 57169.4 57262.0 57367.0 62730.4 64846.0 8845.6 8907.4 8953.1 9025.5 9259.6 11561.0 13427.8 13515.7 13710.3 13806.8 6173.2 8270.0 10517.9 11604.2 11800.2 11380.1 11588.5 11630.9 11788.8 11916.8 11490.1 11687.0 11725.6 11853.1 12377.0 8157.8 8352.4 9098.4 9191.9 9230.3 9435.0 11482.5 11642.2 12051.9 12085.6 05:13:14 INFO - PROCESS | 24364 | 05:13:14 INFO - PROCESS | 24364 | [#3] mootools.html Cycles:180 Average:5988.77 Median:2460.98 stddev:3404.10 (138.3%) stddev-sans-first:3396.70 05:13:14 INFO - PROCESS | 24364 | Values: 1469.5 1513.8 1624.3 1760.6 1771.1 8711.7 9287.9 9292.7 9296.3 9311.5 7712.5 8009.8 8610.8 8992.6 9157.9 2403.8 2431.2 2435.1 2435.7 2437.6 2405.0 2410.3 2448.9 2450.9 2452.4 2393.1 2404.8 2405.3 2429.9 2434.2 2329.8 2336.4 2337.4 2342.5 2381.1 2329.5 2340.4 2342.6 2348.7 2352.5 9206.8 9254.1 9317.3 9318.2 9356.2 5325.7 5490.8 5504.0 5521.6 5521.8 3300.2 3355.3 3355.8 3427.0 3427.4 1176.8 1180.2 1185.7 1225.6 1229.7 12596.7 12673.9 12747.8 12761.5 12920.3 4716.6 4778.5 4778.6 4815.5 4953.2 10833.1 10835.2 10838.9 10841.3 10848.0 5476.6 5495.4 5505.9 5533.4 5542.7 4418.7 4596.4 4846.6 4994.2 5056.5 4169.6 4190.7 4223.5 4258.6 4308.2 1304.5 1311.6 1324.4 1335.1 1344.2 1016.7 1042.8 1044.1 1048.5 1048.6 6107.2 6336.8 6421.8 6610.0 6688.3 453.7 468.9 474.9 476.1 486.5 4333.2 4367.5 4442.4 4461.9 4468.2 10521.8 11035.7 11064.4 11080.9 11091.3 11020.9 11034.2 11044.2 11054.2 11082.1 8058.2 8258.5 8459.9 8464.3 8645.3 6161.0 6227.3 6246.5 6316.7 6467.1 10135.6 10203.7 10208.4 10329.9 10437.1 10169.9 10344.9 10408.2 10645.7 10670.4 7004.5 7554.6 8125.1 8126.1 8330.8 9032.2 9097.1 9117.1 9119.6 9122.7 7937.2 8048.6 8076.3 8161.5 8273.0 7750.2 7802.4 7939.6 7980.5 7988.8 6986.6 7367.2 7524.0 7535.4 7539.4 5198.9 5238.9 5352.7 5359.8 5389.1 5308.3 5385.3 5409.5 5415.4 5495.9 05:13:14 INFO - PROCESS | 24364 | 05:13:14 INFO - PROCESS | 24364 | [#4] prototype.html Cycles:180 Average:4870.67 Median:5583.05 stddev:1433.54 (25.7%) stddev-sans-first:1396.29 05:13:14 INFO - PROCESS | 24364 | Values: 320.6 328.5 337.2 339.1 341.7 5566.2 5617.0 5627.2 5628.9 5646.7 5211.4 5321.7 5393.0 5403.7 5506.7 4316.9 4318.1 4322.0 4327.9 4338.8 4320.9 4332.6 4352.5 4358.4 4385.6 4042.6 4284.9 4292.1 4294.9 4300.6 4266.4 4276.0 4277.2 4288.6 4292.7 3784.2 3790.0 3791.8 3801.8 3803.3 5266.8 5300.6 5428.5 5447.4 5465.7 4891.5 4900.2 4903.5 4913.1 4917.7 5718.7 5728.3 5735.8 5750.9 5769.8 4051.3 4120.0 4162.3 4181.8 4184.6 5827.7 5870.9 5888.4 5893.8 5983.2 4261.2 4264.6 4308.8 4311.7 4316.1 4251.8 4270.2 4284.8 4285.9 4369.9 4853.8 4856.5 4862.0 4867.7 4882.2 5808.2 5844.5 5861.5 5875.6 5881.6 1387.6 1418.7 1424.9 1469.0 1494.0 976.5 1005.3 1006.7 1011.0 1017.6 5422.0 5555.3 5557.2 5573.3 5609.0 5854.3 5859.9 5860.8 5892.6 5903.0 5427.5 5508.9 5592.8 5597.0 5599.7 3060.3 3101.8 3114.4 3124.6 3134.8 5901.4 5905.5 5906.2 5915.7 5924.6 5763.7 5967.7 6011.4 6084.3 6133.8 6114.1 6122.7 6131.3 6142.3 6142.7 5744.5 5974.2 6007.9 6014.2 6041.3 5857.3 5931.9 5938.9 5941.3 5943.4 6123.5 6134.7 6148.9 6151.2 6163.6 4035.2 4238.1 4264.2 4294.5 4297.1 5977.5 5981.3 5985.4 5986.3 5989.0 5608.9 5632.4 5754.7 5832.7 5851.2 5822.9 5827.2 5830.5 5843.9 5844.1 5639.9 5752.4 5763.3 5790.2 5792.0 5769.9 5800.0 5837.7 5853.3 5860.6 5743.9 5747.7 5749.7 5749.8 5756.5 05:13:14 INFO - PROCESS | 24364 | 05:13:14 INFO - PROCESS | 24364 | [#5] yui.html Cycles:180 Average:20064.71 Median:4454.66 stddev:27319.05 (613.3%) stddev-sans-first:27357.41 05:13:14 INFO - PROCESS | 24364 | Values: 804.9 821.6 854.3 862.6 895.1 14766.1 15907.6 16130.8 16149.3 16293.0 13629.3 14000.1 14018.0 14063.2 14138.2 834.2 855.2 857.9 858.0 858.4 714.6 731.7 824.5 852.4 857.6 844.5 845.5 846.1 846.7 848.7 850.1 850.2 851.4 851.5 851.7 632.1 632.6 633.8 633.9 634.7 14284.7 14312.3 14316.5 14334.5 14335.6 15359.8 15366.0 15414.2 15675.4 15892.5 12143.0 12180.8 12311.5 12335.2 12584.2 4061.5 4106.0 4130.4 4196.5 4199.1 72573.6 74394.9 74565.0 74804.0 74921.0 11666.4 12187.3 12436.8 12450.7 12580.4 24162.9 24437.0 24547.1 24630.1 24871.4 9277.3 9300.9 9362.3 9481.0 9490.1 5064.8 5189.2 5229.6 5255.0 5329.5 3479.9 3580.5 3601.8 3607.3 3609.2 622.1 626.6 627.4 641.3 670.8 580.2 602.9 669.7 700.0 778.1 9256.4 9406.6 9417.8 9447.5 9503.1 706.3 726.9 735.5 740.4 743.7 4212.2 4369.9 4444.1 4465.2 4542.6 74579.3 75034.0 76311.0 104460.5 107918.0 100235.0 103113.5 103346.0 104413.0 105064.0 57401.7 59514.4 66410.3 78831.2 89044.0 9789.0 9935.2 9948.3 9964.5 10020.0 52027.0 52514.7 52768.5 53372.0 54132.2 71501.6 71659.6 72725.3 80763.2 81525.6 13520.6 14013.2 14066.2 14069.6 14179.2 15270.7 15341.5 15540.7 15844.8 15980.4 13115.2 13715.6 13914.4 14179.9 14974.1 14040.0 14479.8 14712.1 14837.9 15154.7 13162.4 13476.9 13877.7 14131.1 14853.3 11630.9 12430.7 12508.0 12591.7 12631.3 11945.8 12224.3 12232.3 12254.5 12326.8 05:13:14 INFO - PROCESS | 24364 | -------- Summary: end -------- 05:13:14 INFO - PROCESS | 24364 | 05:13:15 INFO - TEST-INFO | 24364: exit 0 05:13:15 INFO - TEST-OK | dromaeo_css | took 1113160ms 05:13:15 INFO - TEST-START | kraken 05:13:15 INFO - operating with platform_type : linux_ 05:13:15 INFO - Initialising browser for kraken test... 05:13:15 INFO - TEST-INFO | started process 24670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpog0NER/profile http://localhost:42101/getInfo.html) 05:13:19 INFO - PROCESS | 24670 | __metrics Screen width/height:1600/1200 05:13:19 INFO - PROCESS | 24670 | colorDepth:24 05:13:19 INFO - PROCESS | 24670 | Browser inner width/height: 1024/697 05:13:19 INFO - PROCESS | 24670 | __metrics 05:13:20 INFO - PROCESS | 24670 | 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" 05:13:20 INFO - PROCESS | 24670 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:13:20 INFO - PROCESS | 24670 | console.error: PushService: 05:13:20 INFO - PROCESS | 24670 | stateChangeProcessEnqueue: Error transitioning state 05:13:20 INFO - PROCESS | 24670 | UnknownError 05:13:21 INFO - TEST-INFO | 24670: exit 0 05:13:21 INFO - Browser initialized. 05:13:21 INFO - Running cycle 1/1 for kraken test... 05:13:21 INFO - TEST-INFO | started process 24763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpog0NER/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:33 INFO - PROCESS | 24763 | RSS: Main: 143380480 05:13:33 INFO - PROCESS | 24763 | 05:13:35 INFO - PROCESS | 24763 | Cycle 1(1): loaded http://localhost:42101/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42101/tests/kraken/driver.html?testName=audio-beat-detection) 05:13:36 INFO - PROCESS | 24763 | RSS: Main: 187383808 05:13:36 INFO - PROCESS | 24763 | 05:13:38 INFO - PROCESS | 24763 | Cycle 1(1): loaded http://localhost:42101/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42101/tests/kraken/driver.html?testName=audio-dft) 05:13:39 INFO - PROCESS | 24763 | RSS: Main: 174612480 05:13:39 INFO - PROCESS | 24763 | 05:13:42 INFO - PROCESS | 24763 | Cycle 1(1): loaded http://localhost:42101/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42101/tests/kraken/driver.html?testName=audio-fft) 05:13:42 INFO - PROCESS | 24763 | RSS: Main: 265859072 05:13:42 INFO - PROCESS | 24763 | 05:13:44 INFO - PROCESS | 24763 | Cycle 1(1): loaded http://localhost:42101/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42101/tests/kraken/driver.html?testName=audio-oscillator) 05:13:45 INFO - PROCESS | 24763 | RSS: Main: 172412928 05:13:45 INFO - PROCESS | 24763 | 05:13:47 INFO - PROCESS | 24763 | Cycle 1(1): loaded http://localhost:42101/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42101/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:13:48 INFO - PROCESS | 24763 | RSS: Main: 174493696 05:13:48 INFO - PROCESS | 24763 | 05:13:51 INFO - PROCESS | 24763 | Cycle 1(1): loaded http://localhost:42101/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42101/tests/kraken/driver.html?testName=imaging-darkroom) 05:13:51 INFO - PROCESS | 24763 | RSS: Main: 210141184 05:13:51 INFO - PROCESS | 24763 | 05:13:55 INFO - PROCESS | 24763 | Cycle 1(1): loaded http://localhost:42101/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42101/tests/kraken/driver.html?testName=imaging-desaturate) 05:13:55 INFO - PROCESS | 24763 | RSS: Main: 208531456 05:13:55 INFO - PROCESS | 24763 | 05:13:58 INFO - PROCESS | 24763 | Cycle 1(1): loaded http://localhost:42101/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42101/tests/kraken/driver.html?testName=json-parse-financial) 05:13:59 INFO - PROCESS | 24763 | RSS: Main: 209039360 05:13:59 INFO - PROCESS | 24763 | 05:14:00 INFO - PROCESS | 24763 | Cycle 1(1): loaded http://localhost:42101/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42101/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:14:01 INFO - PROCESS | 24763 | RSS: Main: 170508288 05:14:01 INFO - PROCESS | 24763 | 05:14:02 INFO - PROCESS | 24763 | Cycle 1(1): loaded http://localhost:42101/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42101/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:14:03 INFO - PROCESS | 24763 | RSS: Main: 177852416 05:14:03 INFO - PROCESS | 24763 | 05:14:05 INFO - PROCESS | 24763 | Cycle 1(1): loaded http://localhost:42101/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42101/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:14:05 INFO - PROCESS | 24763 | RSS: Main: 187641856 05:14:05 INFO - PROCESS | 24763 | 05:14:08 INFO - PROCESS | 24763 | Cycle 1(1): loaded http://localhost:42101/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42101/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:14:09 INFO - PROCESS | 24763 | RSS: Main: 195088384 05:14:09 INFO - PROCESS | 24763 | 05:14:11 INFO - PROCESS | 24763 | Cycle 1(1): loaded http://localhost:42101/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42101/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:14:12 INFO - PROCESS | 24763 | RSS: Main: 192630784 05:14:12 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | Cycle 1(1): loaded http://localhost:42101/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42101/tests/kraken/driver.html?testName=ai-astar) 05:14:14 INFO - PROCESS | 24763 | RSS: Main: 244240384 05:14:14 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | __start_tp_report 05:14:14 INFO - PROCESS | 24763 | _x_x_mozilla_page_load 05:14:14 INFO - PROCESS | 24763 | _x_x_mozilla_page_load_details 05:14:14 INFO - PROCESS | 24763 | |i|pagename|runs| 05:14:14 INFO - PROCESS | 24763 | |0;ai-astar;112;113;112;112;111;112;110;110;111;110 05:14:14 INFO - PROCESS | 24763 | |1;audio-beat-detection;145;115;114;160;120;118;121;118;146;122 05:14:14 INFO - PROCESS | 24763 | |2;audio-dft;160;161;162;160;161;159;161;161;161;161 05:14:14 INFO - PROCESS | 24763 | |3;audio-fft;74;75;75;117;75;76;76;75;95;74 05:14:14 INFO - PROCESS | 24763 | |4;audio-oscillator;81;81;116;83;82;80;99;81;81;112 05:14:14 INFO - PROCESS | 24763 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;118;117;117 05:14:14 INFO - PROCESS | 24763 | |6;imaging-darkroom;146;146;146;145;147;146;145;145;145;148 05:14:14 INFO - PROCESS | 24763 | |7;imaging-desaturate;95;96;95;96;96;95;96;95;95;95 05:14:14 INFO - PROCESS | 24763 | |8;json-parse-financial;55;49;49;49;49;50;50;49;49;49 05:14:14 INFO - PROCESS | 24763 | |9;json-stringify-tinderbox;58;58;58;57;58;58;60;58;58;58 05:14:14 INFO - PROCESS | 24763 | |10;stanford-crypto-aes;73;73;73;73;74;77;74;73;77;73 05:14:14 INFO - PROCESS | 24763 | |11;stanford-crypto-ccm;136;124;121;125;119;122;123;119;143;120 05:14:14 INFO - PROCESS | 24763 | |12;stanford-crypto-pbkdf2;149;155;152;151;156;152;150;152;155;160 05:14:14 INFO - PROCESS | 24763 | |13;stanford-crypto-sha256-iterative;61;62;62;61;62;64;63;60;60;61 05:14:14 INFO - PROCESS | 24763 | __end_tp_report 05:14:14 INFO - PROCESS | 24763 | __start_cc_report 05:14:14 INFO - PROCESS | 24763 | _x_x_mozilla_cycle_collect,1597 05:14:14 INFO - PROCESS | 24763 | __end_cc_report 05:14:14 INFO - PROCESS | 24763 | __startTimestamp1483103654336__endTimestamp 05:14:14 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | ------- Summary: start ------- 05:14:14 INFO - PROCESS | 24763 | Number of tests: 14 05:14:14 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:1.06 (0.9%) stddev-sans-first:1.09 05:14:14 INFO - PROCESS | 24763 | Values: 112.0 113.0 112.0 112.0 111.0 112.0 110.0 110.0 111.0 110.0 05:14:14 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:121.50 stddev:16.16 (13.3%) stddev-sans-first:15.91 05:14:14 INFO - PROCESS | 24763 | Values: 145.0 115.0 114.0 160.0 120.0 118.0 121.0 118.0 146.0 122.0 05:14:14 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 05:14:14 INFO - PROCESS | 24763 | Values: 160.0 161.0 162.0 160.0 161.0 159.0 161.0 161.0 161.0 161.0 05:14:14 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:14.08 (18.8%) stddev-sans-first:14.69 05:14:14 INFO - PROCESS | 24763 | Values: 74.0 75.0 75.0 117.0 75.0 76.0 76.0 75.0 95.0 74.0 05:14:14 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:81.00 stddev:14.05 (17.3%) stddev-sans-first:14.55 05:14:14 INFO - PROCESS | 24763 | Values: 81.0 81.0 116.0 83.0 82.0 80.0 99.0 81.0 81.0 112.0 05:14:14 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:14:14 INFO - PROCESS | 24763 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 05:14:14 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 05:14:14 INFO - PROCESS | 24763 | Values: 146.0 146.0 146.0 145.0 147.0 146.0 145.0 145.0 145.0 148.0 05:14:14 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:14:14 INFO - PROCESS | 24763 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 05:14:14 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:49.00 stddev:1.87 (3.8%) stddev-sans-first:0.44 05:14:14 INFO - PROCESS | 24763 | Values: 55.0 49.0 49.0 49.0 49.0 50.0 50.0 49.0 49.0 49.0 05:14:14 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 05:14:14 INFO - PROCESS | 24763 | Values: 58.0 58.0 58.0 57.0 58.0 58.0 60.0 58.0 58.0 58.0 05:14:14 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:73.50 stddev:1.63 (2.2%) stddev-sans-first:1.69 05:14:14 INFO - PROCESS | 24763 | Values: 73.0 73.0 73.0 73.0 74.0 77.0 74.0 73.0 77.0 73.0 05:14:14 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:123.50 stddev:7.97 (6.5%) stddev-sans-first:7.43 05:14:14 INFO - PROCESS | 24763 | Values: 136.0 124.0 121.0 125.0 119.0 122.0 123.0 119.0 143.0 120.0 05:14:14 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.20 Median:153.50 stddev:3.29 (2.1%) stddev-sans-first:3.12 05:14:14 INFO - PROCESS | 24763 | Values: 149.0 155.0 152.0 151.0 156.0 152.0 150.0 152.0 155.0 160.0 05:14:14 INFO - PROCESS | 24763 | 05:14:14 INFO - PROCESS | 24763 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:62.00 stddev:1.26 (2.0%) stddev-sans-first:1.32 05:14:14 INFO - PROCESS | 24763 | Values: 61.0 62.0 62.0 61.0 62.0 64.0 63.0 60.0 60.0 61.0 05:14:14 INFO - PROCESS | 24763 | -------- Summary: end -------- 05:14:14 INFO - PROCESS | 24763 | 05:14:15 INFO - TEST-INFO | 24763: exit 0 05:14:15 INFO - TEST-OK | kraken | took 60270ms 05:14:15 INFO - SUITE-END | took 1173s 05:14:15 INFO - Completed test suite (00:19:33) 05:14:15 INFO - javascript benchmark 05:14:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3081.2450949517365, 3124.515700066489, 3135.482645363515, 3151.243701511638, 3170.096522491089, 5453.64551304165, 5523.392426833055, 5549.0, 5555.527780138688, 5576.4702353276425, 5541.612087153901, 5597.412271711472, 5607.186957891114, 5620.0, 5627.943720562793, 5061.721605311715, 5077.238414237875, 5122.257272695457, 5132.28148059272, 5156.767945442445, 4973.254011898226, 4979.8008079676765, 5141.935193834071, 5185.662931909414, 5215.739213039333, 5021.949780502203, 5024.799008039692, 5056.570191533724, 5078.1874900016, 5106.387233531981, 5125.461826508219, 5135.050015747099, 5161.4322424533275, 5211.817586384496, 5219.634625576211, 4874.512548745132, 5103.030424219386, 5121.308623335839, 5149.176131818928, 5186.92219616706, 5428.294321738149, 5447.0, 5518.862028449281, 5543.584231182637, 5573.498385145356, 5965.55258355625, 5970.402959704038, 5975.163477113208, 5977.731002104916, 5986.880262394728, 5832.795852145155, 6009.429104235091, 6009.789657361971, 6025.758969641209, 6027.457528822427, 5500.147477141049, 5532.972335138298, 5600.0759874620635, 5603.075492543766, 5685.403032681592, 6130.601510901777, 6147.754089836357, 6153.753849846045, 6159.891219580519, 6170.876582468415, 5930.199423077829, 5932.79235226765, 5935.228420305332, 5936.376680448577, 5939.643621382645, 5825.621334613236, 5832.475077243069, 5913.349531551526, 5982.760689572368, 5987.760489580368, 5996.460318571262, 6009.609375390585, 6012.0, 6012.188354572077, 6020.217371741734, 6038.577299589075, 6039.275286965592, 6042.818715438456, 6044.24446944132, 6070.696465176724, 4479.641628669699, 4489.19194544985, 4535.070310586322, 4589.908201835945, 4647.674662773574, 4085.428040074392, 4087.652549533323, 4095.5904409558807, 4112.157007813391, 4127.587241275848, 5705.857353566111, 5711.114777209539, 5712.0, 5715.171300161536, 5739.741711622987, 5849.88300233993, 5879.353271140171, 5924.733386997509, 6023.915695174911, 6027.8794424111275, 5645.661260324394, 5676.432356764373, 5710.371859095496, 5718.571107166979, 5724.914126288109, 5192.273081768555, 5206.0368831766245, 5207.791688332424, 5209.739513024334, 5214.217867319932, 5915.1718759373725, 6038.033914573735, 6160.10678451631, 6170.7223174957235, 6173.197484327098, 5880.382559831156, 5948.0, 5966.49284810796, 6007.068904319837, 6016.909746353896, 6121.173641558333, 6153.753849845956, 6160.414760597736, 6161.784337548164, 6169.352218017044, 5744.655320680772, 5822.359540450462, 5882.794102206402, 5885.764569417347, 5886.705664716833, 5829.242198514166, 5942.6731529766275, 6014.759409623566, 6018.909716354346, 6109.266887973472, 5933.436323549256, 5936.28764548257, 5942.049272116441, 5942.7920022799, 5944.821655350346, 5935.881282374242, 5942.376050514634, 5944.256967879015, 5945.583809133319, 5949.077892926603, 5558.888822223452, 5676.0, 5715.114157305624, 5724.0555308375315, 5746.741396637245, 5838.5621078418435, 5889.823305300848, 5907.911381329198, 5917.615355001911, 5918.17145599625, 5648.971755141198, 5771.422857714195, 5776.0, 5779.624324418899, 5781.682007489629], "value": 5511.275475312113, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.7239183779544, 608.1303735658008, 626.555145846449, 637.4613451633368, 639.1212083385345, 33662.15844603883, 36627.0, 45581.7720911395, 45772.77113614427, 46377.07245855081, 45915.77042114785, 46241.768791156, 46333.0, 46361.53638463614, 46381.30428043582, 9086.13681700239, 9254.86117708235, 9255.629774809, 9269.0, 9351.859722104175, 8462.788430289262, 8655.0, 10815.242932994694, 11046.944765276163, 11049.226554141213, 11211.271267367636, 11307.886921130807, 11309.038731707815, 11311.208215424924, 11311.717207069847, 11077.723056923562, 11165.0, 11167.329960202414, 11178.608748693798, 11183.944080279587, 10708.464576771208, 10768.623098191603, 10774.030337269684, 10774.19193560486, 10776.084032857216, 43319.566804331866, 43353.566464335585, 43402.782986084865, 43567.78216108931, 43785.56214437878, 3761.5110035695184, 3799.620037996206, 3867.864624738149, 3870.2453021660785, 3966.504186976628, 33448.331033379196, 33591.6640833591, 33612.49581256283, 34030.31939361223, 35455.4681679775, 4486.887827804331, 4579.152856721517, 4606.930896036562, 4648.209804333272, 4735.810567577293, 336012.0, 338166.0, 339040.0, 341008.0, 341247.0, 38098.42852357217, 39000.41499377511, 61214.38785612087, 61430.0, 61509.0, 40766.59233407628, 40969.79515102405, 40992.59007409888, 40993.590064099575, 41029.58970410317, 17108.05905675175, 17261.0, 17265.482035538953, 17271.13644317779, 17286.22212000463, 13068.673283167807, 13272.73454530904, 14433.35049922756, 14558.199299038655, 14558.272086395638, 9162.541872906462, 9388.342816002814, 9405.20055795265, 9463.101005404476, 9543.61825526985, 3548.183917698944, 3619.2218672985437, 3627.6009638939695, 3687.1335236219466, 3723.0, 964.392432767352, 1032.5456799008562, 1055.7044027672264, 1060.125396547851, 1076.0, 32715.0, 33040.33919321648, 33215.335693286, 33384.83307583447, 33646.66353336435, 1112.6884472347756, 1125.611663975927, 1159.750653609478, 1181.2735167871697, 1232.4269214815154, 17591.824081759274, 17626.559336016446, 17646.294148233927, 17721.911390443223, 17722.5569360767, 594427.0, 600339.0, 601126.0, 601411.0, 603448.0, 61163.0, 62127.689361552904, 62348.688256558424, 62429.0, 62501.37498625046, 1329.0962145740796, 1333.6399172223446, 1365.911215770952, 1374.7181827725292, 1375.5254437219144, 30930.690693093682, 34942.65057349394, 35104.0, 35486.82256588701, 35560.644393556766, 53393.466065340406, 54123.458765413416, 54147.0, 54188.45811541834, 54245.72877135747, 496125.0, 500633.0, 503860.0, 505784.0, 520268.0, 35805.46291805573, 45508.544914551756, 46039.0, 46907.76546117248, 50075.0, 50294.748526257135, 51058.48941510686, 51225.2071177507, 51302.0, 51871.481285186666, 42452.57547424486, 42603.36094958516, 42649.36025959675, 43120.0, 44718.0, 42473.150536989706, 43635.34546981861, 44354.36196267269, 44866.77566612277, 44998.77500612476, 42837.14325713406, 43522.0, 44027.77986110177, 44123.77938110289, 44150.33774493321, 36907.6309236915, 39216.803915980236, 39464.0, 39875.40186897257, 40128.1974360517, 29055.0, 29450.852745736134, 29645.407091858473, 29689.406211876074, 29698.0], "value": 20525.11220483572, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.481228839374, 415.97088203825746, 418.2325432830756, 421.17449798395137, 437.89271628451036, 19686.803131968674, 19762.011899405024, 20473.897630511845, 20485.385438436835, 20647.896760516178, 18994.335198268065, 19440.70838937417, 20003.899980500115, 20156.496087597818, 20298.594028119467, 5959.225300710912, 6195.659238741868, 6213.658248796314, 6220.533459990496, 6232.875342493147, 4367.650587952956, 4658.673892827504, 4730.053989202173, 6086.7565297388055, 6164.445199932005, 6788.049673045777, 6827.0, 6912.032315475837, 6947.166340039203, 6948.200956889972, 6651.567648102882, 6767.052612634235, 6801.251862295144, 6803.523753337268, 6920.723171073176, 5874.23634927461, 5966.940330596682, 5967.313758917737, 5978.880422391528, 5979.760809567612, 23944.760552394426, 24150.516989660286, 24285.392865178335, 24365.512689746105, 24449.511009779882, 2739.7260273972643, 2743.8353698777937, 3081.938361232763, 3088.366884788613, 3163.572917656133, 14969.176695281754, 15228.46700365493, 15398.615034624225, 15416.229188540528, 15529.0, 2014.1137899324397, 2054.209129485144, 2060.9690854637192, 2109.325015994882, 2111.883846388448, 76667.6166619169, 83977.58011209966, 84387.0, 84563.0, 85261.57369213176, 11485.253458525169, 11638.301701897914, 11985.52057917691, 12017.218880772896, 12097.879021209852, 17130.229139688745, 17331.0, 17343.3062677494, 17348.219330130174, 17353.65292694139, 8862.601182946783, 8911.821763564822, 9023.323250756219, 9028.909710902939, 9174.633014679472, 8606.053334133241, 8661.870071948926, 8665.263452606472, 8885.333599980027, 8889.244414224733, 5073.568746656576, 5108.59131269505, 5151.484851514819, 5162.09663308927, 5170.526399975989, 1946.5425624978118, 2078.7193728846714, 2111.5987962287118, 2121.840861935361, 2125.5536337369017, 964.4213471916934, 1021.3055122516612, 1026.8499280805545, 1083.8374243863484, 1088.2056099047738, 19582.0, 19715.507112322306, 20511.4872128198, 20568.28011019637, 20879.0, 997.9051990060933, 1010.4998025977188, 1013.7972405518926, 1057.7091299892438, 1078.8327809189589, 10626.840597391045, 11248.94375528117, 11249.381284029458, 11284.774304513863, 11387.14596405273, 506969.0, 511430.0, 511538.0, 515042.0, 517949.0, 70701.0, 73031.0, 96073.5196324014, 99714.0, 101343.49328253459, 984.2618036472645, 998.7503124218945, 1031.6286136990677, 1035.0580971316067, 1038.2732087538752, 17815.910920445316, 18143.455696329132, 18656.720149198045, 18709.54933492169, 18834.24663013519, 44810.55189448064, 44824.77587612171, 45386.31920521261, 45408.54591454043, 45838.31242531431, 57169.42830571807, 57262.0, 57367.0, 62730.372696272454, 64846.0, 8845.601947912231, 8907.421017633833, 8953.059928707653, 9025.548722563977, 9259.583318750538, 11561.0, 13427.798583021458, 13515.662108447368, 13710.314484275947, 13806.792898106336, 6173.228346456693, 8270.0, 10517.94820517942, 11604.187706860439, 11800.17398782077, 11380.146489013523, 11588.47851846652, 11630.94184529072, 11788.823167652321, 11916.76166476683, 11490.138239632228, 11687.0, 11725.589604363806, 11853.051755859684, 12377.0, 8157.836843262983, 8352.373571982247, 9098.363114581916, 9191.86212206804, 9230.307726920373, 9434.95282523583, 11482.540698371971, 11642.24325418845, 12051.939740301243, 12085.577004804789], "value": 9768.370168402624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.5150600301902, 1513.7956375889255, 1624.325904749529, 1760.6302676437947, 1771.0967406622626, 8711.651533938642, 9287.907120928789, 9292.72121836346, 9296.302777291696, 9311.487868167256, 7712.460127791057, 8009.799755006128, 8610.827783444327, 8992.640294388217, 9157.908420915788, 2403.7596240375997, 2431.1977047574346, 2435.1355268879556, 2435.744246854081, 2437.5734246506877, 2405.0379848060743, 2410.2889647553925, 2448.8530688158767, 2450.901963921441, 2452.435939733862, 2393.1265088242753, 2404.7715467030694, 2405.278416475059, 2429.890654920524, 2434.172381390327, 2329.801966832813, 2336.4158960259933, 2337.4390146364835, 2342.508073304591, 2381.071382160959, 2329.5457385809773, 2340.426595484117, 2342.601757701178, 2348.659444380555, 2352.4589344450874, 9206.815863682688, 9254.120858518498, 9317.301202409846, 9318.161365477139, 9356.157945784911, 5325.733713314357, 5490.80782172626, 5504.0, 5521.613487055908, 5521.834344969658, 3300.227808640753, 3355.3457075870215, 3355.76509644325, 3427.0404286799735, 3427.4002049641213, 1176.7646470705808, 1180.1738782852037, 1185.6857932647856, 1225.5649244518156, 1229.7479016801535, 12596.68508287291, 12673.93663031688, 12747.808782868264, 12761.489540418372, 12920.289384083871, 4716.575508204278, 4778.498257682893, 4778.593819525309, 4815.470298267188, 4953.157963146274, 10833.079188268928, 10835.241533092609, 10838.891611083789, 10841.349519028883, 10848.0, 5476.616636835383, 5495.422980586981, 5505.917411238835, 5533.363663178786, 5542.722863856791, 4418.668599855024, 4596.35651008859, 4846.636502262274, 4994.200927851526, 5056.544910957958, 4169.60388763067, 4190.695117685261, 4223.5142958559545, 4258.552851950562, 4308.202982448257, 1304.4912484131196, 1311.5868501422021, 1324.423875614111, 1335.0988083043906, 1344.227069435059, 1016.6899095775859, 1042.7705904700954, 1044.1229367331478, 1048.501961568249, 1048.5596049659162, 6107.175531303217, 6336.778212762531, 6421.775237866652, 6610.008498725229, 6688.331166883273, 453.74263041368926, 468.9413823272091, 474.85991632468506, 476.1168033298182, 486.4527406667499, 4333.198358303724, 4367.497737760198, 4442.378067070613, 4461.866144015685, 4468.218061839165, 10521.789564208673, 11035.724106897393, 11064.446777661085, 11080.944595276973, 11091.27906686079, 11020.944895275472, 11034.172437067253, 11044.226904116795, 11054.170937179744, 11082.058025067798, 8058.1538938411795, 8258.463199891989, 8459.873101903477, 8464.280536154372, 8645.308375329958, 6161.0, 6227.252729672468, 6246.531510136667, 6316.652584107918, 6467.062275970052, 10135.594576217163, 10203.693889183336, 10208.438535880598, 10329.896701033194, 10437.112845408225, 10169.88131305541, 10344.896551034695, 10408.219383546113, 10645.733856653645, 10670.413127278074, 7004.544704594185, 7554.622268886644, 8125.065617454068, 8126.065502467292, 8330.750077497685, 9032.187103160748, 9097.09029097085, 9117.133872282122, 9119.589618467053, 9122.680706175252, 7937.206279372017, 8048.5975701215875, 8076.273135417606, 8161.470383936972, 8273.048599411144, 7750.186230445947, 7802.375809935305, 7939.6030198491, 7980.521168729895, 7988.800279993046, 6986.6157361343585, 7367.1527774304495, 7524.0, 7535.397168226638, 7539.396848252017, 5198.948010519846, 5238.895222095461, 5352.678839269656, 5359.812406565751, 5389.1107967186545, 5308.2568440419145, 5385.3268341457315, 5409.540189083972, 5415.40430552631, 5495.945040549544], "value": 4721.688389750626, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.5752378099019, 328.5121594432268, 337.2075622287626, 339.1064544924126, 341.66687479707286, 5566.192902029208, 5617.0, 5627.155926611011, 5628.943710562893, 5646.661200327983, 5211.400688920775, 5321.707306098163, 5393.0, 5403.729813509329, 5506.669599824013, 4316.892077698051, 4318.093200427898, 4321.956780432195, 4327.870163895088, 4338.8047537860875, 4320.919770057486, 4332.61356365963, 4352.477702675684, 4358.368036634686, 4385.56144385562, 4042.6361627453525, 4284.935725964113, 4292.141571685675, 4294.892627684301, 4300.591443812833, 4266.360045993095, 4276.037891474424, 4277.160820847019, 4288.6140247377725, 4292.699511034229, 3784.2053168834577, 3790.0, 3791.7535360201773, 3801.8099095045413, 3803.2583646189005, 5266.815661451869, 5300.575953923715, 5428.538574221196, 5447.373552041527, 5465.672059676393, 4891.5353041461, 4900.215965445547, 4903.53416425439, 4913.140200464904, 4917.680350777224, 5718.656880587137, 5728.3126024876865, 5735.770569177228, 5750.856228594277, 5769.798057068025, 4051.2910240707756, 4119.97940010301, 4162.313218318974, 4181.832726690929, 4184.644305234028, 5827.679477628729, 5870.888429132567, 5888.351261646746, 5893.823185304448, 5983.222181116427, 4261.232978063978, 4264.637505811978, 4308.784560772012, 4311.698181127291, 4316.115196384733, 4251.787410629518, 4270.167317373144, 4284.778838031146, 4285.871423857289, 4369.868903932824, 4853.830115945925, 4856.490068542752, 4861.975690121527, 4867.659263851568, 4882.170031094723, 5808.244928159313, 5844.532437404998, 5861.472467477947, 5875.6474611523445, 5881.617694849821, 1387.555982085723, 1418.6949805791805, 1424.893133015028, 1468.9706205876037, 1494.0, 976.5410257179115, 1005.3465247588979, 1006.6627679727227, 1010.9797804043878, 1017.6387382479261, 5422.020962348794, 5555.2778138841695, 5557.166425036196, 5573.303337082864, 5609.02721557567, 5854.2974843018255, 5859.912101318484, 5860.824175274749, 5892.558058145656, 5902.970485147547, 5427.538659214011, 5508.862278442991, 5592.804251851166, 5597.048501754712, 5599.7480113394995, 3060.32672811981, 3101.7828751987145, 3114.3926934247606, 3124.562561241428, 3134.843257837099, 5901.3508514063415, 5905.4685078343155, 5906.202662640574, 5915.733791979371, 5924.637333413253, 5763.682997435098, 5967.701614919237, 6011.355003798315, 6084.30030546484, 6133.84665383369, 6114.144019837227, 6122.663253521099, 6131.325554189036, 6142.293636231891, 6142.662153581507, 5744.540436764965, 5974.22335096452, 6007.879842403215, 6014.248218972629, 6041.305249896318, 5857.26784151981, 5931.881362372642, 5938.940610593839, 5941.316748573797, 5943.405659434022, 6123.510119190365, 6134.693265336805, 6148.907766383419, 6151.169592105009, 6163.599366041193, 4035.1929614076716, 4238.0888109056705, 4264.168487144977, 4294.484661840599, 4297.05464797744, 5977.521798256216, 5981.342052374148, 5985.431384018511, 5986.281646202309, 5989.011813050972, 5608.943910560843, 5632.352279487911, 5754.741036653444, 5832.708364581669, 5851.1515830205235, 5822.912656310074, 5827.1841942127285, 5830.53355731549, 5843.853903652443, 5844.12338149281, 5639.887202256014, 5752.424757524214, 5763.279590051244, 5790.218320526675, 5791.971040144772, 5769.884602307847, 5800.01399762033, 5837.67892765902, 5853.326867410132, 5860.589758717019, 5743.9138412923, 5747.655140691572, 5749.712514374348, 5749.798757043483, 5756.453136951983], "value": 4409.234056703558, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.899387576553, 821.6097353756966, 854.2695994924339, 862.6463150108457, 895.073598825216, 14766.114033158017, 15907.602309942256, 16130.83869161308, 16149.273282702292, 16293.0, 13629.25039122848, 14000.089994150374, 14018.018738688295, 14063.156210627369, 14138.222397768119, 834.1700008491545, 855.1619412975288, 857.9313654907593, 858.0432817408575, 858.4420126917522, 714.6141083814733, 731.7475470962536, 824.5011767880436, 852.3692467574012, 857.5883575883548, 844.535505471991, 845.5349557743217, 846.1158089796147, 846.6867259114106, 848.6859861851124, 850.0988951711175, 850.1838235294125, 851.3912552524912, 851.4933614499332, 851.7402192331336, 632.0582332324849, 632.5540493951798, 633.7560039384824, 633.9175907132043, 634.7365843175077, 14284.714305713931, 14312.28438578067, 14316.498922537765, 14334.49829255971, 14335.641608959755, 15359.769603455958, 15366.00120992132, 15414.152221627806, 15675.372985080583, 15892.52322430329, 12143.0, 12180.756384872342, 12311.507539698401, 12335.198212116273, 12584.244945303311, 4061.451704019949, 4105.958940410617, 4130.442390277334, 4196.538380778112, 4199.097194103252, 72573.637131814, 74394.88407673943, 74565.0, 74804.0, 74921.0, 11666.358350290815, 12187.268763874195, 12436.81344779829, 12450.688732781753, 12580.4338804754, 24162.87918560396, 24437.02251909904, 24547.14085007052, 24630.13794517183, 24871.378215544755, 9277.257819374434, 9300.887295071876, 9362.297827662816, 9481.0, 9490.145886870216, 5064.82273120439, 5189.248219205311, 5229.607779416559, 5255.0, 5329.493698098674, 3479.9304013920087, 3580.480830279595, 3601.8019008954757, 3607.2785442911522, 3609.242059167552, 622.1414448061736, 626.5833220908136, 627.3506920337429, 641.3041849593244, 670.8155257304182, 580.1840240048621, 602.90956356546, 669.7388018672722, 699.951003429755, 778.1246098139593, 9256.444613323221, 9406.623735050522, 9417.764555886157, 9447.480388578557, 9503.097205765442, 706.2831226305304, 726.8691635505554, 735.503535113796, 740.4187712645547, 743.6727839750492, 4212.157568486315, 4369.934450983238, 4444.088961762831, 4465.24090904547, 4542.568455996675, 74579.25420745832, 75034.0, 76311.0, 104460.47769761254, 107918.0, 100235.0, 103113.48443257736, 103346.0, 104413.0, 105064.0, 57401.71299143561, 59514.404855951754, 66410.33589664138, 78831.21168788354, 89044.0, 9789.021097890154, 9935.15551178129, 9948.303618746619, 9964.501774911081, 10020.0, 52027.0, 52514.687132821986, 52768.472315276354, 53372.0, 54132.18801718056, 71501.6424917872, 71659.64170179116, 72725.27274727396, 80763.19236807557, 81525.59237203776, 13520.59438216855, 14013.229272390117, 14066.156030638194, 14069.648258793612, 14179.220142891827, 15270.694586108439, 15341.539753807403, 15540.68918621644, 15844.841551584337, 15980.360785568912, 13115.213087214797, 13715.588532344045, 13914.4434222634, 14179.929100354433, 14974.101553906801, 14040.0, 14479.782803258171, 14712.117272963656, 14837.92581037088, 15154.696906061596, 13162.40769165409, 13476.865231347561, 13877.722445551235, 14131.081479703786, 14853.331600078238, 11630.883691163319, 12430.689232769253, 12508.0, 12591.685207869876, 12631.305278209418, 11945.761084778429, 12224.266544007032, 12232.266064036186, 12254.509819607116, 12326.753464930473], "value": 7692.198477151889, "unit": "score"}], "name": "dromaeo_css", "value": 7492.942227643139, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 112.0, 112.0, 111.0, 112.0, 110.0, 110.0, 111.0, 110.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 115.0, 114.0, 160.0, 120.0, 118.0, 121.0, 118.0, 146.0, 122.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 160.0, 161.0, 159.0, 161.0, 161.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 117.0, 75.0, 76.0, 76.0, 75.0, 95.0, 74.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 116.0, 83.0, 82.0, 80.0, 99.0, 81.0, 81.0, 112.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0, 145.0, 145.0, 148.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 49.0, 49.0, 49.0, 49.0, 50.0, 50.0, 49.0, 49.0, 49.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 57.0, 58.0, 58.0, 60.0, 58.0, 58.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 73.0, 74.0, 77.0, 74.0, 73.0, 77.0, 73.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 124.0, 121.0, 125.0, 119.0, 122.0, 123.0, 119.0, 143.0, 120.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 155.0, 152.0, 151.0, 156.0, 152.0, 150.0, 152.0, 155.0, 160.0], "value": 153.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 62.0, 64.0, 63.0, 60.0, 60.0, 61.0], "value": 61.6, "unit": "score"}], "name": "kraken", "value": 1450.7999999999997, "alertThreshold": 2.0}]} 05:14:15 INFO - Return code: 0 05:14:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:14:15 INFO - # TBPL SUCCESS # 05:14:15 INFO - Running post-action listener: _resource_record_post_action 05:14:15 INFO - [mozharness: 2016-12-30 13:14:15.646886Z] Finished run-tests step (success) 05:14:15 INFO - Running post-run listener: _resource_record_post_run 05:14:15 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 1732608; Write bytes: 332926976; Read time: 92; Write time: 261068 05:14:15 INFO - TinderboxPrint: CPU usage
12.9% 05:14:15 INFO - TinderboxPrint: I/O read bytes / time
1,732,608 / 92 05:14:15 INFO - TinderboxPrint: I/O write bytes / time
332,926,976 / 261,068 05:14:15 INFO - TinderboxPrint: CPU idle
8,252.7 (87.1%) 05:14:15 INFO - TinderboxPrint: CPU user
1,179.3 (12.4%) 05:14:15 INFO - TinderboxPrint: Swap in / out
0 / 0 05:14:15 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 116940800; Read time: 0; Write time: 100932 05:14:15 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 215986176; Read time: 0; Write time: 160136 05:14:16 INFO - Running post-run listener: _upload_blobber_files 05:14:16 INFO - Blob upload gear active. 05:14:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:14:16 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 05:14:16 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:14:16 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:14:16 INFO - (blobuploader) - INFO - Open directory for files ... 05:14:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:14:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:14:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:17 INFO - (blobuploader) - INFO - Done attempting. 05:14:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:14:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:14:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:20 INFO - (blobuploader) - INFO - Done attempting. 05:14:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:14:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:14:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:21 INFO - (blobuploader) - INFO - Done attempting. 05:14:21 INFO - (blobuploader) - INFO - Iteration through files over. 05:14:21 INFO - Return code: 0 05:14:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:14:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:14:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a2c0e2b948251ffa4b5d9e5d9ffda8afac134fb7a9ca2115f8f18680d3ceead2ccf58a5c651985b5e49fbd7e51df22f5c4b62d3ea6247ed7fbf1636cacec4ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3031250726d27e2e693257cd32ef198e248bd44645041dbae46dde722596b4427a95aa03aa3dec11b5512982d19a5df7ad84e0bf65edb09ea9a313e89885a572", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f3580789e8e9896d3f1f1a67e4339e4d916f72190a570858334d959c84e7f37105bddba3d0cfb046ff9b6afe065ff0e1d923ae7e21372b174947a071a0f04444"} 05:14:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:14:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:14:21 INFO - Contents: 05:14:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a2c0e2b948251ffa4b5d9e5d9ffda8afac134fb7a9ca2115f8f18680d3ceead2ccf58a5c651985b5e49fbd7e51df22f5c4b62d3ea6247ed7fbf1636cacec4ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3031250726d27e2e693257cd32ef198e248bd44645041dbae46dde722596b4427a95aa03aa3dec11b5512982d19a5df7ad84e0bf65edb09ea9a313e89885a572", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f3580789e8e9896d3f1f1a67e4339e4d916f72190a570858334d959c84e7f37105bddba3d0cfb046ff9b6afe065ff0e1d923ae7e21372b174947a071a0f04444"} 05:14:21 INFO - Running post-run listener: copy_logs_to_upload_dir 05:14:21 INFO - Copying logs to upload dir... 05:14:21 INFO - mkdir: /builds/slave/test/build/upload/logs 05:14:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.486510 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-12-30 05:14:20.765102) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 05:14:20.772490) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847 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-Beta/sha512/5a2c0e2b948251ffa4b5d9e5d9ffda8afac134fb7a9ca2115f8f18680d3ceead2ccf58a5c651985b5e49fbd7e51df22f5c4b62d3ea6247ed7fbf1636cacec4ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3031250726d27e2e693257cd32ef198e248bd44645041dbae46dde722596b4427a95aa03aa3dec11b5512982d19a5df7ad84e0bf65edb09ea9a313e89885a572", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f3580789e8e9896d3f1f1a67e4339e4d916f72190a570858334d959c84e7f37105bddba3d0cfb046ff9b6afe065ff0e1d923ae7e21372b174947a071a0f04444"} build_url:https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011503 build_url: 'https://queue.taskcluster.net/v1/task/II_bmTQ-S0OX1sDG2RIPGg/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a2c0e2b948251ffa4b5d9e5d9ffda8afac134fb7a9ca2115f8f18680d3ceead2ccf58a5c651985b5e49fbd7e51df22f5c4b62d3ea6247ed7fbf1636cacec4ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3031250726d27e2e693257cd32ef198e248bd44645041dbae46dde722596b4427a95aa03aa3dec11b5512982d19a5df7ad84e0bf65edb09ea9a313e89885a572", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f3580789e8e9896d3f1f1a67e4339e4d916f72190a570858334d959c84e7f37105bddba3d0cfb046ff9b6afe065ff0e1d923ae7e21372b174947a071a0f04444"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 05:14:20.800505) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 05:14:20.800833) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1483098096.689264-443663847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 05:14:21.095742) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 05:14:21.099093) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 05:14:21.099405) ========= ========= Total master_lag: 0.55 =========