builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1481938971.75 results: success (0) buildid: 20161216165049 builduid: b354778d7e4b48d5931cdb6c56570d17 revision: 34a1ab064cb5b868fa75cb74d052e978eb34d6c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 17:42:51.746697) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 17:42:51.747213) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 17:42:51.747551) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 17:42:51.763318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 17:42:51.763611) ========= 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=af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-16 17:42:51-- 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% 223M=0s 2016-12-16 17:42:51 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.190145 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 17:42:51.989971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 17:42:51.990744) ========= 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=af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017479 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 17:42:52.044914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 17:42:52.045722) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34a1ab064cb5b868fa75cb74d052e978eb34d6c1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 34a1ab064cb5b868fa75cb74d052e978eb34d6c1 --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=af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-16 17:42:52,105 truncating revision to first 12 chars 2016-12-16 17:42:52,105 Setting DEBUG logging. 2016-12-16 17:42:52,105 attempt 1/10 2016-12-16 17:42:52,105 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34a1ab064cb5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-16 17:42:52,423 unpacking tar archive at: mozilla-central-34a1ab064cb5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669270 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 17:42:52.731983) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 17:42:52.732364) ========= script_repo_revision: 34a1ab064cb5b868fa75cb74d052e978eb34d6c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 17:42:52.732852) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 17:42:52.733159) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 17:42:52.743995) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-12-16 17:42:52.744359) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:42:53 INFO - MultiFileLogger online at 20161216 17:42:53 in /builds/slave/test 17:42:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:42:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:42:53 INFO - {'append_to_log': False, 17:42:53 INFO - 'base_work_dir': '/builds/slave/test', 17:42:53 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:42:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:42:53 INFO - 'branch': 'Firefox-Non-PGO', 17:42:53 INFO - 'buildbot_json_path': 'buildprops.json', 17:42:53 INFO - 'config_files': ('talos/linux_config.py',), 17:42:53 INFO - 'default_actions': ('clobber', 17:42:53 INFO - 'read-buildbot-config', 17:42:53 INFO - 'download-and-extract', 17:42:53 INFO - 'populate-webroot', 17:42:53 INFO - 'create-virtualenv', 17:42:53 INFO - 'install', 17:42:53 INFO - 'run-tests'), 17:42:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:42:53 INFO - 'download_minidump_stackwalk': True, 17:42:53 INFO - 'download_symbols': 'ondemand', 17:42:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:42:53 INFO - 'tooltool.py': '/tools/tooltool.py', 17:42:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:42:53 INFO - '/tools/misc-python/virtualenv.py')}, 17:42:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:42:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:42:53 INFO - 'installer_path': 'installer.exe', 17:42:53 INFO - 'log_level': 'info', 17:42:53 INFO - 'log_name': 'talos', 17:42:53 INFO - 'log_to_console': True, 17:42:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:42:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:42:53 INFO - 'opt_config_files': (), 17:42:53 INFO - 'pip_index': False, 17:42:53 INFO - 'sps_profile': False, 17:42:53 INFO - 'sps_profile_interval': 0, 17:42:53 INFO - 'suite': 'dromaeojs', 17:42:53 INFO - 'system_bits': '32', 17:42:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:42:53 INFO - 'title': 'talos-linux64-ix-020', 17:42:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:42:53 INFO - 'use_talos_json': True, 17:42:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:42:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:42:53 INFO - 'work_dir': 'build'} 17:42:53 INFO - [mozharness: 2016-12-17 01:42:53.021812Z] Running clobber step. 17:42:53 INFO - Running pre-action listener: _resource_record_pre_action 17:42:53 INFO - Running main action method: clobber 17:42:53 INFO - rmtree: /builds/slave/test/build 17:42:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:42:53 INFO - Running post-action listener: _resource_record_post_action 17:42:53 INFO - [mozharness: 2016-12-17 01:42:53.506661Z] Finished clobber step (success) 17:42:53 INFO - [mozharness: 2016-12-17 01:42:53.506770Z] Running read-buildbot-config step. 17:42:53 INFO - Running pre-action listener: _resource_record_pre_action 17:42:53 INFO - Running main action method: read_buildbot_config 17:42:53 INFO - Using buildbot properties: 17:42:53 INFO - { 17:42:53 INFO - "project": "", 17:42:53 INFO - "product": "firefox", 17:42:53 INFO - "script_repo_revision": "production", 17:42:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:42:53 INFO - "repository": "", 17:42:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:42:53 INFO - "buildid": "20161216165049", 17:42:53 INFO - "pgo_build": "False", 17:42:53 INFO - "basedir": "/builds/slave/test", 17:42:53 INFO - "buildnumber": 874, 17:42:53 INFO - "slavename": "talos-linux64-ix-020", 17:42:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:42:53 INFO - "platform": "ubuntu64_hw", 17:42:53 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:42:53 INFO - "branch": "mozilla-central", 17:42:53 INFO - "repo_path": "mozilla-central", 17:42:53 INFO - "revision": "34a1ab064cb5b868fa75cb74d052e978eb34d6c1", 17:42:53 INFO - "stage_platform": "linux64", 17:42:53 INFO - "builduid": "b354778d7e4b48d5931cdb6c56570d17", 17:42:53 INFO - "slavebuilddir": "test" 17:42:53 INFO - } 17:42:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 17:42:53 INFO - Running post-action listener: _resource_record_post_action 17:42:53 INFO - [mozharness: 2016-12-17 01:42:53.509439Z] Finished read-buildbot-config step (success) 17:42:53 INFO - [mozharness: 2016-12-17 01:42:53.509526Z] Running download-and-extract step. 17:42:53 INFO - Running pre-action listener: _resource_record_pre_action 17:42:53 INFO - Running main action method: download_and_extract 17:42:53 INFO - mkdir: /builds/slave/test/build/tests 17:42:53 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')]} 17:42:53 INFO - trying https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 17:42:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 17:42:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:42:54 INFO - Downloaded 1361 bytes. 17:42:54 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 17:42:54 INFO - Using the following test package requirements: 17:42:54 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 17:42:54 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:42:54 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:42:54 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:54 INFO - u'jsshell-linux-x86_64.zip'], 17:42:54 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:42:54 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 17:42:54 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:42:54 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:42:54 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:42:54 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:42:54 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:42:54 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:42:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 17:42:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:42:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:42:54 INFO - Expected file size: 20213926 17:42:54 INFO - Obtained file size: 20213926 17:42:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:42:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 17:42:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:42:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:43:00 INFO - Expected file size: 20213926 17:43:00 INFO - Obtained file size: 20213926 17:43:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 17:43:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:43:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 17:43:06 INFO - Expected file size: 14409734 17:43:06 INFO - Obtained file size: 14409734 17:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:06 INFO - trying https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:43:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:43:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:43:07 INFO - Downloaded 55619507 bytes. 17:43:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:43:07 INFO - mkdir: /builds/slave/test/properties 17:43:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:43:07 INFO - Writing to file /builds/slave/test/properties/build_url 17:43:07 INFO - Contents: 17:43:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:43:08 INFO - Running post-action listener: _resource_record_post_action 17:43:08 INFO - Running post-action listener: set_extra_try_arguments 17:43:08 INFO - [mozharness: 2016-12-17 01:43:08.029994Z] Finished download-and-extract step (success) 17:43:08 INFO - [mozharness: 2016-12-17 01:43:08.030218Z] Running populate-webroot step. 17:43:08 INFO - Running pre-action listener: _resource_record_pre_action 17:43:08 INFO - Running main action method: populate_webroot 17:43:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:43:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:43:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:43:08 INFO - '--tppagecycles', 17:43:08 INFO - '7'], 17:43:08 INFO - 'tests': ['tsvgm']}}, 17:43:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:43:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:43:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:43:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:43:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:43:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:43:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:43:08 INFO - 'talos_options': ['--disable-e10s'], 17:43:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:43:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:43:08 INFO - 'talos_options': ['--disable-e10s'], 17:43:08 INFO - 'tests': ['damp', 'tps']}, 17:43:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:43:08 INFO - 'tests': ['damp', 'tps']}, 17:43:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:43:08 INFO - 'tests': ['dromaeo_dom']}, 17:43:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:43:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:43:08 INFO - 'tests': ['basic_compositor_video']}, 17:43:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:43:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:43:08 INFO - 'tests': ['a11yr', 17:43:08 INFO - 'ts_paint', 17:43:08 INFO - 'tpaint', 17:43:08 INFO - 'sessionrestore', 17:43:08 INFO - 'sessionrestore_no_auto_restore', 17:43:08 INFO - 'tabpaint']}, 17:43:08 INFO - 'other-e10s': {'tests': ['a11yr', 17:43:08 INFO - 'ts_paint', 17:43:08 INFO - 'tpaint', 17:43:08 INFO - 'sessionrestore', 17:43:08 INFO - 'sessionrestore_no_auto_restore', 17:43:08 INFO - 'tabpaint']}, 17:43:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:43:08 INFO - 'ts_paint', 17:43:08 INFO - 'tpaint', 17:43:08 INFO - 'sessionrestore', 17:43:08 INFO - 'sessionrestore_no_auto_restore', 17:43:08 INFO - 'tabpaint']}, 17:43:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:43:08 INFO - 'ts_paint', 17:43:08 INFO - 'tpaint', 17:43:08 INFO - 'sessionrestore', 17:43:08 INFO - 'sessionrestore_no_auto_restore', 17:43:08 INFO - 'tabpaint']}, 17:43:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:43:08 INFO - 'tests': ['a11yr', 17:43:08 INFO - 'ts_paint', 17:43:08 INFO - 'tpaint', 17:43:08 INFO - 'sessionrestore', 17:43:08 INFO - 'sessionrestore_no_auto_restore', 17:43:08 INFO - 'tabpaint']}, 17:43:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:43:08 INFO - 'tests': ['a11yr', 17:43:08 INFO - 'ts_paint', 17:43:08 INFO - 'tpaint', 17:43:08 INFO - 'sessionrestore', 17:43:08 INFO - 'sessionrestore_no_auto_restore', 17:43:08 INFO - 'tabpaint']}, 17:43:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:43:08 INFO - 'tests': ['tsvgx', 17:43:08 INFO - 'tsvgr_opacity', 17:43:08 INFO - 'tart', 17:43:08 INFO - 'tscrollx', 17:43:08 INFO - 'cart', 17:43:08 INFO - 'tsvg_static']}, 17:43:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:43:08 INFO - 'tsvgr_opacity', 17:43:08 INFO - 'tart', 17:43:08 INFO - 'tscrollx', 17:43:08 INFO - 'cart', 17:43:08 INFO - 'tsvg_static']}, 17:43:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:43:08 INFO - 'talos_options': ['--disable-e10s'], 17:43:08 INFO - 'tests': ['tp5o']}, 17:43:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:43:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:43:08 INFO - 'talos_options': ['--disable-e10s', 17:43:08 INFO - '--xperf_path', 17:43:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:08 INFO - 'tests': ['tp5n']}, 17:43:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:43:08 INFO - 'talos_options': ['--xperf_path', 17:43:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:08 INFO - 'tests': ['tp5n']}}, 17:43:08 INFO - 'talos.zip': {'path': '', 17:43:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:43:08 INFO - Running post-action listener: _resource_record_post_action 17:43:08 INFO - [mozharness: 2016-12-17 01:43:08.052158Z] Finished populate-webroot step (success) 17:43:08 INFO - [mozharness: 2016-12-17 01:43:08.052245Z] Running create-virtualenv step. 17:43:08 INFO - Running pre-action listener: _resource_record_pre_action 17:43:08 INFO - Running main action method: create_virtualenv 17:43:08 INFO - Creating virtualenv /builds/slave/test/build/venv 17:43:08 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 17:43:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:43:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:43:08 INFO - Using real prefix '/usr' 17:43:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:43:10 INFO - Installing distribute.............................................................................................................................................................................................done. 17:43:12 INFO - Installing pip.................done. 17:43:12 INFO - Return code: 0 17:43:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:43:12 INFO - Reading from file tmpfile_stdout 17:43:12 INFO - Output received: 17:43:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:43:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:43:12 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')]} 17:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:12 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')]} 17:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:12 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 0x7f222a949e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4f20>, '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 0xe11c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe11f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', '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 17:43:12 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 17:43:12 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 17:43:12 INFO - Using env: {'DISPLAY': ':0', 17:43:12 INFO - 'HOME': '/home/cltbld', 17:43:12 INFO - 'LANG': 'en_US.UTF-8', 17:43:12 INFO - 'LANGUAGE': 'en_US:en', 17:43:12 INFO - 'LOGNAME': 'cltbld', 17:43:12 INFO - 'MAIL': '/var/mail/cltbld', 17:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:12 INFO - 'MOZ_NO_REMOTE': '1', 17:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:12 INFO - 'NO_EM_RESTART': '1', 17:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:12 INFO - 'PWD': '/builds/slave/test', 17:43:12 INFO - 'SHELL': '/bin/bash', 17:43:12 INFO - 'SHLVL': '1', 17:43:12 INFO - 'TERM': 'linux', 17:43:12 INFO - 'TMOUT': '86400', 17:43:12 INFO - 'USER': 'cltbld', 17:43:12 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', 17:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:12 INFO - '_': '/tools/buildbot/bin/python'} 17:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:12 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 17:43:12 INFO - Cleaning up... 17:43:12 INFO - Return code: 0 17:43:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:43:12 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')]} 17:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:12 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')]} 17:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:12 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 0x7f222a949e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4f20>, '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 0xe11c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe11f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', '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 17:43:12 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 17:43:12 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 17:43:12 INFO - Using env: {'DISPLAY': ':0', 17:43:12 INFO - 'HOME': '/home/cltbld', 17:43:12 INFO - 'LANG': 'en_US.UTF-8', 17:43:12 INFO - 'LANGUAGE': 'en_US:en', 17:43:12 INFO - 'LOGNAME': 'cltbld', 17:43:12 INFO - 'MAIL': '/var/mail/cltbld', 17:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:12 INFO - 'MOZ_NO_REMOTE': '1', 17:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:12 INFO - 'NO_EM_RESTART': '1', 17:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:12 INFO - 'PWD': '/builds/slave/test', 17:43:12 INFO - 'SHELL': '/bin/bash', 17:43:12 INFO - 'SHLVL': '1', 17:43:12 INFO - 'TERM': 'linux', 17:43:12 INFO - 'TMOUT': '86400', 17:43:12 INFO - 'USER': 'cltbld', 17:43:12 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', 17:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:12 INFO - '_': '/tools/buildbot/bin/python'} 17:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:13 INFO - Downloading/unpacking psutil>=3.1.1 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:43:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:15 INFO - Installing collected packages: psutil 17:43:15 INFO - Running setup.py install for psutil 17:43:15 INFO - building 'psutil._psutil_linux' extension 17:43:15 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 17:43:16 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 17:43:16 INFO - building 'psutil._psutil_posix' extension 17:43:16 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 17:43:16 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 17:43:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:16 INFO - Successfully installed psutil 17:43:16 INFO - Cleaning up... 17:43:16 INFO - Return code: 0 17:43:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:43: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')]} 17:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43: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')]} 17:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f222a949e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4f20>, '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 0xe11c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe11f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', '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 17:43: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:43: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 mozsystemmonitor==0.3 17:43:16 INFO - Using env: {'DISPLAY': ':0', 17:43:16 INFO - 'HOME': '/home/cltbld', 17:43:16 INFO - 'LANG': 'en_US.UTF-8', 17:43:16 INFO - 'LANGUAGE': 'en_US:en', 17:43:16 INFO - 'LOGNAME': 'cltbld', 17:43:16 INFO - 'MAIL': '/var/mail/cltbld', 17:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:16 INFO - 'MOZ_NO_REMOTE': '1', 17:43:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:16 INFO - 'NO_EM_RESTART': '1', 17:43:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:16 INFO - 'PWD': '/builds/slave/test', 17:43:16 INFO - 'SHELL': '/bin/bash', 17:43:16 INFO - 'SHLVL': '1', 17:43:16 INFO - 'TERM': 'linux', 17:43:16 INFO - 'TMOUT': '86400', 17:43:16 INFO - 'USER': 'cltbld', 17:43:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', 17:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:16 INFO - '_': '/tools/buildbot/bin/python'} 17:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:43:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:43:18 INFO - Installing collected packages: mozsystemmonitor 17:43:18 INFO - Running setup.py install for mozsystemmonitor 17:43:19 INFO - Successfully installed mozsystemmonitor 17:43:19 INFO - Cleaning up... 17:43:19 INFO - Return code: 0 17:43:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:43:19 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')]} 17:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:19 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')]} 17:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:19 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 0x7f222a949e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4f20>, '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 0xe11c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe11f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', '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 17:43:19 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 17:43:19 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 17:43:19 INFO - Using env: {'DISPLAY': ':0', 17:43:19 INFO - 'HOME': '/home/cltbld', 17:43:19 INFO - 'LANG': 'en_US.UTF-8', 17:43:19 INFO - 'LANGUAGE': 'en_US:en', 17:43:19 INFO - 'LOGNAME': 'cltbld', 17:43:19 INFO - 'MAIL': '/var/mail/cltbld', 17:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:19 INFO - 'MOZ_NO_REMOTE': '1', 17:43:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:19 INFO - 'NO_EM_RESTART': '1', 17:43:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:19 INFO - 'PWD': '/builds/slave/test', 17:43:19 INFO - 'SHELL': '/bin/bash', 17:43:19 INFO - 'SHLVL': '1', 17:43:19 INFO - 'TERM': 'linux', 17:43:19 INFO - 'TMOUT': '86400', 17:43:19 INFO - 'USER': 'cltbld', 17:43:19 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', 17:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:19 INFO - '_': '/tools/buildbot/bin/python'} 17:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:19 INFO - Downloading/unpacking jsonschema==2.5.1 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:43:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:43:21 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 17:43:21 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 17:43:21 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 17:43:21 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 17:43:21 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 17:43:21 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 17:43:21 INFO - Downloading functools32-3.2.3-2.tar.gz 17:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:43:21 INFO - warning: no files found matching '*.txt' 17:43:21 INFO - no previously-included directories found matching 'build' 17:43:21 INFO - no previously-included directories found matching 'dist' 17:43:21 INFO - no previously-included directories found matching '.git*' 17:43:21 INFO - Installing collected packages: jsonschema, functools32 17:43:21 INFO - Running setup.py install for functools32 17:43:21 INFO - warning: no files found matching '*.txt' 17:43:21 INFO - no previously-included directories found matching 'build' 17:43:21 INFO - no previously-included directories found matching 'dist' 17:43:21 INFO - no previously-included directories found matching '.git*' 17:43:21 INFO - Successfully installed jsonschema functools32 17:43:21 INFO - Cleaning up... 17:43:21 INFO - Return code: 0 17:43:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:43:21 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')]} 17:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:21 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')]} 17:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:21 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 0x7f222a949e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4f20>, '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 0xe11c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe11f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', '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 17:43:21 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 17:43:21 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 17:43:21 INFO - Using env: {'DISPLAY': ':0', 17:43:21 INFO - 'HOME': '/home/cltbld', 17:43:21 INFO - 'LANG': 'en_US.UTF-8', 17:43:21 INFO - 'LANGUAGE': 'en_US:en', 17:43:21 INFO - 'LOGNAME': 'cltbld', 17:43:21 INFO - 'MAIL': '/var/mail/cltbld', 17:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:21 INFO - 'MOZ_NO_REMOTE': '1', 17:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:21 INFO - 'NO_EM_RESTART': '1', 17:43:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:21 INFO - 'PWD': '/builds/slave/test', 17:43:21 INFO - 'SHELL': '/bin/bash', 17:43:21 INFO - 'SHLVL': '1', 17:43:21 INFO - 'TERM': 'linux', 17:43:21 INFO - 'TMOUT': '86400', 17:43:21 INFO - 'USER': 'cltbld', 17:43:21 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', 17:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:21 INFO - '_': '/tools/buildbot/bin/python'} 17:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:43:22 INFO - Cleaning up... 17:43:22 INFO - Return code: 0 17:43:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:22 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 0x7f222a949e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4f20>, '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 0xe11c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe11f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', '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 17:43:22 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 17:43:22 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 17:43:22 INFO - Using env: {'DISPLAY': ':0', 17:43:22 INFO - 'HOME': '/home/cltbld', 17:43:22 INFO - 'LANG': 'en_US.UTF-8', 17:43:22 INFO - 'LANGUAGE': 'en_US:en', 17:43:22 INFO - 'LOGNAME': 'cltbld', 17:43:22 INFO - 'MAIL': '/var/mail/cltbld', 17:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:22 INFO - 'MOZ_NO_REMOTE': '1', 17:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:22 INFO - 'NO_EM_RESTART': '1', 17:43:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:22 INFO - 'PWD': '/builds/slave/test', 17:43:22 INFO - 'SHELL': '/bin/bash', 17:43:22 INFO - 'SHLVL': '1', 17:43:22 INFO - 'TERM': 'linux', 17:43:22 INFO - 'TMOUT': '86400', 17:43:22 INFO - 'USER': 'cltbld', 17:43:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', 17:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:22 INFO - '_': '/tools/buildbot/bin/python'} 17:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:22 INFO - Downloading/unpacking blobuploader==1.2.4 17:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:24 INFO - Downloading blobuploader-1.2.4.tar.gz 17:43:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:43:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:43:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43:25 INFO - Downloading docopt-0.6.1.tar.gz 17:43:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:43:25 INFO - Installing collected packages: blobuploader, requests, docopt 17:43:25 INFO - Running setup.py install for blobuploader 17:43:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:43:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:43:25 INFO - Running setup.py install for requests 17:43:25 INFO - Running setup.py install for docopt 17:43:25 INFO - Successfully installed blobuploader requests docopt 17:43:25 INFO - Cleaning up... 17:43:25 INFO - Return code: 0 17:43:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:25 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 0x7f222a949e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4f20>, '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 0xe11c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe11f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', '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 17:43:25 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 17:43:25 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 17:43:25 INFO - Using env: {'DISPLAY': ':0', 17:43:25 INFO - 'HOME': '/home/cltbld', 17:43:25 INFO - 'LANG': 'en_US.UTF-8', 17:43:25 INFO - 'LANGUAGE': 'en_US:en', 17:43:25 INFO - 'LOGNAME': 'cltbld', 17:43:25 INFO - 'MAIL': '/var/mail/cltbld', 17:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:25 INFO - 'MOZ_NO_REMOTE': '1', 17:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:25 INFO - 'NO_EM_RESTART': '1', 17:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:25 INFO - 'PWD': '/builds/slave/test', 17:43:25 INFO - 'SHELL': '/bin/bash', 17:43:25 INFO - 'SHLVL': '1', 17:43:25 INFO - 'TERM': 'linux', 17:43:25 INFO - 'TMOUT': '86400', 17:43:25 INFO - 'USER': 'cltbld', 17:43:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', 17:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:25 INFO - '_': '/tools/buildbot/bin/python'} 17:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:25 INFO - Running setup.py (path:/tmp/pip-xCawm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:26 INFO - Running setup.py (path:/tmp/pip-isX30b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:26 INFO - Running setup.py (path:/tmp/pip-_dr1BK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:26 INFO - Running setup.py (path:/tmp/pip-X1d1pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:26 INFO - Running setup.py (path:/tmp/pip-LqbXZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:26 INFO - Running setup.py (path:/tmp/pip-YlY5aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:26 INFO - Running setup.py (path:/tmp/pip-J2dNIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:26 INFO - Running setup.py (path:/tmp/pip-afDAvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:26 INFO - Running setup.py (path:/tmp/pip-mvrnhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:26 INFO - Running setup.py (path:/tmp/pip-iOEekC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:26 INFO - Running setup.py (path:/tmp/pip-1XojOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:26 INFO - Running setup.py (path:/tmp/pip-5042Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:26 INFO - Running setup.py (path:/tmp/pip-YOvsYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:26 INFO - Running setup.py (path:/tmp/pip-otqN0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:26 INFO - Running setup.py (path:/tmp/pip-sZi0xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:26 INFO - Running setup.py (path:/tmp/pip-NTFc95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:27 INFO - Running setup.py (path:/tmp/pip-QUONu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:43:27 INFO - Running setup.py install for manifestparser 17:43:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:43:27 INFO - Running setup.py install for mozcrash 17:43:27 INFO - Running setup.py install for mozdebug 17:43:27 INFO - Running setup.py install for mozdevice 17:43:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:43:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:43:27 INFO - Running setup.py install for mozfile 17:43:27 INFO - Running setup.py install for mozhttpd 17:43:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:43:27 INFO - Running setup.py install for mozinfo 17:43:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:43:27 INFO - Running setup.py install for mozInstall 17:43:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:43:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:43:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:43:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:43:27 INFO - Running setup.py install for mozleak 17:43:27 INFO - Running setup.py install for mozlog 17:43:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:43:28 INFO - Running setup.py install for moznetwork 17:43:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:43:28 INFO - Running setup.py install for mozprocess 17:43:28 INFO - Running setup.py install for mozprofile 17:43:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:43:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:43:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:43:28 INFO - Running setup.py install for mozrunner 17:43:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:43:28 INFO - Running setup.py install for mozscreenshot 17:43:28 INFO - Running setup.py install for moztest 17:43:28 INFO - Running setup.py install for mozversion 17:43:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:43:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:43:28 INFO - Cleaning up... 17:43:28 INFO - Return code: 0 17:43:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:28 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')]} 17:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:28 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')]} 17:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:28 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 0x7f222a949e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4f20>, '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 0xe11c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe11f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', '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 17:43:28 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 17:43:28 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 17:43:28 INFO - Using env: {'DISPLAY': ':0', 17:43:28 INFO - 'HOME': '/home/cltbld', 17:43:28 INFO - 'LANG': 'en_US.UTF-8', 17:43:28 INFO - 'LANGUAGE': 'en_US:en', 17:43:28 INFO - 'LOGNAME': 'cltbld', 17:43:28 INFO - 'MAIL': '/var/mail/cltbld', 17:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:28 INFO - 'MOZ_NO_REMOTE': '1', 17:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:28 INFO - 'NO_EM_RESTART': '1', 17:43:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:28 INFO - 'PWD': '/builds/slave/test', 17:43:28 INFO - 'SHELL': '/bin/bash', 17:43:28 INFO - 'SHLVL': '1', 17:43:28 INFO - 'TERM': 'linux', 17:43:28 INFO - 'TMOUT': '86400', 17:43:28 INFO - 'USER': 'cltbld', 17:43:28 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', 17:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:28 INFO - '_': '/tools/buildbot/bin/python'} 17:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:29 INFO - Running setup.py (path:/tmp/pip-UgyLyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:29 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)) 17:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:29 INFO - Running setup.py (path:/tmp/pip-kBcrSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:29 INFO - Running setup.py (path:/tmp/pip-xqxazx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:29 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)) 17:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:29 INFO - Running setup.py (path:/tmp/pip-wdbRtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:29 INFO - Running setup.py (path:/tmp/pip-jJbatg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:29 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)) 17:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:29 INFO - Running setup.py (path:/tmp/pip-KKD7gI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:29 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)) 17:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:29 INFO - Running setup.py (path:/tmp/pip-mNOfJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:29 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)) 17:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:29 INFO - Running setup.py (path:/tmp/pip-T56KvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:29 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)) 17:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:29 INFO - Running setup.py (path:/tmp/pip-eWm8QE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:29 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)) 17:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:29 INFO - Running setup.py (path:/tmp/pip-vT2Abz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:29 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)) 17:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:29 INFO - Running setup.py (path:/tmp/pip-ZaQyey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:29 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)) 17:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:29 INFO - Running setup.py (path:/tmp/pip-uR6uqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:30 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)) 17:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:30 INFO - Running setup.py (path:/tmp/pip-qSjb5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:30 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)) 17:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:30 INFO - Running setup.py (path:/tmp/pip-y2fFmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:30 INFO - Running setup.py (path:/tmp/pip-zFEs1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:30 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)) 17:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:30 INFO - Running setup.py (path:/tmp/pip-x_QOZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:30 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)) 17:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:30 INFO - Running setup.py (path:/tmp/pip-9bLH_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:30 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)) 17:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:43:30 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)) 17:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:43:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:32 INFO - Downloading blessings-1.6.tar.gz 17:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:43:32 INFO - Installing collected packages: blessings 17:43:32 INFO - Running setup.py install for blessings 17:43:32 INFO - Successfully installed blessings 17:43:32 INFO - Cleaning up... 17:43:32 INFO - Return code: 0 17:43:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:43:32 INFO - Reading from file tmpfile_stdout 17:43:32 INFO - Current package versions: 17:43:32 INFO - argparse == 1.2.1 17:43:32 INFO - blessings == 1.6 17:43:32 INFO - blobuploader == 1.2.4 17:43:32 INFO - docopt == 0.6.1 17:43:32 INFO - functools32 == 3.2.3-2 17:43:32 INFO - jsonschema == 2.5.1 17:43:32 INFO - manifestparser == 1.1 17:43:32 INFO - mozInstall == 1.12 17:43:32 INFO - mozcrash == 1.0 17:43:32 INFO - mozdebug == 0.1 17:43:32 INFO - mozdevice == 0.49 17:43:32 INFO - mozfile == 1.2 17:43:32 INFO - mozhttpd == 0.7 17:43:32 INFO - mozinfo == 0.9 17:43:32 INFO - mozleak == 0.1 17:43:32 INFO - mozlog == 3.4 17:43:32 INFO - moznetwork == 0.27 17:43:32 INFO - mozprocess == 0.23 17:43:32 INFO - mozprofile == 0.28 17:43:32 INFO - mozrunner == 6.13 17:43:32 INFO - mozscreenshot == 0.1 17:43:32 INFO - mozsystemmonitor == 0.3 17:43:32 INFO - moztest == 0.7 17:43:32 INFO - mozversion == 1.4 17:43:32 INFO - psutil == 3.1.1 17:43:32 INFO - requests == 1.2.3 17:43:32 INFO - wsgiref == 0.1.2 17:43:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:32 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 0x7f222a949e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4f20>, '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 0xe11c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe11f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', '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 17:43:32 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 17:43:32 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 17:43:32 INFO - Using env: {'DISPLAY': ':0', 17:43:32 INFO - 'HOME': '/home/cltbld', 17:43:32 INFO - 'LANG': 'en_US.UTF-8', 17:43:32 INFO - 'LANGUAGE': 'en_US:en', 17:43:32 INFO - 'LOGNAME': 'cltbld', 17:43:32 INFO - 'MAIL': '/var/mail/cltbld', 17:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:32 INFO - 'MOZ_NO_REMOTE': '1', 17:43:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:32 INFO - 'NO_EM_RESTART': '1', 17:43:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:32 INFO - 'PWD': '/builds/slave/test', 17:43:32 INFO - 'SHELL': '/bin/bash', 17:43:32 INFO - 'SHLVL': '1', 17:43:32 INFO - 'TERM': 'linux', 17:43:32 INFO - 'TMOUT': '86400', 17:43:32 INFO - 'USER': 'cltbld', 17:43:32 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', 17:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:32 INFO - '_': '/tools/buildbot/bin/python'} 17:43:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:33 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)) 17:43:33 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)) 17:43:33 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)) 17:43:33 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)) 17:43:33 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)) 17:43:33 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)) 17:43:33 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)) 17:43:33 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)) 17:43:33 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)) 17:43:33 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)) 17:43:33 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)) 17:43:33 INFO - Cleaning up... 17:43:33 INFO - Return code: 0 17:43:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:43:33 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')]} 17:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:33 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')]} 17:43:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:33 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 0x7f222a949e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe14120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4f20>, '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 0xe11c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe11f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', '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 17:43:33 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 17:43:33 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 17:43:33 INFO - Using env: {'DISPLAY': ':0', 17:43:33 INFO - 'HOME': '/home/cltbld', 17:43:33 INFO - 'LANG': 'en_US.UTF-8', 17:43:33 INFO - 'LANGUAGE': 'en_US:en', 17:43:33 INFO - 'LOGNAME': 'cltbld', 17:43:33 INFO - 'MAIL': '/var/mail/cltbld', 17:43:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:33 INFO - 'MOZ_NO_REMOTE': '1', 17:43:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:33 INFO - 'NO_EM_RESTART': '1', 17:43:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:33 INFO - 'PWD': '/builds/slave/test', 17:43:33 INFO - 'SHELL': '/bin/bash', 17:43:33 INFO - 'SHLVL': '1', 17:43:33 INFO - 'TERM': 'linux', 17:43:33 INFO - 'TMOUT': '86400', 17:43:33 INFO - 'USER': 'cltbld', 17:43:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', 17:43:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:33 INFO - '_': '/tools/buildbot/bin/python'} 17:43:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:43:33 INFO - Cleaning up... 17:43:33 INFO - Return code: 0 17:43:33 INFO - Running post-action listener: _resource_record_post_action 17:43:33 INFO - Running post-action listener: _start_resource_monitoring 17:43:33 INFO - Starting resource monitoring. 17:43:33 INFO - [mozharness: 2016-12-17 01:43:33.370573Z] Finished create-virtualenv step (success) 17:43:33 INFO - [mozharness: 2016-12-17 01:43:33.371082Z] Running install step. 17:43:33 INFO - Running pre-action listener: _resource_record_pre_action 17:43:33 INFO - Running main action method: install 17:43:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:43:33 INFO - Reading from file tmpfile_stdout 17:43:33 INFO - Detecting whether we're running mozinstall >=1.0... 17:43:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:43:33 INFO - Reading from file tmpfile_stdout 17:43:33 INFO - Output received: 17:43:33 INFO - Usage: mozinstall [options] installer 17:43:33 INFO - Options: 17:43:33 INFO - -h, --help show this help message and exit 17:43:33 INFO - -d DEST, --destination=DEST 17:43:33 INFO - Directory to install application into. [default: 17:43:33 INFO - "/builds/slave/test"] 17:43:33 INFO - --app=APP Application being installed. [default: firefox] 17:43:33 INFO - mkdir: /builds/slave/test/build/application 17:43:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:43:49 INFO - Reading from file tmpfile_stdout 17:43:49 INFO - Output received: 17:43:49 INFO - /builds/slave/test/build/application/firefox/firefox 17:43:49 INFO - Running post-action listener: _resource_record_post_action 17:43:49 INFO - [mozharness: 2016-12-17 01:43:49.879246Z] Finished install step (success) 17:43:49 INFO - [mozharness: 2016-12-17 01:43:49.879489Z] Running run-tests step. 17:43:49 INFO - Running pre-action listener: _resource_record_pre_action 17:43:49 INFO - Running main action method: run_tests 17:43:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:43:49 INFO - Python 2.7.3 17:43:49 INFO - Return code: 0 17:43:49 INFO - grabbing minidump binary from tooltool 17:43:49 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')]} 17:43:49 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 0xea4f20>, '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 0xe11c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe11f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:43:49 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 17:43:49 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 17:43:49 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 17:43:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:43:50 INFO - Return code: 0 17:43:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:43:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:43:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:43:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:43:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 17:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 17:43:50 INFO - Using env: {'DISPLAY': ':0', 17:43:50 INFO - 'HOME': '/home/cltbld', 17:43:50 INFO - 'LANG': 'en_US.UTF-8', 17:43:50 INFO - 'LANGUAGE': 'en_US:en', 17:43:50 INFO - 'LOGNAME': 'cltbld', 17:43:50 INFO - 'MAIL': '/var/mail/cltbld', 17:43:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:43:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:50 INFO - 'MOZ_NO_REMOTE': '1', 17:43:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:50 INFO - 'NO_EM_RESTART': '1', 17:43:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:50 INFO - 'PWD': '/builds/slave/test', 17:43:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:43:50 INFO - 'SHELL': '/bin/bash', 17:43:50 INFO - 'SHLVL': '1', 17:43:50 INFO - 'TERM': 'linux', 17:43:50 INFO - 'TMOUT': '86400', 17:43:50 INFO - 'USER': 'cltbld', 17:43:50 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903', 17:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:50 INFO - '_': '/tools/buildbot/bin/python'} 17:43:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 17:43:50 INFO - mozversion application_buildid: 20161216165049 17:43:50 INFO - mozversion application_changeset: 34a1ab064cb5b868fa75cb74d052e978eb34d6c1 17:43:50 INFO - mozversion application_display_name: Nightly 17:43:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:43:50 INFO - mozversion application_name: Firefox 17:43:50 INFO - mozversion application_remotingname: firefox 17:43:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:43:50 INFO - mozversion application_vendor: Mozilla 17:43:50 INFO - mozversion application_version: 53.0a1 17:43:50 INFO - mozversion platform_buildid: 20161216165049 17:43:50 INFO - mozversion platform_changeset: 34a1ab064cb5b868fa75cb74d052e978eb34d6c1 17:43:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:43:50 INFO - mozversion platform_version: 53.0a1 17:43:50 INFO - using testdate: 1481939030 17:43:50 INFO - actual date: 1481939030 17:43:50 INFO - starting webserver on 'localhost:33334' 17:43:50 INFO - SUITE-START | Running 2 tests 17:43:50 INFO - TEST-START | dromaeo_css 17:43:50 INFO - operating with platform_type : linux_ 17:43:50 INFO - Initialising browser for dromaeo_css test... 17:43:50 INFO - TEST-INFO | started process 3307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMsfEW4/profile http://localhost:33334/getInfo.html) 17:43:57 INFO - PROCESS | 3307 | __metrics Screen width/height:1600/1200 17:43:57 INFO - PROCESS | 3307 | colorDepth:24 17:43:57 INFO - PROCESS | 3307 | Browser inner width/height: 1024/697 17:43:57 INFO - PROCESS | 3307 | __metrics 17:43:58 INFO - PROCESS | 3307 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:43:58 INFO - PROCESS | 3307 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:43:59 INFO - PROCESS | 3307 | console.error: PushService: 17:43:59 INFO - PROCESS | 3307 | stateChangeProcessEnqueue: Error transitioning state 17:43:59 INFO - PROCESS | 3307 | UnknownError 17:44:00 INFO - TEST-INFO | 3307: exit 0 17:44:00 INFO - Browser initialized. 17:44:00 INFO - Running cycle 1/1 for dromaeo_css test... 17:44:00 INFO - TEST-INFO | started process 3391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMsfEW4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:11 INFO - PROCESS | 3391 | RSS: Main: 156160000 17:44:11 INFO - PROCESS | 3391 | 17:45:02 INFO - PROCESS | 3391 | 1481939102791 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] 17:47:17 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:33334/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33334/tests/dromaeo/cssquery-ext.html) 17:47:18 INFO - PROCESS | 3391 | RSS: Main: 268279808 17:47:18 INFO - PROCESS | 3391 | 17:50:21 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:33334/tests/dromaeo/cssquery-ext.html (next: http://localhost:33334/tests/dromaeo/cssquery-jquery.html) 17:50:21 INFO - PROCESS | 3391 | RSS: Main: 254296064 17:50:21 INFO - PROCESS | 3391 | 17:53:24 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:33334/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33334/tests/dromaeo/cssquery-mootools.html) 17:53:25 INFO - PROCESS | 3391 | RSS: Main: 190578688 17:53:25 INFO - PROCESS | 3391 | 17:56:27 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:33334/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33334/tests/dromaeo/cssquery-prototype.html) 17:56:27 INFO - PROCESS | 3391 | RSS: Main: 190476288 17:56:27 INFO - PROCESS | 3391 | 17:59:31 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:33334/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33334/tests/dromaeo/cssquery-yui.html) 17:59:31 INFO - PROCESS | 3391 | RSS: Main: 191492096 17:59:31 INFO - PROCESS | 3391 | 18:02:34 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:33334/tests/dromaeo/cssquery-yui.html (next: http://localhost:33334/tests/dromaeo/cssquery-dojo.html) 18:02:34 INFO - PROCESS | 3391 | RSS: Main: 285810688 18:02:34 INFO - PROCESS | 3391 | 18:02:34 INFO - PROCESS | 3391 | __start_tp_report 18:02:34 INFO - PROCESS | 3391 | _x_x_mozilla_page_load 18:02:34 INFO - PROCESS | 3391 | _x_x_mozilla_page_load_details 18:02:34 INFO - PROCESS | 3391 | |i|pagename|runs| 18:02:34 INFO - PROCESS | 3391 | |0;dojo.html;2585.3665851866294;2606.752358525942;2607.0223666125207;2617.4372509910368;2623.0163688616767;4561.6806823522365;4623.075384923012;4624.606908412789;4639.211334073208;4643.605293550048;4621.74580398078;4626.352310676508;4645.535446455353;4668.159731248383;4715.056988602285;4212.915741685165;4244.405783190356;4274.465691788527;4317.611414972652;4400.053988392495;3955.7982542890227;4274.551172126929;4329.54539773324;4351.108022855323;4410.272305069676;4201.411802347643;4225.661947044229;4241.024564350186;4315.266404711207;4330.826766929319;4286.61420472159;4292.849750258726;4302.096559722462;4305.84929527465;4308.418363520916;4248.681348898814;4277.893052673677;4284.614384705392;4288.892777680552;4290.099079193342;4674.205385084544;4676.532346765331;4679.649026323005;4727.172744769651;4743.644226682978;4994.475580064077;4995.200767877122;4995.850124496271;4997.350344455198;5048.671836330626;4801.73590452525;4840.273958906157;5018.4981501849525;5027.698338099689;5065.316182315377;4534.115847409724;4572.01701634147;4585.335126406686;4585.679002469862;4586.495485496593;4991.301217829507;4992.101421744048;4994.1509943309;4998.02538504988;5001.699898006132;4833.178359678863;4844.346013288232;4892.68197567157;4921.089598424303;4990.600751939836;5000.374953130859;5003.524665156804;5005.249212618136;5015;5056.797728090909;4816.133096042676;4972.055309491185;4975.353204083446;4983.501649834988;5017.673851199734;4835.032993401333;4841.612670986313;4854.029194161182;4879.316895634614;4924.015196960622;4083.4079058536345;4088.8773336799945;4123.9381409278885;4125.938110928339;4126.566710495415;3599.226166374242;3616.72874534411;3620.7646502977223;3636.2727454509204;3639.654232847928;4220.430241917364;4253.659707223414;4253.8723838284905;4319;4322.848700295474;4953.479884612064;5002.174641184237;5020.874478138003;5029.874253143701;5055.8988820223385;4366.410534577855;4366.43236379275;4374.846880359172;4380.540043295408;4421.867343979686;4283.443152390169;4313.137372525507;4422;4432.623227025674;4469.128519938581;4691.272852707836;4715.127701375257;4731.101090792738;4754.263089221176;4802.927956080732;4998.4251811042195;5012.423571289349;5012.724300163526;5025.673331233605;5054.747262636927;4608.861734147981;4732.503087175797;4748.715077095385;4751.216049351819;4786.353842231254;4818.68678535894;4841.564259216547;4869.415670119608;4886.486918873609;4952.900941981212;4981.327520784647;4981.825636102719;4982.8754281143265;4987.576056035277;5040.722760248075;4787.40157480315;4841.419029716457;4844.224924012282;4853.053654537332;4898.044881248123;4696.953030469788;4720.291956206596;4809.134355815987;4816.940273140044;4836.250381190921;4797.280407938698;4803.567678908915;4805.735684537384;4851.078295123915;4853.684510506806;4820.807167713252;4852.17513022794;4871.3667223260745;4876.536729010738;4919.606431485544;4574.176648203355;4609.147307748078;4611.93082103762;4661.533846615312;4767.73777442244 18:02:34 INFO - PROCESS | 3391 | |1;ext.html;516.4525602860967;529.745722053414;538.5987439357679;544.1049473615899;549.5081901697978;26924.461510769797;30191.396172076573;36912.63087369129;38602.8069859651;38704.22591548167;38906;39134.80432597833;39157.21685566287;39206.21587568247;39416;7510.474266801312;7682.1549629540705;7684.577348245844;7694;7707;7375.963120184391;7562.395008399342;9420.481873496989;9628.22974162069;9663.468509231989;9864.457454839981;9914.603415863357;9924.90075099247;9941.105300522951;9969.950150249239;9790.90209097907;9853.162481189107;9854.359466634718;9858.260630452745;9876.506174691236;9745.415275083447;9801.90198098017;9802.264830137698;9807.26445516589;9832.262580306506;37217.81391093027;37235.441468378;37507.62492375096;37515;37610.81194594037;2863.656361236644;3136.419762343951;3570.732195085353;3580.6419358063986;3645.143391303042;27850.5822412664;27918.581221281696;28056.755459563185;28061.719382806114;28363.716362836312;3418.6068602110577;3526.612072672004;3601.405768048269;3613.223157021253;3648.2703459308245;239437.22532485906;239482.99999999825;241322.99999999825;241524;241614;49920.750396247786;50136;50250.497495025316;50327.748361258695;50372.748136259084;52539;52660;52798;52805.73597132067;52860.735696322045;13813.51652692151;14079;14101.858981410054;14104.858951410355;14128.293585320693;10012.148967337713;10398.376097434179;10558.472076396149;10560.630377936735;10630.840537391945;13270.27013514266;13365.532206372925;14430.340510841177;14776.926115369355;14778.26108694561;6223.906641400383;6239.75040998355;6240.843978900564;6468.450181734511;6474.902876456857;773.7988123088038;871.8212766382876;930.7440453875103;962.1244667352676;1002.6941782756329;24649.383765406008;26242.606360904603;26274.343141421617;26305;27219.183424497296;891.6477991193442;895.4985208283382;917.559571405729;924.2098006204733;983.5229913491951;12314.384280785926;12804;12825;12975;12977.545785897448;336855;340502;341711;342392;342599;36088.45867311992;36839.07902302464;39956.40065399021;40322.79838600788;40820.38769418461;1138.9886101138882;1159.7738441003924;1177.3936422742295;1186.6499382681957;1187.2876274235389;23824.285271441884;24286.878565607058;25386.492270154864;25434.364140896625;25487.87256063708;35724.28551429009;36184.45723314205;36184.63815361813;36195.276094477435;36228.81885590555;300523;300840;301657;301707;303017;20020.499487512345;22379.552408951404;22406.88796556007;22414.663780042985;22435.551288973802;29297.41405171927;30516.542251866686;31142.844285778425;34542.13644658904;35434.29131417305;29991.250218744706;30174.547381788852;30381.848090759406;30480.542791857697;31402.371952561276;29883.55174672338;30029.3994120112;30062.849685751433;30250.84874575613;31269.061928142193;30304.696953030187;30515;30524.236894077825;30527.54208686827;30553.388932221675;26018.052369745717;27817;28231.71768282291;28520.429591408472;28658.283542911595;21661.783382165977;22111.34453781523;22128.778712212672;22218.111275548796;22285.442863928532 18:02:34 INFO - PROCESS | 3391 | |2;jquery.html;348.2634228606495;363.0669180206868;367.56076488596125;368.2285611643607;379.88413533872176;12327.506899724012;13074.215547067171;13890.749832515072;16193.271302791372;16194.75707864383;13864.584062478116;14561.053531520443;14565.854341456583;15115.773263401057;15708.450204242854;4558.065596552707;4702.952970470303;4703.318018887259;4710.199266124767;4716.363290955728;3475.982620086896;3672.247189326195;5604.859878503029;5826.475617194452;5877.85305367365;5908.88182236355;5909.084091965752;5910.67491287979;5910.940890591103;5927.644341339534;4929.408470983487;5170.482951704818;5202.817901373433;5261.394939581921;5266.92099618506;4897.1674815281485;5140.074786538422;5146.147386940698;5147.6911385317;5149.176131818928;12368.1960672556;15394.384224631001;19350.612987740307;20012.399628011182;20028.69956950647;1838.5587459009876;1859.944201673952;1934.7424174286687;2062;2346.0967527502034;8860.955695221546;9335.159835614828;10285.971402859654;11920.523179072827;13384.263865487394;1567.3652170870816;1637.9508614741576;1704.5908981844393;1711.9743203851951;1713.4088739384893;59492.40507594912;63580.36419635837;67788;67843;68096;9447.76380590477;9498.667546635834;9743.561539730728;9783.46190959504;9799.412035277906;13437.395317210749;13447.731045379232;13456.798148027787;13464.259465729283;13471.259080750457;6619.966900165565;6877.799104286681;6960.816661167613;7052.964735176394;7059.329363710542;6473.255575608865;6512.5766825156215;6651.201855777338;6657.800265992028;6689.866202675919;4167.437395951508;4186.28833098374;4191.7484950903045;4256.170046840836;4312.202242585132;1748.4492384898717;1786.6694661487406;1793.399211264241;1820.2841588629612;1852.2961274715522;804.4610111225493;842.5239739547136;856.4647095565272;874.5933141089424;885.1502557544701;15923.283452244677;16357.509274721777;16641.084740339396;16645.25096370666;17144.657106857794;786.2294950948103;796.2674339607574;848.2704873808519;862.2239984014312;872;7880.290773830383;9088.909110908939;9437.858432123523;9540.379875308083;9649.807003859883;223263;228022;228775;345112;349781;80300.19699802928;80746;82516.58741706373;82646.58676706578;83387;883.8409086364516;910.6431417188473;944.8724422203052;946.31392240625;947.5830634520789;15088.471903483325;15215.92392038077;15817.446389376317;15865.762013569574;15938.681226375176;35718;35836.64163358333;36403.817980909924;36481.63518364782;37162;45765.31352029656;49465.50534494609;49529.752351239455;49608.255876161165;49665.50334496609;6996.300369963166;7412.555246685216;7483;7620.885686714593;7671;10726.678199654023;11541.307521548733;11625.418729063682;11713.41432928333;11922.105842061706;9721.805563888824;10092.949535252277;10168.127347522757;10347.896521034694;10556.313839600401;9347.766305842408;9713.56288966984;10271.229657775846;10343;10365.792684146125;5995.310539288038;10116.140128089195;10257.17942564608;10634.787304254027;11010.119190464904;6672.499562532732;7015;7236.710531578678;7401.555906645618;7449.14334851499;5146.588272938231;6443.09796628463;8689.391742577958;9722.513874306398;10797.136229101496 18:02:34 INFO - PROCESS | 3391 | |3;mootools.html;1239.7830379683553;1325.7547353739558;1340.323136815908;1429.2710717534055;1687.5443630219834;6520.44576211022;7221.747238846635;7435.739749108776;7445.404367650589;7596;7465.253474652545;7534.982777325059;7552.773416797491;7553.244675532444;7553.622318884048;1852.8425083867887;1916.6358391905562;2120.0565748242;2165.8592191507582;2173.717416735822;2143.5927173837;2211.1045026764186;2211.292386436341;2216.0581752755097;2216.1578600132007;2101.485136141647;2115.830733541313;2117.6823476478576;2118.9576208475823;2121.596896589651;2130.5206328576023;2147.3450597567735;2151.279321427308;2151.7740637233023;2156.1806513524916;2094.1518684932626;2106.052276475577;2118.226847200776;2122.193566444741;2125.3942626351572;7267.745628903016;7320.341169294736;7352.22801605829;7408.111026676779;7521.887171692429;4403.4495688039;4554.977225113853;4568.862934111982;4571.497135315112;4572.497025327211;2804.7756179505795;2942;3012.8493575321145;3016.155476466593;3024.74289685377;900.4777229207044;936.0919907689598;952.8523078922778;977.7702239973601;979.2851218610383;10089.798204035878;10123.797524049478;10126.493675316206;10141.89858101417;10153.238507111997;3861.942070868939;4059.0867054913;4102.651274641629;4121.814518346621;4228.767417792051;8449.070602233749;8469.280111190617;8563.914360856435;8575.013873404514;8579.356548258906;4505.144022635689;4574.108048930493;4593.63250939924;4601.930971035437;4612.169809434267;3477.530533378012;3555.768875023115;4129.2773764591075;4139.586041395896;4140.0891803803115;3390.660933906639;3436.60479044913;3547.8935631931085;3554.4668299754726;3572.303400836864;1141.3266172957995;1163.1102206811795;1163.947622356996;1182.8107502799683;1188.8811118888043;645.4223469994329;749.318120510333;761.6153842309598;784.8351846112266;789.057076793238;4522.728636281834;4637.25803871379;4677.929831052537;4690.624750019991;4726.527347265314;367.6084969507466;385.50270151504805;390.5723233059795;392.36828705783665;396.4806104003764;3096.303331750383;3144.5283207519055;3176.444122278592;3198.7281081108367;3312.7846689965077;8683.131686831393;8878.689245876492;8935.687250946186;8958.462492250486;9101.590428430736;8883.555822208864;8895.911040889638;8903.06517815633;8908.821823563492;8909.688160914337;6804.727810887608;6866.210385805696;6909.965450172717;6932.688029038705;6942.7222911084;4487.7980490878645;4587.6788624795945;4600.815967361268;4635.142498637762;4741.83403580873;8164.673413063411;8197.918020819954;8205.261526462647;8264.793380165544;8280.171982801672;8187.26314631686;8300.086990430927;8319.376046796393;8368.41421100517;8372.204640559137;5711.7429715662065;5891;6360.045993101072;6444.645544495098;6448.387403196689;6713.798586042427;6870.965645171942;6906.930930690629;7036.683349249193;7079.82300442493;6356.618602883842;6368.172137622079;6430.742770289323;6606.042123892104;6628.337166283333;6228.813135605939;6312.053192021233;6364.554481186273;6434.227892652912;6486.578372405778;5528.198411230269;5605;5605.747741351567;5622.7750889963945;5634.915476267941;4021.537523184871;4044.069863931371;4080.591940805896;4174.352975288835;4175.478065241845;4138.689598280202;4155.771432571238;4156.168766246702;4290.206311832196;4333.9349909750745 18:02:34 INFO - PROCESS | 3391 | |4;prototype.html;357.1838349371685;357.67094273268594;361.5932076414034;365.32415032190437;365.7311875771309;4613.677042607019;4677.508861569533;4682.578567928886;4685.509295574797;4701.694389864657;4632.97683511582;4648.093621743753;4649.279361698934;4654.674172807905;4665.463471700756;3327.9334413311717;3536.929261414783;3647.2340808430263;3773.1135681203764;3810.7141964352713;3761.2477504499075;3765.755225910307;3774.603666615007;3775.6790672792845;3791.6777073948747;3743.906402339936;3749.662530372266;3752.587215406317;3753.9061523461996;3784.1674831537016;3578.2306804037257;3578.964210357889;3655.323765103438;3766.152615661482;3772.849086036555;3362.7309815214726;3363.9663603363897;3365.468711736154;3378.2567835076243;3378.2939615494265;4515.05183911379;4520.033785303403;4530.660200484944;4534.88662783433;4538.570350339633;4226.936595951063;4235.131797981407;4246.490421149482;4246.978765106154;4259.680523960716;4617.699849509771;4821.517848215186;4837.2260438329695;4841.49164337743;4849.733264670442;3506.4740288956605;3513.8243087845503;3515;3524;3532.1875968527384;4840.298156767284;4939.98730260303;5061.848144555669;5078.873028174326;5089.6691715038405;3451.2234747181683;3560.7151427885706;3564.3049605326714;3570.6072332043454;3587.4260118380935;3605.8737944171826;3607.6753092221825;3619.873304434332;3636.8545258189906;3638.381475149231;4099.569545197771;4109.075458021981;4109.773962432095;4114.300568903293;4121.690873184523;4717.363155973968;4804.6876952997945;4840;4849.539293767087;4852.587530059914;1207.3178654060428;1212.830203771455;1216.6897441152626;1224.3143839449936;1226.478746532738;810.789194809342;836.9163083691582;837.5184269045324;850.7362717557577;855.6064210463132;4261.531231564525;4265.91468170641;4280.892977675583;4280.935785963213;4284.271673815459;4884.242942343943;4886.7067975920845;4897.216445368724;4905.2151655734915;4906.822362633014;4226.640735537452;4230.788460576959;4231.513375961804;4237.4321501044815;4257.361395790656;2406.566817972747;2562.4490734492174;2565.897364105415;2576.974230257711;2589.728078551763;4561.058117514185;4567;4585.9541404585525;4589.691937797712;4589.770511474413;4931.632816248221;4940.1601727706375;4948.554630083309;4958.281049247839;4963.436517497049;4301.806418711103;4493.326001099861;4564.315352697122;4599.2871104978785;4607.76961151941;4798.3042458843975;4820.084184005028;4837.685550439211;4844.297576851407;4847.927281090857;4768.8092476301945;4782.210935195653;4786.976065119652;4794.59245964083;4799.1841386965;4401.339799030043;4538.432695913011;4567.81728730847;4573.81704731807;4584.083183363407;3473.7568370213844;3498.930021399507;3561.8041007743786;3572.678458938708;3576.481410195559;4938;4951.752412379438;4959.504049595012;4965.851024469272;4971.453140154653;4786.808527658994;4792.7363994980615;4800.639952003544;4828.903421931472;4852.369192005017;4544.7045942013665;4749.7625118743235;4779.450363208137;4802.639802014793;4820.25286080658;4752.310914917249;4757.857264282077;4760.880977975578;4766.475687674422;4770.737609431515;4860.756962151949;4861.319415281934;4862.270659400977;4865.7323847188745;4868.61051115917;4526.479454862733;4675.345451636842;4681.625469962327;4722.150012997693;4723.409573803275 18:02:34 INFO - PROCESS | 3391 | |5;yui.html;628.8176428835641;641.2433328672167;675.1391975231579;678.2742465561847;716.4912911832598;13210.40553175107;14438.20589867557;14455.927720361384;14459.710805783878;14460.710785784291;12953.28756918369;13001.544945926895;13047.934760326209;13058.869411305885;13090.476380944774;616.8581226317949;629.0469938043844;739.9482036257464;748.5172064018705;763.4541302968377;752.2966026764992;776.0842206196714;776.2819392062348;776.6000509737489;776.7397921696239;820.8604537228686;822;822.383212590557;823.0945959444593;823.3948048184609;645.4481418387259;661.0976017735804;792.3502727763237;812.2324403438753;812.995935020327;597.3190562758459;605.8212827215938;605.9030555111161;606.423897297569;606.548121649374;12760.6809829755;12762.042846786528;12773.872261277362;12794.680132996657;12800.61598152057;12846.400431408936;12898.80651790224;12931.935340323238;12969.87030129696;13098;11429.02853257474;11491.59779407725;11548.133889958286;11810.409479526075;11844.526218951232;4025.1144748155357;4026.838926442939;4060.309747342959;4220.07158425146;4233.576642335742;69332;69706;70120.64939675269;70324.64837675779;72712.63643681801;10069.848952265722;10181.847272290921;10349.534270957825;10408.583656653649;10764.085052770446;19671.606567868563;20030.098645560985;20058.39824805258;20067.197312107353;20283.59432811365;6524.902126468011;6557.442617377481;6634.270230274666;6683.131192944983;6739.764108256188;3529.6293889141784;3611.8735844245853;3616.403293456603;3649.1606930406156;3660.3960346543054;2781.7079206683006;2835.2911772056987;2843.1754791110347;2851.230167854668;2851.9429611408073;475.8358366363599;484.52758560404027;493.0902484915325;497.5571741150379;497.6566169343214;490.5217413022275;510.2295533743999;536.7906516458585;565.1861319699619;573.5698226330252;7220.74727384539;7506.699732010768;7720.459567830198;7873.803154921058;8050.677972881136;478.5716783478837;531.6544246239897;556.7244214113958;562.8620987858001;575.3297408519029;3786.981065094657;3823.235352929425;3944.4872166618156;3953.5651078381356;4032.7580345179385;52101;52162.73918630383;54961.725191374586;65517.672411637635;65860.67069664621;58324.12513812296;58457.41542584605;59750.40249597535;59843.700781496686;63810.36189638137;52497.2125418119;52533.737331313096;52616;52953.94092118136;52976.47023529715;7020.719171233093;7731.6520756567215;7757.65090570937;7894.447388682966;7895.960520197592;37434.62565374311;37697.62302377051;37773;38027.80986095052;39358.40962385509;44169;48952.75523622359;50054.74972625114;50250;52492.47507524876;9424.481653508848;9717.12545870875;9957.551910164206;10010.499475026074;10105;10545.420001899662;10688.038076573146;10702.83945740799;10756.193285503463;11107.888921110685;9807.460589667637;10121.59513619447;10212.438315892698;10475.685729428129;10881;9619.903800961902;9633.662821801203;9698.321117521988;10061.748456288651;10340.741481463023;9522;9545.52272386364;9746.26902982265;9766.658166964122;9845.409275443497;7995.560244186626;8703.347248956481;8768.167024132697;8777.473351598925;8872.689455869013;7967.362610991223;7996.60016999136;8281;8394.160583941557;8591.398602097794 18:02:34 INFO - PROCESS | 3391 | __end_tp_report 18:02:34 INFO - PROCESS | 3391 | __start_cc_report 18:02:34 INFO - PROCESS | 3391 | _x_x_mozilla_cycle_collect,1302 18:02:34 INFO - PROCESS | 3391 | __end_cc_report 18:02:34 INFO - PROCESS | 3391 | __startTimestamp1481940154913__endTimestamp 18:02:34 INFO - PROCESS | 3391 | 18:02:34 INFO - PROCESS | 3391 | ------- Summary: start ------- 18:02:34 INFO - PROCESS | 3391 | Number of tests: 6 18:02:34 INFO - PROCESS | 3391 | 18:02:34 INFO - PROCESS | 3391 | [#0] dojo.html Cycles:165 Average:4585.71 Median:4727.17 stddev:484.62 (10.3%) stddev-sans-first:460.00 18:02:34 INFO - PROCESS | 3391 | Values: 2585.4 2606.8 2607.0 2617.4 2623.0 4561.7 4623.1 4624.6 4639.2 4643.6 4621.7 4626.4 4645.5 4668.2 4715.1 4212.9 4244.4 4274.5 4317.6 4400.1 3955.8 4274.6 4329.5 4351.1 4410.3 4201.4 4225.7 4241.0 4315.3 4330.8 4286.6 4292.8 4302.1 4305.8 4308.4 4248.7 4277.9 4284.6 4288.9 4290.1 4674.2 4676.5 4679.6 4727.2 4743.6 4994.5 4995.2 4995.9 4997.4 5048.7 4801.7 4840.3 5018.5 5027.7 5065.3 4534.1 4572.0 4585.3 4585.7 4586.5 4991.3 4992.1 4994.2 4998.0 5001.7 4833.2 4844.3 4892.7 4921.1 4990.6 5000.4 5003.5 5005.2 5015.0 5056.8 4816.1 4972.1 4975.4 4983.5 5017.7 4835.0 4841.6 4854.0 4879.3 4924.0 4083.4 4088.9 4123.9 4125.9 4126.6 3599.2 3616.7 3620.8 3636.3 3639.7 4220.4 4253.7 4253.9 4319.0 4322.8 4953.5 5002.2 5020.9 5029.9 5055.9 4366.4 4366.4 4374.8 4380.5 4421.9 4283.4 4313.1 4422.0 4432.6 4469.1 4691.3 4715.1 4731.1 4754.3 4802.9 4998.4 5012.4 5012.7 5025.7 5054.7 4608.9 4732.5 4748.7 4751.2 4786.4 4818.7 4841.6 4869.4 4886.5 4952.9 4981.3 4981.8 4982.9 4987.6 5040.7 4787.4 4841.4 4844.2 4853.1 4898.0 4697.0 4720.3 4809.1 4816.9 4836.3 4797.3 4803.6 4805.7 4851.1 4853.7 4820.8 4852.2 4871.4 4876.5 4919.6 4574.2 4609.1 4611.9 4661.5 4767.7 18:02:34 INFO - PROCESS | 3391 | 18:02:34 INFO - PROCESS | 3391 | [#1] ext.html Cycles:180 Average:43340.02 Median:172564.80 stddev:78116.78 (45.3%) stddev-sans-first:78269.75 18:02:34 INFO - PROCESS | 3391 | Values: 516.5 529.7 538.6 544.1 549.5 26924.5 30191.4 36912.6 38602.8 38704.2 38906.0 39134.8 39157.2 39206.2 39416.0 7510.5 7682.2 7684.6 7694.0 7707.0 7376.0 7562.4 9420.5 9628.2 9663.5 9864.5 9914.6 9924.9 9941.1 9970.0 9790.9 9853.2 9854.4 9858.3 9876.5 9745.4 9801.9 9802.3 9807.3 9832.3 37217.8 37235.4 37507.6 37515.0 37610.8 2863.7 3136.4 3570.7 3580.6 3645.1 27850.6 27918.6 28056.8 28061.7 28363.7 3418.6 3526.6 3601.4 3613.2 3648.3 239437.2 239483.0 241323.0 241524.0 241614.0 49920.8 50136.0 50250.5 50327.7 50372.7 52539.0 52660.0 52798.0 52805.7 52860.7 13813.5 14079.0 14101.9 14104.9 14128.3 10012.1 10398.4 10558.5 10560.6 10630.8 13270.3 13365.5 14430.3 14776.9 14778.3 6223.9 6239.8 6240.8 6468.5 6474.9 773.8 871.8 930.7 962.1 1002.7 24649.4 26242.6 26274.3 26305.0 27219.2 891.6 895.5 917.6 924.2 983.5 12314.4 12804.0 12825.0 12975.0 12977.5 336855.0 340502.0 341711.0 342392.0 342599.0 36088.5 36839.1 39956.4 40322.8 40820.4 1139.0 1159.8 1177.4 1186.6 1187.3 23824.3 24286.9 25386.5 25434.4 25487.9 35724.3 36184.5 36184.6 36195.3 36228.8 300523.0 300840.0 301657.0 301707.0 303017.0 20020.5 22379.6 22406.9 22414.7 22435.6 29297.4 30516.5 31142.8 34542.1 35434.3 29991.3 30174.5 30381.8 30480.5 31402.4 29883.6 30029.4 30062.8 30250.8 31269.1 30304.7 30515.0 30524.2 30527.5 30553.4 26018.1 27817.0 28231.7 28520.4 28658.3 21661.8 22111.3 22128.8 22218.1 22285.4 18:02:34 INFO - PROCESS | 3391 | 18:02:34 INFO - PROCESS | 3391 | [#2] jquery.html Cycles:180 Average:20695.00 Median:4706.76 stddev:47568.11 (1010.6%) stddev-sans-first:47677.02 18:02:34 INFO - PROCESS | 3391 | Values: 348.3 363.1 367.6 368.2 379.9 12327.5 13074.2 13890.7 16193.3 16194.8 13864.6 14561.1 14565.9 15115.8 15708.5 4558.1 4703.0 4703.3 4710.2 4716.4 3476.0 3672.2 5604.9 5826.5 5877.9 5908.9 5909.1 5910.7 5910.9 5927.6 4929.4 5170.5 5202.8 5261.4 5266.9 4897.2 5140.1 5146.1 5147.7 5149.2 12368.2 15394.4 19350.6 20012.4 20028.7 1838.6 1859.9 1934.7 2062.0 2346.1 8861.0 9335.2 10286.0 11920.5 13384.3 1567.4 1638.0 1704.6 1712.0 1713.4 59492.4 63580.4 67788.0 67843.0 68096.0 9447.8 9498.7 9743.6 9783.5 9799.4 13437.4 13447.7 13456.8 13464.3 13471.3 6620.0 6877.8 6960.8 7053.0 7059.3 6473.3 6512.6 6651.2 6657.8 6689.9 4167.4 4186.3 4191.7 4256.2 4312.2 1748.4 1786.7 1793.4 1820.3 1852.3 804.5 842.5 856.5 874.6 885.2 15923.3 16357.5 16641.1 16645.3 17144.7 786.2 796.3 848.3 862.2 872.0 7880.3 9088.9 9437.9 9540.4 9649.8 223263.0 228022.0 228775.0 345112.0 349781.0 80300.2 80746.0 82516.6 82646.6 83387.0 883.8 910.6 944.9 946.3 947.6 15088.5 15215.9 15817.4 15865.8 15938.7 35718.0 35836.6 36403.8 36481.6 37162.0 45765.3 49465.5 49529.8 49608.3 49665.5 6996.3 7412.6 7483.0 7620.9 7671.0 10726.7 11541.3 11625.4 11713.4 11922.1 9721.8 10092.9 10168.1 10347.9 10556.3 9347.8 9713.6 10271.2 10343.0 10365.8 5995.3 10116.1 10257.2 10634.8 11010.1 6672.5 7015.0 7236.7 7401.6 7449.1 5146.6 6443.1 8689.4 9722.5 10797.1 18:02:34 INFO - PROCESS | 3391 | 18:02:34 INFO - PROCESS | 3391 | [#3] mootools.html Cycles:180 Average:4809.65 Median:4597.22 stddev:2687.53 (58.5%) stddev-sans-first:2681.67 18:02:34 INFO - PROCESS | 3391 | Values: 1239.8 1325.8 1340.3 1429.3 1687.5 6520.4 7221.7 7435.7 7445.4 7596.0 7465.3 7535.0 7552.8 7553.2 7553.6 1852.8 1916.6 2120.1 2165.9 2173.7 2143.6 2211.1 2211.3 2216.1 2216.2 2101.5 2115.8 2117.7 2119.0 2121.6 2130.5 2147.3 2151.3 2151.8 2156.2 2094.2 2106.1 2118.2 2122.2 2125.4 7267.7 7320.3 7352.2 7408.1 7521.9 4403.4 4555.0 4568.9 4571.5 4572.5 2804.8 2942.0 3012.8 3016.2 3024.7 900.5 936.1 952.9 977.8 979.3 10089.8 10123.8 10126.5 10141.9 10153.2 3861.9 4059.1 4102.7 4121.8 4228.8 8449.1 8469.3 8563.9 8575.0 8579.4 4505.1 4574.1 4593.6 4601.9 4612.2 3477.5 3555.8 4129.3 4139.6 4140.1 3390.7 3436.6 3547.9 3554.5 3572.3 1141.3 1163.1 1163.9 1182.8 1188.9 645.4 749.3 761.6 784.8 789.1 4522.7 4637.3 4677.9 4690.6 4726.5 367.6 385.5 390.6 392.4 396.5 3096.3 3144.5 3176.4 3198.7 3312.8 8683.1 8878.7 8935.7 8958.5 9101.6 8883.6 8895.9 8903.1 8908.8 8909.7 6804.7 6866.2 6910.0 6932.7 6942.7 4487.8 4587.7 4600.8 4635.1 4741.8 8164.7 8197.9 8205.3 8264.8 8280.2 8187.3 8300.1 8319.4 8368.4 8372.2 5711.7 5891.0 6360.0 6444.6 6448.4 6713.8 6871.0 6906.9 7036.7 7079.8 6356.6 6368.2 6430.7 6606.0 6628.3 6228.8 6312.1 6364.6 6434.2 6486.6 5528.2 5605.0 5605.7 5622.8 5634.9 4021.5 4044.1 4080.6 4174.4 4175.5 4138.7 4155.8 4156.2 4290.2 4333.9 18:02:34 INFO - PROCESS | 3391 | 18:02:34 INFO - PROCESS | 3391 | [#4] prototype.html Cycles:180 Average:4016.14 Median:4552.88 stddev:1135.91 (24.9%) stddev-sans-first:1105.40 18:02:34 INFO - PROCESS | 3391 | Values: 357.2 357.7 361.6 365.3 365.7 4613.7 4677.5 4682.6 4685.5 4701.7 4633.0 4648.1 4649.3 4654.7 4665.5 3327.9 3536.9 3647.2 3773.1 3810.7 3761.2 3765.8 3774.6 3775.7 3791.7 3743.9 3749.7 3752.6 3753.9 3784.2 3578.2 3579.0 3655.3 3766.2 3772.8 3362.7 3364.0 3365.5 3378.3 3378.3 4515.1 4520.0 4530.7 4534.9 4538.6 4226.9 4235.1 4246.5 4247.0 4259.7 4617.7 4821.5 4837.2 4841.5 4849.7 3506.5 3513.8 3515.0 3524.0 3532.2 4840.3 4940.0 5061.8 5078.9 5089.7 3451.2 3560.7 3564.3 3570.6 3587.4 3605.9 3607.7 3619.9 3636.9 3638.4 4099.6 4109.1 4109.8 4114.3 4121.7 4717.4 4804.7 4840.0 4849.5 4852.6 1207.3 1212.8 1216.7 1224.3 1226.5 810.8 836.9 837.5 850.7 855.6 4261.5 4265.9 4280.9 4280.9 4284.3 4884.2 4886.7 4897.2 4905.2 4906.8 4226.6 4230.8 4231.5 4237.4 4257.4 2406.6 2562.4 2565.9 2577.0 2589.7 4561.1 4567.0 4586.0 4589.7 4589.8 4931.6 4940.2 4948.6 4958.3 4963.4 4301.8 4493.3 4564.3 4599.3 4607.8 4798.3 4820.1 4837.7 4844.3 4847.9 4768.8 4782.2 4787.0 4794.6 4799.2 4401.3 4538.4 4567.8 4573.8 4584.1 3473.8 3498.9 3561.8 3572.7 3576.5 4938.0 4951.8 4959.5 4965.9 4971.5 4786.8 4792.7 4800.6 4828.9 4852.4 4544.7 4749.8 4779.5 4802.6 4820.3 4752.3 4757.9 4760.9 4766.5 4770.7 4860.8 4861.3 4862.3 4865.7 4868.6 4526.5 4675.3 4681.6 4722.2 4723.4 18:02:34 INFO - PROCESS | 3391 | 18:02:34 INFO - PROCESS | 3391 | [#5] yui.html Cycles:180 Average:14809.84 Median:52784.97 stddev:19030.50 (36.1%) stddev-sans-first:19054.09 18:02:34 INFO - PROCESS | 3391 | Values: 628.8 641.2 675.1 678.3 716.5 13210.4 14438.2 14455.9 14459.7 14460.7 12953.3 13001.5 13047.9 13058.9 13090.5 616.9 629.0 739.9 748.5 763.5 752.3 776.1 776.3 776.6 776.7 820.9 822.0 822.4 823.1 823.4 645.4 661.1 792.4 812.2 813.0 597.3 605.8 605.9 606.4 606.5 12760.7 12762.0 12773.9 12794.7 12800.6 12846.4 12898.8 12931.9 12969.9 13098.0 11429.0 11491.6 11548.1 11810.4 11844.5 4025.1 4026.8 4060.3 4220.1 4233.6 69332.0 69706.0 70120.6 70324.6 72712.6 10069.8 10181.8 10349.5 10408.6 10764.1 19671.6 20030.1 20058.4 20067.2 20283.6 6524.9 6557.4 6634.3 6683.1 6739.8 3529.6 3611.9 3616.4 3649.2 3660.4 2781.7 2835.3 2843.2 2851.2 2851.9 475.8 484.5 493.1 497.6 497.7 490.5 510.2 536.8 565.2 573.6 7220.7 7506.7 7720.5 7873.8 8050.7 478.6 531.7 556.7 562.9 575.3 3787.0 3823.2 3944.5 3953.6 4032.8 52101.0 52162.7 54961.7 65517.7 65860.7 58324.1 58457.4 59750.4 59843.7 63810.4 52497.2 52533.7 52616.0 52953.9 52976.5 7020.7 7731.7 7757.7 7894.4 7896.0 37434.6 37697.6 37773.0 38027.8 39358.4 44169.0 48952.8 50054.7 50250.0 52492.5 9424.5 9717.1 9957.6 10010.5 10105.0 10545.4 10688.0 10702.8 10756.2 11107.9 9807.5 10121.6 10212.4 10475.7 10881.0 9619.9 9633.7 9698.3 10061.7 10340.7 9522.0 9545.5 9746.3 9766.7 9845.4 7995.6 8703.3 8768.2 8777.5 8872.7 7967.4 7996.6 8281.0 8394.2 8591.4 18:02:34 INFO - PROCESS | 3391 | -------- Summary: end -------- 18:02:34 INFO - PROCESS | 3391 | 18:02:35 INFO - TEST-INFO | 3391: exit 0 18:02:35 INFO - TEST-OK | dromaeo_css | took 1125196ms 18:02:35 INFO - TEST-START | kraken 18:02:35 INFO - operating with platform_type : linux_ 18:02:35 INFO - Initialising browser for kraken test... 18:02:35 INFO - TEST-INFO | started process 3689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpworEMJ/profile http://localhost:33334/getInfo.html) 18:02:40 INFO - PROCESS | 3689 | __metrics Screen width/height:1600/1200 18:02:40 INFO - PROCESS | 3689 | colorDepth:24 18:02:40 INFO - PROCESS | 3689 | Browser inner width/height: 1024/697 18:02:40 INFO - PROCESS | 3689 | __metrics 18:02:40 INFO - PROCESS | 3689 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:02:40 INFO - PROCESS | 3689 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:02:41 INFO - PROCESS | 3689 | console.error: PushService: 18:02:41 INFO - PROCESS | 3689 | stateChangeProcessEnqueue: Error transitioning state 18:02:41 INFO - PROCESS | 3689 | UnknownError 18:02:42 INFO - TEST-INFO | 3689: exit 0 18:02:42 INFO - Browser initialized. 18:02:42 INFO - Running cycle 1/1 for kraken test... 18:02:42 INFO - TEST-INFO | started process 3773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpworEMJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:02:54 INFO - PROCESS | 3773 | RSS: Main: 156033024 18:02:54 INFO - PROCESS | 3773 | 18:02:56 INFO - PROCESS | 3773 | Cycle 1(1): loaded http://localhost:33334/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33334/tests/kraken/driver.html?testName=audio-beat-detection) 18:02:57 INFO - PROCESS | 3773 | RSS: Main: 210042880 18:02:57 INFO - PROCESS | 3773 | 18:03:00 INFO - PROCESS | 3773 | Cycle 1(1): loaded http://localhost:33334/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33334/tests/kraken/driver.html?testName=audio-dft) 18:03:01 INFO - PROCESS | 3773 | RSS: Main: 188055552 18:03:01 INFO - PROCESS | 3773 | 18:03:04 INFO - PROCESS | 3773 | Cycle 1(1): loaded http://localhost:33334/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33334/tests/kraken/driver.html?testName=audio-fft) 18:03:04 INFO - PROCESS | 3773 | RSS: Main: 270204928 18:03:04 INFO - PROCESS | 3773 | 18:03:07 INFO - PROCESS | 3773 | Cycle 1(1): loaded http://localhost:33334/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33334/tests/kraken/driver.html?testName=audio-oscillator) 18:03:07 INFO - PROCESS | 3773 | RSS: Main: 181792768 18:03:07 INFO - PROCESS | 3773 | 18:03:09 INFO - PROCESS | 3773 | Cycle 1(1): loaded http://localhost:33334/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33334/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:03:10 INFO - PROCESS | 3773 | RSS: Main: 185335808 18:03:10 INFO - PROCESS | 3773 | 18:03:13 INFO - PROCESS | 3773 | Cycle 1(1): loaded http://localhost:33334/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33334/tests/kraken/driver.html?testName=imaging-darkroom) 18:03:14 INFO - PROCESS | 3773 | RSS: Main: 223883264 18:03:14 INFO - PROCESS | 3773 | 18:03:17 INFO - PROCESS | 3773 | Cycle 1(1): loaded http://localhost:33334/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33334/tests/kraken/driver.html?testName=imaging-desaturate) 18:03:18 INFO - PROCESS | 3773 | RSS: Main: 223629312 18:03:18 INFO - PROCESS | 3773 | 18:03:21 INFO - PROCESS | 3773 | Cycle 1(1): loaded http://localhost:33334/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33334/tests/kraken/driver.html?testName=json-parse-financial) 18:03:22 INFO - PROCESS | 3773 | RSS: Main: 221995008 18:03:22 INFO - PROCESS | 3773 | 18:03:23 INFO - PROCESS | 3773 | Cycle 1(1): loaded http://localhost:33334/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33334/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:03:24 INFO - PROCESS | 3773 | RSS: Main: 184852480 18:03:24 INFO - PROCESS | 3773 | 18:03:26 INFO - PROCESS | 3773 | Cycle 1(1): loaded http://localhost:33334/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33334/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:03:26 INFO - PROCESS | 3773 | RSS: Main: 192217088 18:03:26 INFO - PROCESS | 3773 | 18:03:29 INFO - PROCESS | 3773 | Cycle 1(1): loaded http://localhost:33334/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33334/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:03:29 INFO - PROCESS | 3773 | RSS: Main: 200101888 18:03:29 INFO - PROCESS | 3773 | 18:03:32 INFO - PROCESS | 3773 | Cycle 1(1): loaded http://localhost:33334/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:03:33 INFO - PROCESS | 3773 | RSS: Main: 209035264 18:03:33 INFO - PROCESS | 3773 | 18:03:36 INFO - PROCESS | 3773 | Cycle 1(1): loaded http://localhost:33334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:03:36 INFO - PROCESS | 3773 | RSS: Main: 206012416 18:03:36 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | Cycle 1(1): loaded http://localhost:33334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33334/tests/kraken/driver.html?testName=ai-astar) 18:03:38 INFO - PROCESS | 3773 | RSS: Main: 258367488 18:03:38 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | __start_tp_report 18:03:38 INFO - PROCESS | 3773 | _x_x_mozilla_page_load 18:03:38 INFO - PROCESS | 3773 | _x_x_mozilla_page_load_details 18:03:38 INFO - PROCESS | 3773 | |i|pagename|runs| 18:03:38 INFO - PROCESS | 3773 | |0;ai-astar;105;118;114;115;115;113;114;116;115;114 18:03:38 INFO - PROCESS | 3773 | |1;audio-beat-detection;154;125;125;172;124;125;127;125;164;128 18:03:38 INFO - PROCESS | 3773 | |2;audio-dft;162;162;162;161;163;162;162;162;158;160 18:03:38 INFO - PROCESS | 3773 | |3;audio-fft;75;77;77;118;78;77;77;76;92;78 18:03:38 INFO - PROCESS | 3773 | |4;audio-oscillator;85;85;107;86;85;85;111;85;85;112 18:03:38 INFO - PROCESS | 3773 | |5;imaging-gaussian-blur;128;127;127;127;127;127;127;127;128;129 18:03:38 INFO - PROCESS | 3773 | |6;imaging-darkroom;148;147;147;147;147;146;146;147;146;147 18:03:38 INFO - PROCESS | 3773 | |7;imaging-desaturate;96;96;96;95;96;95;95;95;95;96 18:03:38 INFO - PROCESS | 3773 | |8;json-parse-financial;65;65;65;66;66;67;65;64;65;65 18:03:38 INFO - PROCESS | 3773 | |9;json-stringify-tinderbox;66;66;65;65;66;67;66;65;65;66 18:03:38 INFO - PROCESS | 3773 | |10;stanford-crypto-aes;85;84;87;84;90;85;85;94;83;85 18:03:38 INFO - PROCESS | 3773 | |11;stanford-crypto-ccm;136;135;146;140;138;137;135;146;172;156 18:03:38 INFO - PROCESS | 3773 | |12;stanford-crypto-pbkdf2;177;177;173;173;180;174;177;177;173;176 18:03:38 INFO - PROCESS | 3773 | |13;stanford-crypto-sha256-iterative;67;68;67;73;67;67;68;67;69;66 18:03:38 INFO - PROCESS | 3773 | __end_tp_report 18:03:38 INFO - PROCESS | 3773 | __start_cc_report 18:03:38 INFO - PROCESS | 3773 | _x_x_mozilla_cycle_collect,1985 18:03:38 INFO - PROCESS | 3773 | __end_cc_report 18:03:38 INFO - PROCESS | 3773 | __startTimestamp1481940218977__endTimestamp 18:03:38 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | ------- Summary: start ------- 18:03:38 INFO - PROCESS | 3773 | Number of tests: 14 18:03:38 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | [#0] ai-astar Cycles:10 Average:113.90 Median:115.00 stddev:3.41 (3.0%) stddev-sans-first:1.45 18:03:38 INFO - PROCESS | 3773 | Values: 105.0 118.0 114.0 115.0 115.0 113.0 114.0 116.0 115.0 114.0 18:03:38 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:127.50 stddev:18.76 (14.7%) stddev-sans-first:18.85 18:03:38 INFO - PROCESS | 3773 | Values: 154.0 125.0 125.0 172.0 124.0 125.0 127.0 125.0 164.0 128.0 18:03:38 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.43 (0.9%) stddev-sans-first:1.50 18:03:38 INFO - PROCESS | 3773 | Values: 162.0 162.0 162.0 161.0 163.0 162.0 162.0 162.0 158.0 160.0 18:03:38 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | [#3] audio-fft Cycles:10 Average:82.50 Median:77.00 stddev:13.38 (17.4%) stddev-sans-first:13.91 18:03:38 INFO - PROCESS | 3773 | Values: 75.0 77.0 77.0 118.0 78.0 77.0 77.0 76.0 92.0 78.0 18:03:38 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:85.00 stddev:12.08 (14.2%) stddev-sans-first:12.49 18:03:38 INFO - PROCESS | 3773 | Values: 85.0 85.0 107.0 86.0 85.0 85.0 111.0 85.0 85.0 112.0 18:03:38 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | [#5] imaging-gaussian-blur Cycles:10 Average:127.40 Median:127.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 18:03:38 INFO - PROCESS | 3773 | Values: 128.0 127.0 127.0 127.0 127.0 127.0 127.0 127.0 128.0 129.0 18:03:38 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 18:03:38 INFO - PROCESS | 3773 | Values: 148.0 147.0 147.0 147.0 147.0 146.0 146.0 147.0 146.0 147.0 18:03:38 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:03:38 INFO - PROCESS | 3773 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 18:03:38 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 18:03:38 INFO - PROCESS | 3773 | Values: 65.0 65.0 65.0 66.0 66.0 67.0 65.0 64.0 65.0 65.0 18:03:38 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 18:03:38 INFO - PROCESS | 3773 | Values: 66.0 66.0 65.0 65.0 66.0 67.0 66.0 65.0 65.0 66.0 18:03:38 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.00 stddev:3.36 (4.0%) stddev-sans-first:3.54 18:03:38 INFO - PROCESS | 3773 | Values: 85.0 84.0 87.0 84.0 90.0 85.0 85.0 94.0 83.0 85.0 18:03:38 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:143.00 stddev:11.85 (8.3%) stddev-sans-first:12.20 18:03:38 INFO - PROCESS | 3773 | Values: 136.0 135.0 146.0 140.0 138.0 137.0 135.0 146.0 172.0 156.0 18:03:38 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.70 Median:177.00 stddev:2.36 (1.3%) stddev-sans-first:2.46 18:03:38 INFO - PROCESS | 3773 | Values: 177.0 177.0 173.0 173.0 180.0 174.0 177.0 177.0 173.0 176.0 18:03:38 INFO - PROCESS | 3773 | 18:03:38 INFO - PROCESS | 3773 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:1.97 (2.9%) stddev-sans-first:2.06 18:03:38 INFO - PROCESS | 3773 | Values: 67.0 68.0 67.0 73.0 67.0 67.0 68.0 67.0 69.0 66.0 18:03:38 INFO - PROCESS | 3773 | -------- Summary: end -------- 18:03:38 INFO - PROCESS | 3773 | 18:03:40 INFO - TEST-INFO | 3773: exit 0 18:03:40 INFO - TEST-OK | kraken | took 64509ms 18:03:40 INFO - SUITE-END | took 1189s 18:03:40 INFO - Completed test suite (00:19:50) 18:03:40 INFO - javascript benchmark 18:03:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2585.3665851866294, 2606.752358525942, 2607.0223666125207, 2617.4372509910368, 2623.0163688616767, 4561.6806823522365, 4623.075384923012, 4624.606908412789, 4639.211334073208, 4643.605293550048, 4621.74580398078, 4626.352310676508, 4645.535446455353, 4668.159731248383, 4715.056988602285, 4212.915741685165, 4244.405783190356, 4274.465691788527, 4317.611414972652, 4400.053988392495, 3955.7982542890227, 4274.551172126929, 4329.54539773324, 4351.108022855323, 4410.272305069676, 4201.411802347643, 4225.661947044229, 4241.024564350186, 4315.266404711207, 4330.826766929319, 4286.61420472159, 4292.849750258726, 4302.096559722462, 4305.84929527465, 4308.418363520916, 4248.681348898814, 4277.893052673677, 4284.614384705392, 4288.892777680552, 4290.099079193342, 4674.205385084544, 4676.532346765331, 4679.649026323005, 4727.172744769651, 4743.644226682978, 4994.475580064077, 4995.200767877122, 4995.850124496271, 4997.350344455198, 5048.671836330626, 4801.73590452525, 4840.273958906157, 5018.4981501849525, 5027.698338099689, 5065.316182315377, 4534.115847409724, 4572.01701634147, 4585.335126406686, 4585.679002469862, 4586.495485496593, 4991.301217829507, 4992.101421744048, 4994.1509943309, 4998.02538504988, 5001.699898006132, 4833.178359678863, 4844.346013288232, 4892.68197567157, 4921.089598424303, 4990.600751939836, 5000.374953130859, 5003.524665156804, 5005.249212618136, 5015.0, 5056.797728090909, 4816.133096042676, 4972.055309491185, 4975.353204083446, 4983.501649834988, 5017.673851199734, 4835.032993401333, 4841.612670986313, 4854.029194161182, 4879.316895634614, 4924.015196960622, 4083.4079058536345, 4088.8773336799945, 4123.9381409278885, 4125.938110928339, 4126.566710495415, 3599.226166374242, 3616.72874534411, 3620.7646502977223, 3636.2727454509204, 3639.654232847928, 4220.430241917364, 4253.659707223414, 4253.8723838284905, 4319.0, 4322.848700295474, 4953.479884612064, 5002.174641184237, 5020.874478138003, 5029.874253143701, 5055.8988820223385, 4366.410534577855, 4366.43236379275, 4374.846880359172, 4380.540043295408, 4421.867343979686, 4283.443152390169, 4313.137372525507, 4422.0, 4432.623227025674, 4469.128519938581, 4691.272852707836, 4715.127701375257, 4731.101090792738, 4754.263089221176, 4802.927956080732, 4998.4251811042195, 5012.423571289349, 5012.724300163526, 5025.673331233605, 5054.747262636927, 4608.861734147981, 4732.503087175797, 4748.715077095385, 4751.216049351819, 4786.353842231254, 4818.68678535894, 4841.564259216547, 4869.415670119608, 4886.486918873609, 4952.900941981212, 4981.327520784647, 4981.825636102719, 4982.8754281143265, 4987.576056035277, 5040.722760248075, 4787.40157480315, 4841.419029716457, 4844.224924012282, 4853.053654537332, 4898.044881248123, 4696.953030469788, 4720.291956206596, 4809.134355815987, 4816.940273140044, 4836.250381190921, 4797.280407938698, 4803.567678908915, 4805.735684537384, 4851.078295123915, 4853.684510506806, 4820.807167713252, 4852.17513022794, 4871.3667223260745, 4876.536729010738, 4919.606431485544, 4574.176648203355, 4609.147307748078, 4611.93082103762, 4661.533846615312, 4767.73777442244], "value": 4554.733490045614, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.4525602860967, 529.745722053414, 538.5987439357679, 544.1049473615899, 549.5081901697978, 26924.461510769797, 30191.396172076573, 36912.63087369129, 38602.8069859651, 38704.22591548167, 38906.0, 39134.80432597833, 39157.21685566287, 39206.21587568247, 39416.0, 7510.474266801312, 7682.1549629540705, 7684.577348245844, 7694.0, 7707.0, 7375.963120184391, 7562.395008399342, 9420.481873496989, 9628.22974162069, 9663.468509231989, 9864.457454839981, 9914.603415863357, 9924.90075099247, 9941.105300522951, 9969.950150249239, 9790.90209097907, 9853.162481189107, 9854.359466634718, 9858.260630452745, 9876.506174691236, 9745.415275083447, 9801.90198098017, 9802.264830137698, 9807.26445516589, 9832.262580306506, 37217.81391093027, 37235.441468378, 37507.62492375096, 37515.0, 37610.81194594037, 2863.656361236644, 3136.419762343951, 3570.732195085353, 3580.6419358063986, 3645.143391303042, 27850.5822412664, 27918.581221281696, 28056.755459563185, 28061.719382806114, 28363.716362836312, 3418.6068602110577, 3526.612072672004, 3601.405768048269, 3613.223157021253, 3648.2703459308245, 239437.22532485906, 239482.99999999825, 241322.99999999825, 241524.0, 241614.0, 49920.750396247786, 50136.0, 50250.497495025316, 50327.748361258695, 50372.748136259084, 52539.0, 52660.0, 52798.0, 52805.73597132067, 52860.735696322045, 13813.51652692151, 14079.0, 14101.858981410054, 14104.858951410355, 14128.293585320693, 10012.148967337713, 10398.376097434179, 10558.472076396149, 10560.630377936735, 10630.840537391945, 13270.27013514266, 13365.532206372925, 14430.340510841177, 14776.926115369355, 14778.26108694561, 6223.906641400383, 6239.75040998355, 6240.843978900564, 6468.450181734511, 6474.902876456857, 773.7988123088038, 871.8212766382876, 930.7440453875103, 962.1244667352676, 1002.6941782756329, 24649.383765406008, 26242.606360904603, 26274.343141421617, 26305.0, 27219.183424497296, 891.6477991193442, 895.4985208283382, 917.559571405729, 924.2098006204733, 983.5229913491951, 12314.384280785926, 12804.0, 12825.0, 12975.0, 12977.545785897448, 336855.0, 340502.0, 341711.0, 342392.0, 342599.0, 36088.45867311992, 36839.07902302464, 39956.40065399021, 40322.79838600788, 40820.38769418461, 1138.9886101138882, 1159.7738441003924, 1177.3936422742295, 1186.6499382681957, 1187.2876274235389, 23824.285271441884, 24286.878565607058, 25386.492270154864, 25434.364140896625, 25487.87256063708, 35724.28551429009, 36184.45723314205, 36184.63815361813, 36195.276094477435, 36228.81885590555, 300523.0, 300840.0, 301657.0, 301707.0, 303017.0, 20020.499487512345, 22379.552408951404, 22406.88796556007, 22414.663780042985, 22435.551288973802, 29297.41405171927, 30516.542251866686, 31142.844285778425, 34542.13644658904, 35434.29131417305, 29991.250218744706, 30174.547381788852, 30381.848090759406, 30480.542791857697, 31402.371952561276, 29883.55174672338, 30029.3994120112, 30062.849685751433, 30250.84874575613, 31269.061928142193, 30304.696953030187, 30515.0, 30524.236894077825, 30527.54208686827, 30553.388932221675, 26018.052369745717, 27817.0, 28231.71768282291, 28520.429591408472, 28658.283542911595, 21661.783382165977, 22111.34453781523, 22128.778712212672, 22218.111275548796, 22285.442863928532], "value": 16513.065839983425, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.2634228606495, 363.0669180206868, 367.56076488596125, 368.2285611643607, 379.88413533872176, 12327.506899724012, 13074.215547067171, 13890.749832515072, 16193.271302791372, 16194.75707864383, 13864.584062478116, 14561.053531520443, 14565.854341456583, 15115.773263401057, 15708.450204242854, 4558.065596552707, 4702.952970470303, 4703.318018887259, 4710.199266124767, 4716.363290955728, 3475.982620086896, 3672.247189326195, 5604.859878503029, 5826.475617194452, 5877.85305367365, 5908.88182236355, 5909.084091965752, 5910.67491287979, 5910.940890591103, 5927.644341339534, 4929.408470983487, 5170.482951704818, 5202.817901373433, 5261.394939581921, 5266.92099618506, 4897.1674815281485, 5140.074786538422, 5146.147386940698, 5147.6911385317, 5149.176131818928, 12368.1960672556, 15394.384224631001, 19350.612987740307, 20012.399628011182, 20028.69956950647, 1838.5587459009876, 1859.944201673952, 1934.7424174286687, 2062.0, 2346.0967527502034, 8860.955695221546, 9335.159835614828, 10285.971402859654, 11920.523179072827, 13384.263865487394, 1567.3652170870816, 1637.9508614741576, 1704.5908981844393, 1711.9743203851951, 1713.4088739384893, 59492.40507594912, 63580.36419635837, 67788.0, 67843.0, 68096.0, 9447.76380590477, 9498.667546635834, 9743.561539730728, 9783.46190959504, 9799.412035277906, 13437.395317210749, 13447.731045379232, 13456.798148027787, 13464.259465729283, 13471.259080750457, 6619.966900165565, 6877.799104286681, 6960.816661167613, 7052.964735176394, 7059.329363710542, 6473.255575608865, 6512.5766825156215, 6651.201855777338, 6657.800265992028, 6689.866202675919, 4167.437395951508, 4186.28833098374, 4191.7484950903045, 4256.170046840836, 4312.202242585132, 1748.4492384898717, 1786.6694661487406, 1793.399211264241, 1820.2841588629612, 1852.2961274715522, 804.4610111225493, 842.5239739547136, 856.4647095565272, 874.5933141089424, 885.1502557544701, 15923.283452244677, 16357.509274721777, 16641.084740339396, 16645.25096370666, 17144.657106857794, 786.2294950948103, 796.2674339607574, 848.2704873808519, 862.2239984014312, 872.0, 7880.290773830383, 9088.909110908939, 9437.858432123523, 9540.379875308083, 9649.807003859883, 223263.0, 228022.0, 228775.0, 345112.0, 349781.0, 80300.19699802928, 80746.0, 82516.58741706373, 82646.58676706578, 83387.0, 883.8409086364516, 910.6431417188473, 944.8724422203052, 946.31392240625, 947.5830634520789, 15088.471903483325, 15215.92392038077, 15817.446389376317, 15865.762013569574, 15938.681226375176, 35718.0, 35836.64163358333, 36403.817980909924, 36481.63518364782, 37162.0, 45765.31352029656, 49465.50534494609, 49529.752351239455, 49608.255876161165, 49665.50334496609, 6996.300369963166, 7412.555246685216, 7483.0, 7620.885686714593, 7671.0, 10726.678199654023, 11541.307521548733, 11625.418729063682, 11713.41432928333, 11922.105842061706, 9721.805563888824, 10092.949535252277, 10168.127347522757, 10347.896521034694, 10556.313839600401, 9347.766305842408, 9713.56288966984, 10271.229657775846, 10343.0, 10365.792684146125, 5995.310539288038, 10116.140128089195, 10257.17942564608, 10634.787304254027, 11010.119190464904, 6672.499562532732, 7015.0, 7236.710531578678, 7401.555906645618, 7449.14334851499, 5146.588272938231, 6443.09796628463, 8689.391742577958, 9722.513874306398, 10797.136229101496], "value": 7837.078000296292, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1239.7830379683553, 1325.7547353739558, 1340.323136815908, 1429.2710717534055, 1687.5443630219834, 6520.44576211022, 7221.747238846635, 7435.739749108776, 7445.404367650589, 7596.0, 7465.253474652545, 7534.982777325059, 7552.773416797491, 7553.244675532444, 7553.622318884048, 1852.8425083867887, 1916.6358391905562, 2120.0565748242, 2165.8592191507582, 2173.717416735822, 2143.5927173837, 2211.1045026764186, 2211.292386436341, 2216.0581752755097, 2216.1578600132007, 2101.485136141647, 2115.830733541313, 2117.6823476478576, 2118.9576208475823, 2121.596896589651, 2130.5206328576023, 2147.3450597567735, 2151.279321427308, 2151.7740637233023, 2156.1806513524916, 2094.1518684932626, 2106.052276475577, 2118.226847200776, 2122.193566444741, 2125.3942626351572, 7267.745628903016, 7320.341169294736, 7352.22801605829, 7408.111026676779, 7521.887171692429, 4403.4495688039, 4554.977225113853, 4568.862934111982, 4571.497135315112, 4572.497025327211, 2804.7756179505795, 2942.0, 3012.8493575321145, 3016.155476466593, 3024.74289685377, 900.4777229207044, 936.0919907689598, 952.8523078922778, 977.7702239973601, 979.2851218610383, 10089.798204035878, 10123.797524049478, 10126.493675316206, 10141.89858101417, 10153.238507111997, 3861.942070868939, 4059.0867054913, 4102.651274641629, 4121.814518346621, 4228.767417792051, 8449.070602233749, 8469.280111190617, 8563.914360856435, 8575.013873404514, 8579.356548258906, 4505.144022635689, 4574.108048930493, 4593.63250939924, 4601.930971035437, 4612.169809434267, 3477.530533378012, 3555.768875023115, 4129.2773764591075, 4139.586041395896, 4140.0891803803115, 3390.660933906639, 3436.60479044913, 3547.8935631931085, 3554.4668299754726, 3572.303400836864, 1141.3266172957995, 1163.1102206811795, 1163.947622356996, 1182.8107502799683, 1188.8811118888043, 645.4223469994329, 749.318120510333, 761.6153842309598, 784.8351846112266, 789.057076793238, 4522.728636281834, 4637.25803871379, 4677.929831052537, 4690.624750019991, 4726.527347265314, 367.6084969507466, 385.50270151504805, 390.5723233059795, 392.36828705783665, 396.4806104003764, 3096.303331750383, 3144.5283207519055, 3176.444122278592, 3198.7281081108367, 3312.7846689965077, 8683.131686831393, 8878.689245876492, 8935.687250946186, 8958.462492250486, 9101.590428430736, 8883.555822208864, 8895.911040889638, 8903.06517815633, 8908.821823563492, 8909.688160914337, 6804.727810887608, 6866.210385805696, 6909.965450172717, 6932.688029038705, 6942.7222911084, 4487.7980490878645, 4587.6788624795945, 4600.815967361268, 4635.142498637762, 4741.83403580873, 8164.673413063411, 8197.918020819954, 8205.261526462647, 8264.793380165544, 8280.171982801672, 8187.26314631686, 8300.086990430927, 8319.376046796393, 8368.41421100517, 8372.204640559137, 5711.7429715662065, 5891.0, 6360.045993101072, 6444.645544495098, 6448.387403196689, 6713.798586042427, 6870.965645171942, 6906.930930690629, 7036.683349249193, 7079.82300442493, 6356.618602883842, 6368.172137622079, 6430.742770289323, 6606.042123892104, 6628.337166283333, 6228.813135605939, 6312.053192021233, 6364.554481186273, 6434.227892652912, 6486.578372405778, 5528.198411230269, 5605.0, 5605.747741351567, 5622.7750889963945, 5634.915476267941, 4021.537523184871, 4044.069863931371, 4080.591940805896, 4174.352975288835, 4175.478065241845, 4138.689598280202, 4155.771432571238, 4156.168766246702, 4290.206311832196, 4333.9349909750745], "value": 3831.4633522842923, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.1838349371685, 357.67094273268594, 361.5932076414034, 365.32415032190437, 365.7311875771309, 4613.677042607019, 4677.508861569533, 4682.578567928886, 4685.509295574797, 4701.694389864657, 4632.97683511582, 4648.093621743753, 4649.279361698934, 4654.674172807905, 4665.463471700756, 3327.9334413311717, 3536.929261414783, 3647.2340808430263, 3773.1135681203764, 3810.7141964352713, 3761.2477504499075, 3765.755225910307, 3774.603666615007, 3775.6790672792845, 3791.6777073948747, 3743.906402339936, 3749.662530372266, 3752.587215406317, 3753.9061523461996, 3784.1674831537016, 3578.2306804037257, 3578.964210357889, 3655.323765103438, 3766.152615661482, 3772.849086036555, 3362.7309815214726, 3363.9663603363897, 3365.468711736154, 3378.2567835076243, 3378.2939615494265, 4515.05183911379, 4520.033785303403, 4530.660200484944, 4534.88662783433, 4538.570350339633, 4226.936595951063, 4235.131797981407, 4246.490421149482, 4246.978765106154, 4259.680523960716, 4617.699849509771, 4821.517848215186, 4837.2260438329695, 4841.49164337743, 4849.733264670442, 3506.4740288956605, 3513.8243087845503, 3515.0, 3524.0, 3532.1875968527384, 4840.298156767284, 4939.98730260303, 5061.848144555669, 5078.873028174326, 5089.6691715038405, 3451.2234747181683, 3560.7151427885706, 3564.3049605326714, 3570.6072332043454, 3587.4260118380935, 3605.8737944171826, 3607.6753092221825, 3619.873304434332, 3636.8545258189906, 3638.381475149231, 4099.569545197771, 4109.075458021981, 4109.773962432095, 4114.300568903293, 4121.690873184523, 4717.363155973968, 4804.6876952997945, 4840.0, 4849.539293767087, 4852.587530059914, 1207.3178654060428, 1212.830203771455, 1216.6897441152626, 1224.3143839449936, 1226.478746532738, 810.789194809342, 836.9163083691582, 837.5184269045324, 850.7362717557577, 855.6064210463132, 4261.531231564525, 4265.91468170641, 4280.892977675583, 4280.935785963213, 4284.271673815459, 4884.242942343943, 4886.7067975920845, 4897.216445368724, 4905.2151655734915, 4906.822362633014, 4226.640735537452, 4230.788460576959, 4231.513375961804, 4237.4321501044815, 4257.361395790656, 2406.566817972747, 2562.4490734492174, 2565.897364105415, 2576.974230257711, 2589.728078551763, 4561.058117514185, 4567.0, 4585.9541404585525, 4589.691937797712, 4589.770511474413, 4931.632816248221, 4940.1601727706375, 4948.554630083309, 4958.281049247839, 4963.436517497049, 4301.806418711103, 4493.326001099861, 4564.315352697122, 4599.2871104978785, 4607.76961151941, 4798.3042458843975, 4820.084184005028, 4837.685550439211, 4844.297576851407, 4847.927281090857, 4768.8092476301945, 4782.210935195653, 4786.976065119652, 4794.59245964083, 4799.1841386965, 4401.339799030043, 4538.432695913011, 4567.81728730847, 4573.81704731807, 4584.083183363407, 3473.7568370213844, 3498.930021399507, 3561.8041007743786, 3572.678458938708, 3576.481410195559, 4938.0, 4951.752412379438, 4959.504049595012, 4965.851024469272, 4971.453140154653, 4786.808527658994, 4792.7363994980615, 4800.639952003544, 4828.903421931472, 4852.369192005017, 4544.7045942013665, 4749.7625118743235, 4779.450363208137, 4802.639802014793, 4820.25286080658, 4752.310914917249, 4757.857264282077, 4760.880977975578, 4766.475687674422, 4770.737609431515, 4860.756962151949, 4861.319415281934, 4862.270659400977, 4865.7323847188745, 4868.61051115917, 4526.479454862733, 4675.345451636842, 4681.625469962327, 4722.150012997693, 4723.409573803275], "value": 3673.0075904622768, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.8176428835641, 641.2433328672167, 675.1391975231579, 678.2742465561847, 716.4912911832598, 13210.40553175107, 14438.20589867557, 14455.927720361384, 14459.710805783878, 14460.710785784291, 12953.28756918369, 13001.544945926895, 13047.934760326209, 13058.869411305885, 13090.476380944774, 616.8581226317949, 629.0469938043844, 739.9482036257464, 748.5172064018705, 763.4541302968377, 752.2966026764992, 776.0842206196714, 776.2819392062348, 776.6000509737489, 776.7397921696239, 820.8604537228686, 822.0, 822.383212590557, 823.0945959444593, 823.3948048184609, 645.4481418387259, 661.0976017735804, 792.3502727763237, 812.2324403438753, 812.995935020327, 597.3190562758459, 605.8212827215938, 605.9030555111161, 606.423897297569, 606.548121649374, 12760.6809829755, 12762.042846786528, 12773.872261277362, 12794.680132996657, 12800.61598152057, 12846.400431408936, 12898.80651790224, 12931.935340323238, 12969.87030129696, 13098.0, 11429.02853257474, 11491.59779407725, 11548.133889958286, 11810.409479526075, 11844.526218951232, 4025.1144748155357, 4026.838926442939, 4060.309747342959, 4220.07158425146, 4233.576642335742, 69332.0, 69706.0, 70120.64939675269, 70324.64837675779, 72712.63643681801, 10069.848952265722, 10181.847272290921, 10349.534270957825, 10408.583656653649, 10764.085052770446, 19671.606567868563, 20030.098645560985, 20058.39824805258, 20067.197312107353, 20283.59432811365, 6524.902126468011, 6557.442617377481, 6634.270230274666, 6683.131192944983, 6739.764108256188, 3529.6293889141784, 3611.8735844245853, 3616.403293456603, 3649.1606930406156, 3660.3960346543054, 2781.7079206683006, 2835.2911772056987, 2843.1754791110347, 2851.230167854668, 2851.9429611408073, 475.8358366363599, 484.52758560404027, 493.0902484915325, 497.5571741150379, 497.6566169343214, 490.5217413022275, 510.2295533743999, 536.7906516458585, 565.1861319699619, 573.5698226330252, 7220.74727384539, 7506.699732010768, 7720.459567830198, 7873.803154921058, 8050.677972881136, 478.5716783478837, 531.6544246239897, 556.7244214113958, 562.8620987858001, 575.3297408519029, 3786.981065094657, 3823.235352929425, 3944.4872166618156, 3953.5651078381356, 4032.7580345179385, 52101.0, 52162.73918630383, 54961.725191374586, 65517.672411637635, 65860.67069664621, 58324.12513812296, 58457.41542584605, 59750.40249597535, 59843.700781496686, 63810.36189638137, 52497.2125418119, 52533.737331313096, 52616.0, 52953.94092118136, 52976.47023529715, 7020.719171233093, 7731.6520756567215, 7757.65090570937, 7894.447388682966, 7895.960520197592, 37434.62565374311, 37697.62302377051, 37773.0, 38027.80986095052, 39358.40962385509, 44169.0, 48952.75523622359, 50054.74972625114, 50250.0, 52492.47507524876, 9424.481653508848, 9717.12545870875, 9957.551910164206, 10010.499475026074, 10105.0, 10545.420001899662, 10688.038076573146, 10702.83945740799, 10756.193285503463, 11107.888921110685, 9807.460589667637, 10121.59513619447, 10212.438315892698, 10475.685729428129, 10881.0, 9619.903800961902, 9633.662821801203, 9698.321117521988, 10061.748456288651, 10340.741481463023, 9522.0, 9545.52272386364, 9746.26902982265, 9766.658166964122, 9845.409275443497, 7995.560244186626, 8703.347248956481, 8768.167024132697, 8777.473351598925, 8872.689455869013, 7967.362610991223, 7996.60016999136, 8281.0, 8394.160583941557, 8591.398602097794], "value": 6076.700740518475, "unit": "score"}], "name": "dromaeo_css", "value": 6077.968306115905, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 114.0, 115.0, 115.0, 113.0, 114.0, 116.0, 115.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 125.0, 172.0, 124.0, 125.0, 127.0, 125.0, 164.0, 128.0], "value": 136.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 163.0, 162.0, 162.0, 162.0, 158.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 118.0, 78.0, 77.0, 77.0, 76.0, 92.0, 78.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 107.0, 86.0, 85.0, 85.0, 111.0, 85.0, 85.0, 112.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 128.0, 129.0], "value": 127.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 67.0, 65.0, 64.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 67.0, 66.0, 65.0, 65.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 87.0, 84.0, 90.0, 85.0, 85.0, 94.0, 83.0, 85.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 146.0, 140.0, 138.0, 137.0, 135.0, 146.0, 172.0, 156.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 173.0, 173.0, 180.0, 174.0, 177.0, 177.0, 173.0, 176.0], "value": 175.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 73.0, 67.0, 67.0, 68.0, 67.0, 69.0, 66.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1561.9, "alertThreshold": 2.0}]} 18:03:40 INFO - Return code: 0 18:03:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:03:40 INFO - # TBPL SUCCESS # 18:03:40 INFO - Running post-action listener: _resource_record_post_action 18:03:40 INFO - [mozharness: 2016-12-17 02:03:40.776656Z] Finished run-tests step (success) 18:03:40 INFO - Running post-run listener: _resource_record_post_run 18:03:40 INFO - Total resource usage - Wall time: 1207s; CPU: 13.0%; Read bytes: 7643136; Write bytes: 427552768; Read time: 2188; Write time: 649376 18:03:40 INFO - TinderboxPrint: CPU usage
13.2% 18:03:40 INFO - TinderboxPrint: I/O read bytes / time
7,643,136 / 2,188 18:03:40 INFO - TinderboxPrint: I/O write bytes / time
427,552,768 / 649,376 18:03:40 INFO - TinderboxPrint: CPU idle
8,366.4 (86.8%) 18:03:40 INFO - TinderboxPrint: CPU user
1,214.9 (12.6%) 18:03:40 INFO - TinderboxPrint: Swap in / out
0 / 0 18:03:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 24293376; Read time: 0; Write time: 43772 18:03:40 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 5607424; Write bytes: 358514688; Read time: 1772; Write time: 492596 18:03:41 INFO - Running post-run listener: _upload_blobber_files 18:03:41 INFO - Blob upload gear active. 18:03:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:03:41 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 18:03:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:03:41 INFO - (blobuploader) - INFO - Open directory for files ... 18:03:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:03:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:03:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:03:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:03:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:03:46 INFO - (blobuploader) - INFO - Done attempting. 18:03:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:03:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:03:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:03:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:03:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:03:46 INFO - (blobuploader) - INFO - Done attempting. 18:03:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:03:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:03:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:03:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:03:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:03:47 INFO - (blobuploader) - INFO - Done attempting. 18:03:47 INFO - (blobuploader) - INFO - Iteration through files over. 18:03:47 INFO - Return code: 0 18:03:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:03:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:03:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dfd7989ed81d0c1e231cb1776cc767a87cfb0b5f946e240094c48e539d36bb5f0c30df67aeddd8b5f9e6c2655d81f6a69685e7fee57a7265b7170479e2194618", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe16c07076e7c9005dd7b931200550ec8b5d76430399d35145e169c60c8ba052e2064ea9d48a86f51c720da0c5502ca7859e23d8511ab6d080154457ba60a493", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/669956d45f419b6af89820d0617fada4bf6636c78849f259e1a009efa49c373814fd01b524980e678327be74456bf6598b2e9b49de24aa1a403ff620ad419b42"} 18:03:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:03:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:03:47 INFO - Contents: 18:03:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dfd7989ed81d0c1e231cb1776cc767a87cfb0b5f946e240094c48e539d36bb5f0c30df67aeddd8b5f9e6c2655d81f6a69685e7fee57a7265b7170479e2194618", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe16c07076e7c9005dd7b931200550ec8b5d76430399d35145e169c60c8ba052e2064ea9d48a86f51c720da0c5502ca7859e23d8511ab6d080154457ba60a493", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/669956d45f419b6af89820d0617fada4bf6636c78849f259e1a009efa49c373814fd01b524980e678327be74456bf6598b2e9b49de24aa1a403ff620ad419b42"} 18:03:47 INFO - Running post-run listener: copy_logs_to_upload_dir 18:03:47 INFO - Copying logs to upload dir... 18:03:47 INFO - mkdir: /builds/slave/test/build/upload/logs 18:03:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.072544 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-12-16 18:03:47.862459) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 18:03:47.866273) ========= 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=af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dfd7989ed81d0c1e231cb1776cc767a87cfb0b5f946e240094c48e539d36bb5f0c30df67aeddd8b5f9e6c2655d81f6a69685e7fee57a7265b7170479e2194618", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe16c07076e7c9005dd7b931200550ec8b5d76430399d35145e169c60c8ba052e2064ea9d48a86f51c720da0c5502ca7859e23d8511ab6d080154457ba60a493", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/669956d45f419b6af89820d0617fada4bf6636c78849f259e1a009efa49c373814fd01b524980e678327be74456bf6598b2e9b49de24aa1a403ff620ad419b42"} build_url:https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011257 build_url: 'https://queue.taskcluster.net/v1/task/Xw23DYQpTH-WkLSXmglmQg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dfd7989ed81d0c1e231cb1776cc767a87cfb0b5f946e240094c48e539d36bb5f0c30df67aeddd8b5f9e6c2655d81f6a69685e7fee57a7265b7170479e2194618", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe16c07076e7c9005dd7b931200550ec8b5d76430399d35145e169c60c8ba052e2064ea9d48a86f51c720da0c5502ca7859e23d8511ab6d080154457ba60a493", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/669956d45f419b6af89820d0617fada4bf6636c78849f259e1a009efa49c373814fd01b524980e678327be74456bf6598b2e9b49de24aa1a403ff620ad419b42"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 18:03:47.891148) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 18:03:47.891465) ========= 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=af724c981e2a0f424dbabf99000001e7-1481938970.382656-1424220903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004397 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 18:03:47.977736) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 18:03:47.978055) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 18:03:47.978350) ========= ========= Total master_lag: 0.23 =========