builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1483044901.46 results: success (0) buildid: 20161229120420 builduid: 97e60e6b055b461495ef6fb620840979 revision: 79ef936724454728beeeba41fb76a61d02c7c226 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 12:55:01.455764) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 12:55:01.456169) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 12:55:01.456436) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 12:55:01.475862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 12:55:01.476137) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-29 12:55:01-- 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% 46.2M=0s 2016-12-29 12:55:01 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134065 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 12:55:01.624499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 12:55:01.624816) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017792 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 12:55:01.674476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 12:55:01.674794) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 79ef936724454728beeeba41fb76a61d02c7c226 --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 79ef936724454728beeeba41fb76a61d02c7c226 --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=934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-29 12:55:01,982 truncating revision to first 12 chars 2016-12-29 12:55:01,982 Setting DEBUG logging. 2016-12-29 12:55:01,982 attempt 1/10 2016-12-29 12:55:01,982 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/79ef93672445?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-29 12:55:02,281 unpacking tar archive at: mozilla-central-79ef93672445/testing/mozharness/ program finished with exit code 0 elapsedTime=0.603029 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 12:55:02.290496) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 12:55:02.290773) ========= script_repo_revision: 79ef936724454728beeeba41fb76a61d02c7c226 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 12:55:02.291177) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 12:55:02.291439) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 12:55:02.301528) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-12-29 12:55:02.301791) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:55:02 INFO - MultiFileLogger online at 20161229 12:55:02 in /builds/slave/test 12:55:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 12:55:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:55:02 INFO - {'append_to_log': False, 12:55:02 INFO - 'base_work_dir': '/builds/slave/test', 12:55:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:55:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:55:02 INFO - 'branch': 'Firefox-Non-PGO', 12:55:02 INFO - 'buildbot_json_path': 'buildprops.json', 12:55:02 INFO - 'config_files': ('talos/linux_config.py',), 12:55:02 INFO - 'default_actions': ('clobber', 12:55:02 INFO - 'read-buildbot-config', 12:55:02 INFO - 'download-and-extract', 12:55:02 INFO - 'populate-webroot', 12:55:02 INFO - 'create-virtualenv', 12:55:02 INFO - 'install', 12:55:02 INFO - 'run-tests'), 12:55:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:55:02 INFO - 'download_minidump_stackwalk': True, 12:55:02 INFO - 'download_symbols': 'ondemand', 12:55:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:55:02 INFO - 'tooltool.py': '/tools/tooltool.py', 12:55:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:55:02 INFO - '/tools/misc-python/virtualenv.py')}, 12:55:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:55:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:55:02 INFO - 'installer_path': 'installer.exe', 12:55:02 INFO - 'log_level': 'info', 12:55:02 INFO - 'log_name': 'talos', 12:55:02 INFO - 'log_to_console': True, 12:55:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:55:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:55:02 INFO - 'opt_config_files': (), 12:55:02 INFO - 'pip_index': False, 12:55:02 INFO - 'sps_profile': False, 12:55:02 INFO - 'sps_profile_interval': 0, 12:55:02 INFO - 'suite': 'dromaeojs-e10s', 12:55:02 INFO - 'system_bits': '32', 12:55:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:55:02 INFO - 'title': 'talos-linux64-ix-057', 12:55:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:55:02 INFO - 'use_talos_json': True, 12:55:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:55:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:55:02 INFO - 'work_dir': 'build'} 12:55:02 INFO - [mozharness: 2016-12-29 20:55:02.699090Z] Running clobber step. 12:55:02 INFO - Running pre-action listener: _resource_record_pre_action 12:55:02 INFO - Running main action method: clobber 12:55:02 INFO - rmtree: /builds/slave/test/build 12:55:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:55:03 INFO - Running post-action listener: _resource_record_post_action 12:55:03 INFO - [mozharness: 2016-12-29 20:55:03.163957Z] Finished clobber step (success) 12:55:03 INFO - [mozharness: 2016-12-29 20:55:03.164057Z] Running read-buildbot-config step. 12:55:03 INFO - Running pre-action listener: _resource_record_pre_action 12:55:03 INFO - Running main action method: read_buildbot_config 12:55:03 INFO - Using buildbot properties: 12:55:03 INFO - { 12:55:03 INFO - "project": "", 12:55:03 INFO - "product": "firefox", 12:55:03 INFO - "script_repo_revision": "production", 12:55:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 12:55:03 INFO - "repository": "", 12:55:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 12:55:03 INFO - "buildid": "20161229120420", 12:55:03 INFO - "pgo_build": "False", 12:55:03 INFO - "basedir": "/builds/slave/test", 12:55:03 INFO - "buildnumber": 337, 12:55:03 INFO - "slavename": "talos-linux64-ix-057", 12:55:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:55:03 INFO - "platform": "ubuntu64_hw", 12:55:03 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 12:55:03 INFO - "branch": "mozilla-central", 12:55:03 INFO - "repo_path": "mozilla-central", 12:55:03 INFO - "revision": "79ef936724454728beeeba41fb76a61d02c7c226", 12:55:03 INFO - "stage_platform": "linux64", 12:55:03 INFO - "builduid": "97e60e6b055b461495ef6fb620840979", 12:55:03 INFO - "slavebuilddir": "test" 12:55:03 INFO - } 12:55:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 12:55:03 INFO - Running post-action listener: _resource_record_post_action 12:55:03 INFO - [mozharness: 2016-12-29 20:55:03.166560Z] Finished read-buildbot-config step (success) 12:55:03 INFO - [mozharness: 2016-12-29 20:55:03.166661Z] Running download-and-extract step. 12:55:03 INFO - Running pre-action listener: _resource_record_pre_action 12:55:03 INFO - Running main action method: download_and_extract 12:55:03 INFO - mkdir: /builds/slave/test/build/tests 12:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:03 INFO - trying https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:55:03 INFO - Downloading https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/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 12:55:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/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 12:55:03 INFO - Downloaded 1361 bytes. 12:55:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:55:03 INFO - Using the following test package requirements: 12:55:03 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:55:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:55:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:55:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:03 INFO - u'jsshell-linux-x86_64.zip'], 12:55:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:55:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:55:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:55:03 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:55:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:55:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:55:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:55:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:55:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:55:03 INFO - Fetch https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:55:04 INFO - Expected file size: 20245391 12:55:04 INFO - Obtained file size: 20245391 12:55:08 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 12:55:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:55:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:55:08 INFO - Fetch https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:55:09 INFO - Expected file size: 20245391 12:55:09 INFO - Obtained file size: 20245391 12:55:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 12:55:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:55:13 INFO - Fetch https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:55:14 INFO - Expected file size: 14409776 12:55:14 INFO - Obtained file size: 14409776 12:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:14 INFO - trying https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:55:14 INFO - Downloading https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/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 12:55:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/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 12:55:15 INFO - Downloaded 55913762 bytes. 12:55:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:55:15 INFO - mkdir: /builds/slave/test/properties 12:55:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:55:15 INFO - Writing to file /builds/slave/test/properties/build_url 12:55:15 INFO - Contents: 12:55:15 INFO - build_url:https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:55:16 INFO - Running post-action listener: _resource_record_post_action 12:55:16 INFO - Running post-action listener: set_extra_try_arguments 12:55:16 INFO - [mozharness: 2016-12-29 20:55:16.565707Z] Finished download-and-extract step (success) 12:55:16 INFO - [mozharness: 2016-12-29 20:55:16.565935Z] Running populate-webroot step. 12:55:16 INFO - Running pre-action listener: _resource_record_pre_action 12:55:16 INFO - Running main action method: populate_webroot 12:55:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:55:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:55:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:55:16 INFO - '--tppagecycles', 12:55:16 INFO - '7'], 12:55:16 INFO - 'tests': ['tsvgm']}}, 12:55:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:55:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:55:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:55:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:55:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:55:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:55:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:55:16 INFO - 'talos_options': ['--disable-e10s'], 12:55:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:55:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:55:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:55:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:55:16 INFO - 'talos_options': ['--disable-e10s'], 12:55:16 INFO - 'tests': ['damp', 'tps']}, 12:55:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:55:16 INFO - 'tests': ['damp', 'tps']}, 12:55:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:55:16 INFO - 'tests': ['dromaeo_dom']}, 12:55:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:55:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:55:16 INFO - 'tests': ['basic_compositor_video']}, 12:55:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:55:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:55:16 INFO - 'tests': ['a11yr', 12:55:16 INFO - 'ts_paint', 12:55:16 INFO - 'tpaint', 12:55:16 INFO - 'sessionrestore', 12:55:16 INFO - 'sessionrestore_no_auto_restore', 12:55:16 INFO - 'tabpaint']}, 12:55:16 INFO - 'other-e10s': {'tests': ['a11yr', 12:55:16 INFO - 'ts_paint', 12:55:16 INFO - 'tpaint', 12:55:16 INFO - 'sessionrestore', 12:55:16 INFO - 'sessionrestore_no_auto_restore', 12:55:16 INFO - 'tabpaint']}, 12:55:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:55:16 INFO - 'ts_paint', 12:55:16 INFO - 'tpaint', 12:55:16 INFO - 'sessionrestore', 12:55:16 INFO - 'sessionrestore_no_auto_restore', 12:55:16 INFO - 'tabpaint']}, 12:55:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:55:16 INFO - 'ts_paint', 12:55:16 INFO - 'tpaint', 12:55:16 INFO - 'sessionrestore', 12:55:16 INFO - 'sessionrestore_no_auto_restore', 12:55:16 INFO - 'tabpaint']}, 12:55:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:55:16 INFO - 'tests': ['a11yr', 12:55:16 INFO - 'ts_paint', 12:55:16 INFO - 'tpaint', 12:55:16 INFO - 'sessionrestore', 12:55:16 INFO - 'sessionrestore_no_auto_restore', 12:55:16 INFO - 'tabpaint']}, 12:55:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:55:16 INFO - 'tests': ['a11yr', 12:55:16 INFO - 'ts_paint', 12:55:16 INFO - 'tpaint', 12:55:16 INFO - 'sessionrestore', 12:55:16 INFO - 'sessionrestore_no_auto_restore', 12:55:16 INFO - 'tabpaint']}, 12:55:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:55:16 INFO - 'tests': ['tsvgx', 12:55:16 INFO - 'tsvgr_opacity', 12:55:16 INFO - 'tart', 12:55:16 INFO - 'tscrollx', 12:55:16 INFO - 'cart', 12:55:16 INFO - 'tsvg_static']}, 12:55:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:55:16 INFO - 'tsvgr_opacity', 12:55:16 INFO - 'tart', 12:55:16 INFO - 'tscrollx', 12:55:16 INFO - 'cart', 12:55:16 INFO - 'tsvg_static']}, 12:55:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:55:16 INFO - 'talos_options': ['--disable-e10s'], 12:55:16 INFO - 'tests': ['tp5o']}, 12:55:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:55:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:55:16 INFO - 'talos_options': ['--disable-e10s', 12:55:16 INFO - '--xperf_path', 12:55:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:55:16 INFO - 'tests': ['tp5n']}, 12:55:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:55:16 INFO - 'talos_options': ['--xperf_path', 12:55:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:55:16 INFO - 'tests': ['tp5n']}}, 12:55:16 INFO - 'talos.zip': {'path': '', 12:55:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:55:16 INFO - Running post-action listener: _resource_record_post_action 12:55:16 INFO - [mozharness: 2016-12-29 20:55:16.586905Z] Finished populate-webroot step (success) 12:55:16 INFO - [mozharness: 2016-12-29 20:55:16.586993Z] Running create-virtualenv step. 12:55:16 INFO - Running pre-action listener: _resource_record_pre_action 12:55:16 INFO - Running main action method: create_virtualenv 12:55:16 INFO - Creating virtualenv /builds/slave/test/build/venv 12:55:16 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 12:55:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:55:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:55:16 INFO - Using real prefix '/usr' 12:55:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:55:17 INFO - Installing distribute.............................................................................................................................................................................................done. 12:55:19 INFO - Installing pip.................done. 12:55:19 INFO - Return code: 0 12:55:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:55:19 INFO - Reading from file tmpfile_stdout 12:55:19 INFO - Output received: 12:55:19 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) 12:55:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:55: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')]} 12:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55: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')]} 12:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a820>, '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 0x207b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b9b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', '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 12:55: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', 'pip>=1.5'] in /builds/slave/test/build 12:55: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 pip>=1.5 12:55:19 INFO - Using env: {'DISPLAY': ':0', 12:55:19 INFO - 'HOME': '/home/cltbld', 12:55:19 INFO - 'LANG': 'en_US.UTF-8', 12:55:19 INFO - 'LANGUAGE': 'en_US:en', 12:55:19 INFO - 'LOGNAME': 'cltbld', 12:55:19 INFO - 'MAIL': '/var/mail/cltbld', 12:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:19 INFO - 'MOZ_NO_REMOTE': '1', 12:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:19 INFO - 'NO_EM_RESTART': '1', 12:55:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:19 INFO - 'PWD': '/builds/slave/test', 12:55:19 INFO - 'SHELL': '/bin/bash', 12:55:19 INFO - 'SHLVL': '1', 12:55:19 INFO - 'TERM': 'linux', 12:55:19 INFO - 'TMOUT': '86400', 12:55:19 INFO - 'USER': 'cltbld', 12:55:19 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', 12:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:19 INFO - '_': '/tools/buildbot/bin/python'} 12:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:19 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 12:55:19 INFO - Cleaning up... 12:55:19 INFO - Return code: 0 12:55:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:55: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')]} 12:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55: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')]} 12:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55: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', '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 0x1d0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a820>, '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 0x207b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b9b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', '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 12:55: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:55: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 psutil>=3.1.1 12:55:19 INFO - Using env: {'DISPLAY': ':0', 12:55:19 INFO - 'HOME': '/home/cltbld', 12:55:19 INFO - 'LANG': 'en_US.UTF-8', 12:55:19 INFO - 'LANGUAGE': 'en_US:en', 12:55:19 INFO - 'LOGNAME': 'cltbld', 12:55:19 INFO - 'MAIL': '/var/mail/cltbld', 12:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:19 INFO - 'MOZ_NO_REMOTE': '1', 12:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:19 INFO - 'NO_EM_RESTART': '1', 12:55:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:19 INFO - 'PWD': '/builds/slave/test', 12:55:19 INFO - 'SHELL': '/bin/bash', 12:55:19 INFO - 'SHLVL': '1', 12:55:19 INFO - 'TERM': 'linux', 12:55:19 INFO - 'TMOUT': '86400', 12:55:19 INFO - 'USER': 'cltbld', 12:55:19 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', 12:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:19 INFO - '_': '/tools/buildbot/bin/python'} 12:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:19 INFO - Downloading/unpacking psutil>=3.1.1 12:55: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 12:55: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 12:55: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 12:55: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 12:55: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 12:55: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 12:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:55:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:55:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:55:22 INFO - Installing collected packages: psutil 12:55:22 INFO - Running setup.py install for psutil 12:55:22 INFO - building 'psutil._psutil_linux' extension 12:55:22 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 12:55:22 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 12:55:22 INFO - building 'psutil._psutil_posix' extension 12:55:22 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 12:55:22 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 12:55:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:55:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:55:22 INFO - Successfully installed psutil 12:55:22 INFO - Cleaning up... 12:55:22 INFO - Return code: 0 12:55:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:55: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')]} 12:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55: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')]} 12:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a820>, '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 0x207b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b9b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', '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 12:55: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:55: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 mozsystemmonitor==0.3 12:55:22 INFO - Using env: {'DISPLAY': ':0', 12:55:22 INFO - 'HOME': '/home/cltbld', 12:55:22 INFO - 'LANG': 'en_US.UTF-8', 12:55:22 INFO - 'LANGUAGE': 'en_US:en', 12:55:22 INFO - 'LOGNAME': 'cltbld', 12:55:22 INFO - 'MAIL': '/var/mail/cltbld', 12:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:22 INFO - 'MOZ_NO_REMOTE': '1', 12:55:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:22 INFO - 'NO_EM_RESTART': '1', 12:55:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:22 INFO - 'PWD': '/builds/slave/test', 12:55:22 INFO - 'SHELL': '/bin/bash', 12:55:22 INFO - 'SHLVL': '1', 12:55:22 INFO - 'TERM': 'linux', 12:55:22 INFO - 'TMOUT': '86400', 12:55:22 INFO - 'USER': 'cltbld', 12:55:22 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', 12:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:22 INFO - '_': '/tools/buildbot/bin/python'} 12:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:55: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 12:55: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 12:55: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 12:55: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 12:55: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 12:55: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 12:55:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:55:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:55:24 INFO - Installing collected packages: mozsystemmonitor 12:55:24 INFO - Running setup.py install for mozsystemmonitor 12:55:24 INFO - Successfully installed mozsystemmonitor 12:55:24 INFO - Cleaning up... 12:55:25 INFO - Return code: 0 12:55:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:55: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')]} 12:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55: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')]} 12:55:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a820>, '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 0x207b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b9b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', '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 12:55:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:55:25 INFO - Using env: {'DISPLAY': ':0', 12:55:25 INFO - 'HOME': '/home/cltbld', 12:55:25 INFO - 'LANG': 'en_US.UTF-8', 12:55:25 INFO - 'LANGUAGE': 'en_US:en', 12:55:25 INFO - 'LOGNAME': 'cltbld', 12:55:25 INFO - 'MAIL': '/var/mail/cltbld', 12:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:25 INFO - 'MOZ_NO_REMOTE': '1', 12:55:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:25 INFO - 'NO_EM_RESTART': '1', 12:55:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:25 INFO - 'PWD': '/builds/slave/test', 12:55:25 INFO - 'SHELL': '/bin/bash', 12:55:25 INFO - 'SHLVL': '1', 12:55:25 INFO - 'TERM': 'linux', 12:55:25 INFO - 'TMOUT': '86400', 12:55:25 INFO - 'USER': 'cltbld', 12:55:25 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', 12:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:25 INFO - '_': '/tools/buildbot/bin/python'} 12:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:25 INFO - Downloading/unpacking jsonschema==2.5.1 12:55:25 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 12:55:25 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 12:55:25 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 12:55:25 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 12:55:25 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 12:55:25 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 12:55:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:55:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:27 INFO - Downloading functools32-3.2.3-2.tar.gz 12:55:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:55:27 INFO - warning: no files found matching '*.txt' 12:55:27 INFO - no previously-included directories found matching 'build' 12:55:27 INFO - no previously-included directories found matching 'dist' 12:55:27 INFO - no previously-included directories found matching '.git*' 12:55:27 INFO - Installing collected packages: jsonschema, functools32 12:55:27 INFO - Running setup.py install for functools32 12:55:27 INFO - warning: no files found matching '*.txt' 12:55:27 INFO - no previously-included directories found matching 'build' 12:55:27 INFO - no previously-included directories found matching 'dist' 12:55:27 INFO - no previously-included directories found matching '.git*' 12:55:27 INFO - Successfully installed jsonschema functools32 12:55:27 INFO - Cleaning up... 12:55:27 INFO - Return code: 0 12:55:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a820>, '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 0x207b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b9b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', '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 12:55:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:55:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:55:27 INFO - Using env: {'DISPLAY': ':0', 12:55:27 INFO - 'HOME': '/home/cltbld', 12:55:27 INFO - 'LANG': 'en_US.UTF-8', 12:55:27 INFO - 'LANGUAGE': 'en_US:en', 12:55:27 INFO - 'LOGNAME': 'cltbld', 12:55:27 INFO - 'MAIL': '/var/mail/cltbld', 12:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:27 INFO - 'MOZ_NO_REMOTE': '1', 12:55:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:27 INFO - 'NO_EM_RESTART': '1', 12:55:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:27 INFO - 'PWD': '/builds/slave/test', 12:55:27 INFO - 'SHELL': '/bin/bash', 12:55:27 INFO - 'SHLVL': '1', 12:55:27 INFO - 'TERM': 'linux', 12:55:27 INFO - 'TMOUT': '86400', 12:55:27 INFO - 'USER': 'cltbld', 12:55:27 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', 12:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:27 INFO - '_': '/tools/buildbot/bin/python'} 12:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:55:27 INFO - Cleaning up... 12:55:27 INFO - Return code: 0 12:55:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a820>, '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 0x207b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b9b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', '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 12:55:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:55:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:55:27 INFO - Using env: {'DISPLAY': ':0', 12:55:27 INFO - 'HOME': '/home/cltbld', 12:55:27 INFO - 'LANG': 'en_US.UTF-8', 12:55:27 INFO - 'LANGUAGE': 'en_US:en', 12:55:27 INFO - 'LOGNAME': 'cltbld', 12:55:27 INFO - 'MAIL': '/var/mail/cltbld', 12:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:27 INFO - 'MOZ_NO_REMOTE': '1', 12:55:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:27 INFO - 'NO_EM_RESTART': '1', 12:55:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:27 INFO - 'PWD': '/builds/slave/test', 12:55:27 INFO - 'SHELL': '/bin/bash', 12:55:27 INFO - 'SHLVL': '1', 12:55:27 INFO - 'TERM': 'linux', 12:55:27 INFO - 'TMOUT': '86400', 12:55:27 INFO - 'USER': 'cltbld', 12:55:27 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', 12:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:27 INFO - '_': '/tools/buildbot/bin/python'} 12:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:28 INFO - Downloading/unpacking blobuploader==1.2.4 12:55:28 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 12:55:28 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 12:55:28 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 12:55:28 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 12:55:28 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 12:55:28 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 12:55:30 INFO - Downloading blobuploader-1.2.4.tar.gz 12:55:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:55:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:55: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 12:55: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 12:55: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 12:55: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 12:55: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 12:55: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 12:55:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:55:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:55: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 12:55: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 12:55: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 12:55: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 12:55: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 12:55: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 12:55:30 INFO - Downloading docopt-0.6.1.tar.gz 12:55:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:55:30 INFO - Installing collected packages: blobuploader, requests, docopt 12:55:30 INFO - Running setup.py install for blobuploader 12:55:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:55:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:55:31 INFO - Running setup.py install for requests 12:55:31 INFO - Running setup.py install for docopt 12:55:31 INFO - Successfully installed blobuploader requests docopt 12:55:31 INFO - Cleaning up... 12:55:31 INFO - Return code: 0 12:55:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55:31 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')]} 12:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:31 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')]} 12:55:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:31 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 0x1d0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a820>, '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 0x207b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b9b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', '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 12:55:31 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 12:55:31 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 12:55:31 INFO - Using env: {'DISPLAY': ':0', 12:55:31 INFO - 'HOME': '/home/cltbld', 12:55:31 INFO - 'LANG': 'en_US.UTF-8', 12:55:31 INFO - 'LANGUAGE': 'en_US:en', 12:55:31 INFO - 'LOGNAME': 'cltbld', 12:55:31 INFO - 'MAIL': '/var/mail/cltbld', 12:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:31 INFO - 'MOZ_NO_REMOTE': '1', 12:55:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:31 INFO - 'NO_EM_RESTART': '1', 12:55:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:31 INFO - 'PWD': '/builds/slave/test', 12:55:31 INFO - 'SHELL': '/bin/bash', 12:55:31 INFO - 'SHLVL': '1', 12:55:31 INFO - 'TERM': 'linux', 12:55:31 INFO - 'TMOUT': '86400', 12:55:31 INFO - 'USER': 'cltbld', 12:55:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', 12:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:31 INFO - '_': '/tools/buildbot/bin/python'} 12:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:55:31 INFO - Running setup.py (path:/tmp/pip-Zh0ofO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:55:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:55:31 INFO - Running setup.py (path:/tmp/pip-oR40iE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:55:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:55:31 INFO - Running setup.py (path:/tmp/pip-G3dWtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:55:32 INFO - Running setup.py (path:/tmp/pip-BnP0jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:55:32 INFO - Running setup.py (path:/tmp/pip-J4KVlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:55:32 INFO - Running setup.py (path:/tmp/pip-3ZWQfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:55:32 INFO - Running setup.py (path:/tmp/pip-ad7ExX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:55:32 INFO - Running setup.py (path:/tmp/pip-mWHc5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:55:32 INFO - Running setup.py (path:/tmp/pip-xFgPag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:55:32 INFO - Running setup.py (path:/tmp/pip-HX_GwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:55:32 INFO - Running setup.py (path:/tmp/pip-xehNA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:55:32 INFO - Running setup.py (path:/tmp/pip-MIQuwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:55:32 INFO - Running setup.py (path:/tmp/pip-kQ9sjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:55:32 INFO - Running setup.py (path:/tmp/pip-ZunOi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:32 INFO - Running setup.py (path:/tmp/pip-515_AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:55:32 INFO - Running setup.py (path:/tmp/pip-rNar9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:55:32 INFO - Running setup.py (path:/tmp/pip-UUxOrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:55:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:55:33 INFO - Running setup.py install for manifestparser 12:55:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:55:33 INFO - Running setup.py install for mozcrash 12:55:33 INFO - Running setup.py install for mozdebug 12:55:33 INFO - Running setup.py install for mozdevice 12:55:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:55:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:55:33 INFO - Running setup.py install for mozfile 12:55:33 INFO - Running setup.py install for mozhttpd 12:55:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:55:33 INFO - Running setup.py install for mozinfo 12:55:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:55:33 INFO - Running setup.py install for mozInstall 12:55:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:55:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:55:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:55:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:55:33 INFO - Running setup.py install for mozleak 12:55:33 INFO - Running setup.py install for mozlog 12:55:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:55:34 INFO - Running setup.py install for moznetwork 12:55:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:55:34 INFO - Running setup.py install for mozprocess 12:55:34 INFO - Running setup.py install for mozprofile 12:55:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:55:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:55:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:55:34 INFO - Running setup.py install for mozrunner 12:55:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:55:34 INFO - Running setup.py install for mozscreenshot 12:55:34 INFO - Running setup.py install for moztest 12:55:34 INFO - Running setup.py install for mozversion 12:55:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:55:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:55:34 INFO - Cleaning up... 12:55:34 INFO - Return code: 0 12:55:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55:34 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')]} 12:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:34 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')]} 12:55:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:34 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 0x1d0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a820>, '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 0x207b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b9b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', '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 12:55:34 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 12:55:34 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 12:55:34 INFO - Using env: {'DISPLAY': ':0', 12:55:34 INFO - 'HOME': '/home/cltbld', 12:55:34 INFO - 'LANG': 'en_US.UTF-8', 12:55:34 INFO - 'LANGUAGE': 'en_US:en', 12:55:34 INFO - 'LOGNAME': 'cltbld', 12:55:34 INFO - 'MAIL': '/var/mail/cltbld', 12:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:34 INFO - 'MOZ_NO_REMOTE': '1', 12:55:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:34 INFO - 'NO_EM_RESTART': '1', 12:55:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:34 INFO - 'PWD': '/builds/slave/test', 12:55:34 INFO - 'SHELL': '/bin/bash', 12:55:34 INFO - 'SHLVL': '1', 12:55:34 INFO - 'TERM': 'linux', 12:55:34 INFO - 'TMOUT': '86400', 12:55:34 INFO - 'USER': 'cltbld', 12:55:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', 12:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:34 INFO - '_': '/tools/buildbot/bin/python'} 12:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:55:35 INFO - Running setup.py (path:/tmp/pip-MxILY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:55:35 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)) 12:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:55:35 INFO - Running setup.py (path:/tmp/pip-L04W7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:55:35 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)) 12:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:55:35 INFO - Running setup.py (path:/tmp/pip-a86AR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:55:35 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)) 12:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:55:35 INFO - Running setup.py (path:/tmp/pip-23RD_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:55:35 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)) 12:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:55:35 INFO - Running setup.py (path:/tmp/pip-tR0ZyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:55:35 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)) 12:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:55:35 INFO - Running setup.py (path:/tmp/pip-SOfoon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:55:35 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)) 12:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:55:35 INFO - Running setup.py (path:/tmp/pip-gsrBXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:55:35 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)) 12:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:55:35 INFO - Running setup.py (path:/tmp/pip-4FVECz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:55:35 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)) 12:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:55:35 INFO - Running setup.py (path:/tmp/pip-CqEG7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:55:35 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)) 12:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:55:35 INFO - Running setup.py (path:/tmp/pip-hGU3zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:55:35 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)) 12:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:55:35 INFO - Running setup.py (path:/tmp/pip-yQpFAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:55:35 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)) 12:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:55:35 INFO - Running setup.py (path:/tmp/pip-7EOZzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:55:35 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)) 12:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:55:35 INFO - Running setup.py (path:/tmp/pip-DXx4Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:55:36 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)) 12:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:55:36 INFO - Running setup.py (path:/tmp/pip-s8G4HZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:55:36 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)) 12:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:36 INFO - Running setup.py (path:/tmp/pip-8IZdLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:55:36 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)) 12:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:55:36 INFO - Running setup.py (path:/tmp/pip-yoMtLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 12:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:55:36 INFO - Running setup.py (path:/tmp/pip-FvniYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:55:36 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)) 12:55:36 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)) 12:55:36 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)) 12:55:36 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)) 12:55:36 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)) 12:55:36 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)) 12:55:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:38 INFO - Downloading blessings-1.6.tar.gz 12:55:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:55:38 INFO - Installing collected packages: blessings 12:55:38 INFO - Running setup.py install for blessings 12:55:38 INFO - Successfully installed blessings 12:55:38 INFO - Cleaning up... 12:55:38 INFO - Return code: 0 12:55:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:55:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:55:38 INFO - Reading from file tmpfile_stdout 12:55:38 INFO - Current package versions: 12:55:38 INFO - argparse == 1.2.1 12:55:38 INFO - blessings == 1.6 12:55:38 INFO - blobuploader == 1.2.4 12:55:38 INFO - docopt == 0.6.1 12:55:38 INFO - functools32 == 3.2.3-2 12:55:38 INFO - jsonschema == 2.5.1 12:55:38 INFO - manifestparser == 1.1 12:55:38 INFO - mozInstall == 1.12 12:55:38 INFO - mozcrash == 1.0 12:55:38 INFO - mozdebug == 0.1 12:55:38 INFO - mozdevice == 0.49 12:55:38 INFO - mozfile == 1.2 12:55:38 INFO - mozhttpd == 0.7 12:55:38 INFO - mozinfo == 0.9 12:55:38 INFO - mozleak == 0.1 12:55:38 INFO - mozlog == 3.4 12:55:38 INFO - moznetwork == 0.27 12:55:38 INFO - mozprocess == 0.23 12:55:38 INFO - mozprofile == 0.28 12:55:38 INFO - mozrunner == 6.13 12:55:38 INFO - mozscreenshot == 0.1 12:55:38 INFO - mozsystemmonitor == 0.3 12:55:38 INFO - moztest == 0.8 12:55:38 INFO - mozversion == 1.4 12:55:38 INFO - psutil == 3.1.1 12:55:38 INFO - requests == 1.2.3 12:55:38 INFO - wsgiref == 0.1.2 12:55:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:38 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 0x1d0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a820>, '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 0x207b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b9b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', '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 12:55:38 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 12:55:38 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 12:55:38 INFO - Using env: {'DISPLAY': ':0', 12:55:38 INFO - 'HOME': '/home/cltbld', 12:55:38 INFO - 'LANG': 'en_US.UTF-8', 12:55:38 INFO - 'LANGUAGE': 'en_US:en', 12:55:38 INFO - 'LOGNAME': 'cltbld', 12:55:38 INFO - 'MAIL': '/var/mail/cltbld', 12:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:38 INFO - 'MOZ_NO_REMOTE': '1', 12:55:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:38 INFO - 'NO_EM_RESTART': '1', 12:55:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:38 INFO - 'PWD': '/builds/slave/test', 12:55:38 INFO - 'SHELL': '/bin/bash', 12:55:38 INFO - 'SHLVL': '1', 12:55:38 INFO - 'TERM': 'linux', 12:55:38 INFO - 'TMOUT': '86400', 12:55:38 INFO - 'USER': 'cltbld', 12:55:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', 12:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:38 INFO - '_': '/tools/buildbot/bin/python'} 12:55:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:38 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)) 12:55:38 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)) 12:55:38 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)) 12:55:38 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)) 12:55:38 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)) 12:55:38 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)) 12:55:38 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)) 12:55:38 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)) 12:55:38 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)) 12:55:38 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)) 12:55:38 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)) 12:55:38 INFO - Cleaning up... 12:55:39 INFO - Return code: 0 12:55:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:39 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 0x1d0b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a820>, '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 0x207b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b9b0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', '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 12:55:39 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 12:55:39 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 12:55:39 INFO - Using env: {'DISPLAY': ':0', 12:55:39 INFO - 'HOME': '/home/cltbld', 12:55:39 INFO - 'LANG': 'en_US.UTF-8', 12:55:39 INFO - 'LANGUAGE': 'en_US:en', 12:55:39 INFO - 'LOGNAME': 'cltbld', 12:55:39 INFO - 'MAIL': '/var/mail/cltbld', 12:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:39 INFO - 'MOZ_NO_REMOTE': '1', 12:55:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:39 INFO - 'NO_EM_RESTART': '1', 12:55:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:39 INFO - 'PWD': '/builds/slave/test', 12:55:39 INFO - 'SHELL': '/bin/bash', 12:55:39 INFO - 'SHLVL': '1', 12:55:39 INFO - 'TERM': 'linux', 12:55:39 INFO - 'TMOUT': '86400', 12:55:39 INFO - 'USER': 'cltbld', 12:55:39 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', 12:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:39 INFO - '_': '/tools/buildbot/bin/python'} 12:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:55:39 INFO - Cleaning up... 12:55:39 INFO - Return code: 0 12:55:39 INFO - Running post-action listener: _resource_record_post_action 12:55:39 INFO - Running post-action listener: _start_resource_monitoring 12:55:39 INFO - Starting resource monitoring. 12:55:39 INFO - [mozharness: 2016-12-29 20:55:39.266299Z] Finished create-virtualenv step (success) 12:55:39 INFO - [mozharness: 2016-12-29 20:55:39.266811Z] Running install step. 12:55:39 INFO - Running pre-action listener: _resource_record_pre_action 12:55:39 INFO - Running main action method: install 12:55:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:55:39 INFO - Reading from file tmpfile_stdout 12:55:39 INFO - Detecting whether we're running mozinstall >=1.0... 12:55:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:55:39 INFO - Reading from file tmpfile_stdout 12:55:39 INFO - Output received: 12:55:39 INFO - Usage: mozinstall [options] installer 12:55:39 INFO - Options: 12:55:39 INFO - -h, --help show this help message and exit 12:55:39 INFO - -d DEST, --destination=DEST 12:55:39 INFO - Directory to install application into. [default: 12:55:39 INFO - "/builds/slave/test"] 12:55:39 INFO - --app=APP Application being installed. [default: firefox] 12:55:39 INFO - mkdir: /builds/slave/test/build/application 12:55:39 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'] 12:55:39 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 12:55:55 INFO - Reading from file tmpfile_stdout 12:55:55 INFO - Output received: 12:55:55 INFO - /builds/slave/test/build/application/firefox/firefox 12:55:55 INFO - Running post-action listener: _resource_record_post_action 12:55:55 INFO - [mozharness: 2016-12-29 20:55:55.672717Z] Finished install step (success) 12:55:55 INFO - [mozharness: 2016-12-29 20:55:55.672961Z] Running run-tests step. 12:55:55 INFO - Running pre-action listener: _resource_record_pre_action 12:55:55 INFO - Running main action method: run_tests 12:55:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:55:55 INFO - Python 2.7.3 12:55:55 INFO - Return code: 0 12:55:55 INFO - grabbing minidump binary from tooltool 12:55:55 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')]} 12:55:55 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 0x207a820>, '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 0x207b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:55:55 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 12:55:55 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 12:55:55 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 12:55:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:55:55 INFO - Return code: 0 12:55:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:55:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:55:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:55:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:55:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:55:55 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:55:55 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:55:55 INFO - Using env: {'DISPLAY': ':0', 12:55:55 INFO - 'HOME': '/home/cltbld', 12:55:55 INFO - 'LANG': 'en_US.UTF-8', 12:55:55 INFO - 'LANGUAGE': 'en_US:en', 12:55:55 INFO - 'LOGNAME': 'cltbld', 12:55:55 INFO - 'MAIL': '/var/mail/cltbld', 12:55:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:55:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:55 INFO - 'MOZ_NO_REMOTE': '1', 12:55:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:55 INFO - 'NO_EM_RESTART': '1', 12:55:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:55 INFO - 'PWD': '/builds/slave/test', 12:55:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:55:55 INFO - 'SHELL': '/bin/bash', 12:55:55 INFO - 'SHLVL': '1', 12:55:55 INFO - 'TERM': 'linux', 12:55:55 INFO - 'TMOUT': '86400', 12:55:55 INFO - 'USER': 'cltbld', 12:55:55 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636', 12:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:55 INFO - '_': '/tools/buildbot/bin/python'} 12:55:55 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:55:55 INFO - mozversion application_buildid: 20161229120420 12:55:55 INFO - mozversion application_changeset: 79ef936724454728beeeba41fb76a61d02c7c226 12:55:55 INFO - mozversion application_display_name: Nightly 12:55:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:55:55 INFO - mozversion application_name: Firefox 12:55:55 INFO - mozversion application_remotingname: firefox 12:55:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:55:55 INFO - mozversion application_vendor: Mozilla 12:55:55 INFO - mozversion application_version: 53.0a1 12:55:55 INFO - mozversion platform_buildid: 20161229120420 12:55:55 INFO - mozversion platform_changeset: 79ef936724454728beeeba41fb76a61d02c7c226 12:55:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:55:55 INFO - mozversion platform_version: 53.0a1 12:55:55 INFO - using testdate: 1483044955 12:55:55 INFO - actual date: 1483044955 12:55:55 INFO - starting webserver on 'localhost:44508' 12:55:55 INFO - SUITE-START | Running 2 tests 12:55:55 INFO - TEST-START | dromaeo_css 12:55:55 INFO - operating with platform_type : linux_ 12:55:55 INFO - Initialising browser for dromaeo_css test... 12:55:55 INFO - TEST-INFO | started process 3457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxhSCIq/profile http://localhost:44508/getInfo.html) 12:55:56 INFO - PROCESS | 3457 | 1483044956427 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 12:56:00 INFO - PROCESS | 3457 | __metrics Screen width/height:1600/1200 12:56:00 INFO - PROCESS | 3457 | colorDepth:24 12:56:00 INFO - PROCESS | 3457 | Browser inner width/height: 1024/697 12:56:00 INFO - PROCESS | 3457 | __metrics 12:56:01 ERROR - PROCESS | 3457 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 12:56:02 INFO - TEST-INFO | 3457: exit 0 12:56:02 INFO - Browser initialized. 12:56:02 INFO - Running cycle 1/1 for dromaeo_css test... 12:56:02 INFO - TEST-INFO | started process 3578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxhSCIq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:56:14 INFO - PROCESS | 3578 | RSS: Main: 158060544 12:56:14 INFO - PROCESS | 3578 | 12:59:17 INFO - PROCESS | 3578 | Cycle 1(1): loaded http://localhost:44508/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44508/tests/dromaeo/cssquery-ext.html) 12:59:18 INFO - PROCESS | 3578 | RSS: Main: 165806080 12:59:18 INFO - PROCESS | 3578 | 13:01:02 INFO - PROCESS | 3578 | ************************* 13:01:02 INFO - PROCESS | 3578 | A coding exception was thrown and uncaught in a Task. 13:01:02 INFO - PROCESS | 3578 | 13:01:02 INFO - PROCESS | 3578 | Full message: ReferenceError: fetch is not defined 13:01:02 INFO - PROCESS | 3578 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 13:01:02 INFO - PROCESS | 3578 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 13:01:02 INFO - PROCESS | 3578 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 13:01:02 INFO - PROCESS | 3578 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 13:01:02 INFO - PROCESS | 3578 | TaskImpl@resource://gre/modules/Task.jsm:277:3 13:01:02 INFO - PROCESS | 3578 | asyncFunction@resource://gre/modules/Task.jsm:252:14 13:01:02 INFO - PROCESS | 3578 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 13:01:02 INFO - PROCESS | 3578 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 13:01:02 INFO - PROCESS | 3578 | TaskImpl@resource://gre/modules/Task.jsm:277:3 13:01:02 INFO - PROCESS | 3578 | asyncFunction@resource://gre/modules/Task.jsm:252:14 13:01:02 INFO - PROCESS | 3578 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 13:01:02 INFO - PROCESS | 3578 | 13:01:02 INFO - PROCESS | 3578 | ************************* 13:02:21 INFO - PROCESS | 3578 | Cycle 1(1): loaded http://localhost:44508/tests/dromaeo/cssquery-ext.html (next: http://localhost:44508/tests/dromaeo/cssquery-jquery.html) 13:02:21 INFO - PROCESS | 3578 | RSS: Main: 162435072 13:02:21 INFO - PROCESS | 3578 | 13:05:24 INFO - PROCESS | 3578 | Cycle 1(1): loaded http://localhost:44508/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44508/tests/dromaeo/cssquery-mootools.html) 13:05:24 INFO - PROCESS | 3578 | RSS: Main: 168124416 13:05:24 INFO - PROCESS | 3578 | 13:08:26 INFO - PROCESS | 3578 | Cycle 1(1): loaded http://localhost:44508/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44508/tests/dromaeo/cssquery-prototype.html) 13:08:27 INFO - PROCESS | 3578 | RSS: Main: 161894400 13:08:27 INFO - PROCESS | 3578 | 13:11:30 INFO - PROCESS | 3578 | Cycle 1(1): loaded http://localhost:44508/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44508/tests/dromaeo/cssquery-yui.html) 13:11:31 INFO - PROCESS | 3578 | RSS: Main: 167485440 13:11:31 INFO - PROCESS | 3578 | 13:14:33 INFO - PROCESS | 3578 | Cycle 1(1): loaded http://localhost:44508/tests/dromaeo/cssquery-yui.html (next: http://localhost:44508/tests/dromaeo/cssquery-dojo.html) 13:14:34 INFO - PROCESS | 3578 | RSS: Main: 166367232 13:14:34 INFO - PROCESS | 3578 | 13:14:34 INFO - PROCESS | 3578 | __start_tp_report 13:14:34 INFO - PROCESS | 3578 | _x_x_mozilla_page_load 13:14:34 INFO - PROCESS | 3578 | _x_x_mozilla_page_load_details 13:14:34 INFO - PROCESS | 3578 | |i|pagename|runs| 13:14:34 INFO - PROCESS | 3578 | |0;dojo.html;2580.600006998915;2588.1329754532253;2590.9093181738644;2611.6865976082872;2613.1899111275507;4637.513061128583;4802.015586804705;4810.06203790261;4825.831095911643;4830.468648448667;4695.3191787190835;4750;4772.90454190916;4779.952200477994;4798.088363210987;4405.074934263808;4420.491643461003;4491.820327186909;4538.500764915857;4588.082383523292;4425.358323043157;4452.888677783049;4470.038941627549;4501.167284052461;4503.4145561077175;4313.568643135693;4315.568443155659;4320.9135817283795;4360.1279744051;4404.119176164748;4348.043430445328;4374.868753937387;4381.75900325482;4387.890302742425;4389.4513185851765;4299.892502687427;4361.476622805252;4386.934195987063;4417.911641767147;4418.403515525395;4728;4729.330879544445;4731.030138821533;4731.574158325767;4748.667593268473;4924.187509061001;4966.453690094087;5109.054824857413;5125.589952803767;5152.9484705152845;5018.47306032865;5060.797568097271;5063.620228482879;5124.103281925648;5150.407703114115;4716.3868697069165;4757.35775670287;4757.429108506966;4758.595519380857;4808.422989241313;5138.640295179302;5167.715775632301;5205.141151710001;5210.557102646242;5229.712365819841;4836.782344794493;4878.926816097762;4942.085714142895;4957.529034741766;4962.230854217602;4880.463149053601;4954.47977962316;5054.317667114892;5069.847904562869;5133.050385678662;4992.226204938241;4996.100701873697;5047.899042019212;5067.949320506747;5115.97442012795;4910.017996400734;5090.236464530276;5096.082705113041;5112.4120726116225;5157.510036546522;4247.723897946624;4298.806553705091;4301.806418711103;4303.655707543389;4371.803268852909;3735.831887565066;3759.774413535197;3762.9247415051545;3774.7168962327387;3804.885853424402;4340.088581397878;4353.869383918487;4376.452943382077;4377.584129507692;4423.049044455457;5010.273510341053;5052.57053150479;5070.771815268322;5115.951229997841;5162.199859021857;4390.736555806662;4407.405000324915;4408.030233348658;4448.243798554254;4449.3326001100095;4636.095961287517;4646.442426908792;4647.16351056813;4656.930146047812;4700.576948074689;4640.559146881041;4693.483716791218;4726.432828060655;4744.857654270378;4825.541573550507;5138.049460849755;5143.228515722672;5164.612654050886;5204;5226.555742761908;4759.762011899322;4775.474697783172;4783.6412269079265;4792.856214313576;4818.783154757974;4925.064237794808;4980.427250866197;5015.448300686994;5038.697678139323;5078.08594453002;5094.6688465249645;5166.3800343958965;5178.43037265908;5226.608004399762;5243.5542978847225;5004.149294619996;5022.824201152942;5025.648204625787;5041.218611115283;5079.44126146131;4847.3698419205275;4862.343583616308;4876.414830220397;4912.263160525949;4950.653454258168;4716.363290955677;4865.0756356292195;4897.632677549127;4955.231939049453;4961.404631444249;5040.7479626019285;5056.519630635084;5060.620453465931;5093.567046801063;5117.488251174853;4923.876903077308;4941.97529012367;4953.578945789648;4958.404991401055;4975.825846095369 13:14:34 INFO - PROCESS | 3578 | |1;ext.html;511.30462570903575;523.7826302084635;527.1828665568371;527.9208118782183;533.8558589180918;36687.81656091719;38777.22445551091;38838.805805970966;42501.57498425015;42550.36174457386;39020.414693779545;39344.60655393452;39400.40899386504;39532.80233598828;39537.60462395375;7628.084629844427;7811.4922530035365;7814.882776758353;7839.098503672065;9350.25197984163;9227.077292270786;9634.614615415376;9637.807243855119;9645.987171347013;9655.937846836843;9641.951790241039;9653.951730241373;9688.418694878295;9692.321537492378;9703.514824258795;9571.760705982337;9613.759656008586;9632.903670963271;9637.71086867395;9643.90356096437;9449.102335278207;9578.760530986712;9579.856302155473;9586.233101351874;9597.664081757104;32726.345473090405;32755.50866737001;32845.34309313824;32855.6714432855;32925.83537082299;3519.9472007919903;3641.362761516724;3666.5600127984544;3687.7418580699364;3688.2254726507467;24726.381840453952;24841.62737558938;25384.492310153877;25520.234392968054;25651.102211422698;3431.7940923544415;3433.0902310887636;3449.379111759882;3453.689167974869;3466.2894106708063;225651;227189;227439;228105;229063;45317.77341113339;45359;45379.09241815145;45482.72276435821;45623.31565026527;47412.288815667795;47606.76196619064;47619.76190119027;47630.76184619124;47665.76167119142;13266.137701049402;13795.586132416043;13810.309484525733;13811.930940345233;13834.100783449245;9753.268504862164;9988.700338989842;10119;10322.535485903152;10679.733006674895;14972.326245318987;15048.699026019638;15121.546353609408;15347.616309592126;15381.692366152614;6185.876282474325;6461.450776683941;6562.507811914125;6592.571482853695;6592.637404942774;697.1773307497202;697.8415829722737;710.7638474690797;726.2700985509634;733.2191216354565;26242.868785655948;27214.591781123298;27596.172114836587;27701.861490692416;27725.445491090064;885.8892638420198;901.4540063790499;901.7655409593422;923.7275003873873;930.6742640075919;13640.931795340959;14511.492097776527;14521.78217326741;14719.190444525653;14820.184889830947;315266;316968;318154;318311;318818;48581;49054.26418603724;49079;49097.50902491001;49448.75275623671;1129.5312445335258;1139.32779660001;1171.8769529199483;1176.2883455509464;1176.3236139219812;24103.44930210413;25175.24474265775;26565;26689.33276668021;26765.86617066902;40536.59463405446;40782.1843563133;40870.59129408668;40873.591264088165;40884.79557602193;264371;264959;266116;267411;268030;21081.6837747437;21683.34949951504;21804.236851710113;22901;22951.6557251638;35395.64604353924;35895.28209435744;36581.08547286232;36720.449193261586;37009.44485832768;30286.54570181493;30484.390312194075;30943.226419339695;30966.22584435407;31875.68124318727;30770;31080.22299442532;31131;31419.52870706987;32023.03930882077;30298.545521816748;30325.241868953453;30428;30465.54301685432;31114.844425777726;26151.17853698561;28608.57087143736;28754.568681469376;28913.42173156567;29239.415211696072;21775.346739597837;21848.890755546756;21994.89002555041;22001.11995520161;22088 13:14:34 INFO - PROCESS | 3578 | |2;jquery.html;360.2974200309396;366.92294618130194;371.38721110168217;379.3778203745857;384.348529242933;15418.61453463664;16452.670946581075;16476.340946362132;16635;16642.417515386966;15761.842381576182;15788.763168552481;15926.442574509894;16135.515934521954;16194.838051619481;4893.070316639845;5065.518775716301;5104.33643626328;5115.258287548303;5125.1287281162295;4989.101961646902;5034.974825125869;5328.973355133219;5345.946540534604;5393.217983392406;5361.785528578872;5372.059889519319;5374.328208973879;5379.38137114231;5383.623146379755;5248.947510524903;5338.3060202173665;5555.166724991263;5567.387587365387;5596.188552659883;5342.27879236302;5351.277577527023;5361.410244873061;5376.865578360573;5396.514313711746;19494.902525487425;19565;19955.401337959884;20044.69932951007;20067.498312542157;2327.3483424641126;2434.379233295516;2453.6932883389577;2469.5678256305073;2490.066225165563;8865.734027979172;8877.289816814638;9084.50035248061;9390.248780097576;9427.34008619397;1662.8669706423457;1711.3069206971072;1711.8972861628342;1745.0576688588146;1757.5606098475382;63798;65000.99999999953;65247.67376163089;65880.6705966472;66207.3379266206;9563.474008929576;9697.127258546765;9890.357126786736;9934.105930466292;10057.396556206651;13572.728545429234;13603.115797473132;13603.863961360457;13620.795688064687;13626.318684065756;7015.89476157858;7110.537815042006;7255.45584081196;7280.635968201569;7372.668229929559;6782.93217067823;6856.725730970805;7010.439164866799;7023.964880175567;7024.262452442522;4171.311733563928;4284.078923031563;4297.484301883794;4300.956990430118;4344.847930322424;1705.6503416799526;1751.9474415767547;1787.294018862542;1849.5838436351983;1878.5209771508178;873.5021038008401;898.5641963647626;899.150302963693;913.164454524103;914.8170365926841;14701.55895323142;14981.176035317943;15485.922570387076;16008.11955342444;16188.595285117966;863.7408777366765;874.6807415293372;878.4904755241944;886.0563499872615;916.3356566489375;8780.165884240987;8899.644014239488;9028.18746312835;9069.909300907038;9278.536073196314;309363;310279;310416;316865;324668;72893.27106728971;73240.63379683068;75688.62155689186;77433.2256677426;77954.6102269485;909.913558211982;930.6137952749668;934.2152591822901;947.265868951568;952.2096659772511;13748.381322840696;13754.174749515061;13868.4452621894;13947.302634868012;14591.708165836837;34938.47592286169;35059;35582.11044723903;35808;35999.82000090087;46852.7657361711;46965.53034469748;47163;47334.76332618315;49078;4951.405831300123;5053.191489361684;7461.253874612496;7700.4224683150105;7965.402594805529;9989.60041598328;11001.284916480403;11191;11636.12729045342;11657.53369865196;9832.852507212254;9963.850542241727;10088.495575221357;10121;10224.948875255575;9474;9888.307818452638;10117;10424.68725938223;10494.055535001886;9282.860757088514;9309.581068852054;9514.571844266886;10068.24488163376;10232.232582556488;7515.962420187864;7537.924620753723;7545.50954187976;7787.8831817523915;7849.136594974662;7259.564426134449;8343.374246931384;9395.24838012971;9561.139497445263;9801.75495612587 13:14:34 INFO - PROCESS | 3578 | |3;mootools.html;1281.5322407321325;1301.6615679923218;1312.612779230127;1313.1989486413293;1313.750387426389;6183.567150299481;6377.107204991305;6798.830029249271;7165.749198778044;7172.533785303952;6949;7192.280771922805;7217.06178196835;7356.374708149814;7371.520851144672;2119.7774233705472;2138.123369418539;2161.708169397135;2164.8592841465334;2165.252987719234;2084.062172022588;2109.24067335759;2119.14174759222;2142.507223338633;2164.491344534033;2015.5364266218778;2033.2578608807826;2037.0731317250616;2039.51051747581;2046.8976551172457;2026.2705426046612;2046.58045100754;2053.3429302623167;2064.411642681836;2076.9376918692387;2046.069038587439;2067.80355866194;2089.937301880946;2112.8837913914726;2138.5829763196184;7223.530470519399;7323.890141647879;7355.5586664800285;7391.22392148822;7399.075115610549;4395.120975804852;4507.143642707875;4519.435070616173;4525.411696479437;4530.728156310632;2774.9306267343277;2824.7598954088926;2878.4962631539397;2889.942201155965;2891.3783536539536;1042.723678225271;1050.453764042701;1069.0859315285475;1080.4651697409754;1090.1061129873508;9237.261019118454;9238.676646317346;9286.535673216313;9296.442213467146;9360.95319523398;3762.4415397529397;3807;3822.445745366906;3866.0528170597822;3898.317794385971;7678.923210767933;7695.92304076952;7706.961465192639;7712.922870771333;7742.225777422325;4366.454193225847;4374.475062992461;4381.868543943687;4382.517923028464;4384.846530371486;4033.153037862023;4098.590140985878;4118.320477121241;4143.709940304149;4154.480689913761;3138.764592655514;3211.325621619486;3296.0770984124483;3329.617094034217;3349.2129349602824;877.8024944387462;913.8400779863497;930.972070837876;934.8036912248368;943.9244860411151;739.7706710919632;766.651173715958;774.7598244544209;781.5779479081347;786.8741001439856;4432.645388368923;4669.766511674403;4683.414573178353;4811.182099043171;4827.589654879304;767.1867820110589;811.7199566149669;812.2608426332009;812.9674813007414;817.8200795824908;2976.5683975823817;3094.5667606535103;3122.406742718876;3153.353562519678;3259.837008149583;8323.542205178652;8496.660133594587;8599.871001934976;8612.741617751477;8623.913760862437;8458.196471335214;8475.152484751476;8488.151184881586;8498.277646400002;8508.234258916727;6813.1142951415995;6916.654167291716;6951.6871740771785;6960.37356637905;6968.965155174192;4495.325701144854;4603.6777425579885;4644.954885150814;4672.74299913508;4675.859724208279;7990.440669153336;7990.880136797837;8091.393145513992;8114.229148230908;8157.836843262983;7638.847223055619;7784.455088143775;7848.332891704269;8052.798680033046;8207.876881846896;6074.210352654127;6097.908531371944;6116.082587611894;6154.5384096192065;6157.384261573807;6903.1371078615175;6944.062551555476;6951.826204344932;6979.232284448605;6983.615901125487;6217.689115544114;6298.559100862895;6325.399087086719;6389.2652344980925;6435.646039467687;6222.62664240147;6293.905591416041;6317.30509643948;6360.268569114611;6455.935440645533;5279.128943724242;5351.143816989263;5351.866203344947;5362.785488580413;5363.463653634762;3950.229705207457;3951.545572259227;3999.8400063997115;4024.295748243987;4101.282275601818;3913.25648126855;3918.0792513758674;3970.3647416413237;3985.7807820568987;4017.8593749218635 13:14:34 INFO - PROCESS | 3578 | |4;prototype.html;329.14586647649355;341.7641827139274;349.64685667475874;349.98250087495626;352.2567382822243;4888.289098815413;4940.827071052514;4973.975130124349;5099.286099946006;5101.591872650193;4792.90414191716;4894.975525122379;4909.656324057309;4909.877253068675;4921.400544822938;4015.2571774221715;4015.7791321477307;4023.376376661615;4043.5147782266167;4061.8578349757763;3886.9222615547674;4016.9397459038137;4024.738392004525;4033.556308806029;4046.1300820323627;3935.9803200984097;3944.8027598620097;3948.2300951314505;3948.4077388391684;3949.486566746333;3924.862629807957;3934.7245692801516;3943.073377756225;3947.2894878921784;3972.6623237024887;3567.571891373052;3577.3203091412806;3600.1539638185004;3605.3235245610917;3605.7836529808033;4659.976700116477;4790.880227994293;4844.37023186987;4868.659193856432;4874.926876096862;4544.932055914551;4558.270676691714;4558.8632341029825;4572.771361431948;4592.196365636;5161.690298582097;5175.974120129413;5210.921836172461;5217.399999000126;5226.712530810804;3732.6547888376886;3885.7279990400684;3896.376579747255;3899.53205615328;3906.2187562487334;5389.221556886218;5389.245505629215;5406.648567843077;5417.864553386157;5431.972840135813;3997.1605962747567;4011.4183443400543;4030.2544029354663;4040.7575545467366;4046.919061618751;4018.6584140347813;4047.919041619151;4073.6944729145434;4082.285440115159;4084.6936479764136;4102.774347410861;4298.914021719611;4310.612044915973;4312.805923733439;4337.783110844445;5180.813799513272;5187;5200.115980283285;5204.947950520522;5246.213068039825;1248.9000879929583;1264.8988080953502;1275.8022506511506;1279.3986826191674;1287.7102651903247;859.2181115185151;868.2055918834322;870.0864092702637;877.1447838357678;885.9246964008131;4360.71655342408;4387.714798538085;4407.2507673695545;4411.205982923105;4424.823007079745;5194.97402512985;5200.479952004769;5211.2443695663915;5223.555997740159;5238.266642670029;4419;4441.333799930037;4444.0002997976235;4447.977760111179;4463.808377010453;2652.469506098788;2760.5169095408223;2780.402213524102;2781.3602871339704;2785.3454438207004;4850.563449289581;4853.616719235001;4855.830045948375;4871.634627402888;4883.316335713003;5060.316857224301;5320.669832541865;5333.86665333362;5344.144936810092;5351.678899266057;4758.976205118952;4761.333413322138;4766.666333356632;4780.760961951889;4785.425748910084;5149.9227511586605;5171.276021356938;5202.687838729688;5205.609579281493;5215.973920130375;4974.278729584118;5079.415867175175;5101.01060586379;5111.539961403343;5153.278541004187;4959.454460009469;4960.652754307164;4971.9502804972935;4978.950210497848;4996.575291100152;3706.5922748497105;3747.587765345755;3766.3785475396253;3774.5281839770028;3777.807752449176;5207.3230480037355;5367.892642147213;5466.207399926909;5486.369067557282;5515.586331025109;5232.607554433356;5234.816781412632;5261.8423946731655;5273.815416460406;5281.683099014072;5225.268462415341;5234.612827600765;5237.371515418175;5273.472652734849;5291.920621190762;4889.584385327287;5139.023585518889;5191.454897235736;5200.791968321225;5219.869503262449;5235.685858848481;5242.449542797951;5243.5542978847225;5249.002689488985;5253.896681696887;5139.537441630271;5159.477954003653;5169.844904652867;5180.425506400572;5180.456052114474 13:14:34 INFO - PROCESS | 3578 | |5;yui.html;648.2804087462915;654.9541532092755;724.0840336973725;744.2854859335038;757.6059254539662;11904.345261010641;12822.743545129091;13217.471301147954;13294.335283235823;13405.865941340584;12661.746765064694;12780.36098195089;12783.808242876365;12793.104482686216;12924.612261632166;787.9606019699021;789.5775759968418;807.9394045446586;809.1221025187679;809.4778867630375;784.5959330944568;805.7663277649475;809.1786836361098;809.2393150438598;809.5790189101664;855.8288342331527;856.0241324889631;857.5626430520448;857.7341024282462;859.3211363023204;843.8312337532518;849.2229609906927;849.4860609331358;849.4945507423073;850.345234169692;620.2742790934617;620.761007012299;621.7264403662374;621.7481919822479;623.688155922039;13744.381502832397;13819.239941803196;14305.785413218706;14507.782383264259;14510.274486275644;10127;12847.614571562868;13684.93157534216;13878.236696981661;13929.955253356038;11452.541898324058;12035.217710848767;12227.816582751266;12300.384980751016;12376.690582735413;4113.91772164558;4156.355764856452;4160.83356665733;4163.770992595406;4224.070704445017;64796;65092;65181.67409162971;65828.3417165827;66358;9969.501524923724;10255.384676919408;10417.270791044706;10433.686989390331;10475.16198704117;18195.45413637593;19160.904195479212;19451.31920382808;19554.217831286875;19708.31020914261;6845.383915447534;6994.790156295319;7015.298470152944;7025.498004006904;7181.928180718231;3608.332458495187;3669.6697297243377;3676.6690997810324;3756.286305601927;3776.339140650375;2876.0652787843615;2930.1502564256125;2932.1057077591113;2942.47035533606;2952.926176845553;480.8389189621446;483.82582270382636;495.21508409171145;521.5905514171358;548.506344290142;582.8164128299572;607.1499900139839;607.8389226854798;616.1066453642147;617.9691015449209;8029.678812847537;8190.549519776469;8246.505209687439;8269.338452923752;8553.315734741205;613.12629502959;629.4932579273637;634.4321831960461;640.2604991235131;645.6965226343611;3794.962050379516;3996.980015099906;4007.7394969327484;4018.859339923147;4091.3044782387065;66037.66981165063;67943.66028169828;68561;68937;69027.3097269031;56859.43140568624;58275.12587311194;58358.12462813061;59284.11073833896;60839;52066.47933520616;52156;52167.73916130471;52679.73660131675;53063.204051939254;7479.36425403825;7562.697492100255;7570.659320330708;7627.161012288533;7641.808954775953;35905.28189436249;37056.814715926244;37445.12774361217;37892.810535947145;38309.808450957564;34448.655513444544;46807.53192468032;46926;47005;47099.52900471089;9683.41899486033;9699.806003880023;9727.562259698188;9865.06281903218;10326.845097323396;11087.113030957666;11141.331520108819;11355.943220284176;11370.374629395463;11445.084393248353;10055.095041446304;11235.88764112381;11513.712157196138;12320.260784352968;12711;11126.554937802397;11334.206605537533;11768.76462470763;12063;12076.879231207575;11170.553177872795;11189.440527973731;11695.132089184155;11956.34240116802;12030.458629361874;9483.383580067273;9495.620175192915;10073.496325183858;10348.896511034793;10576.206784491347;9576.23390128802;9855.802883942424;9944.204463642747;9958.103770660675;9987.60049598008 13:14:34 INFO - PROCESS | 3578 | __end_tp_report 13:14:34 INFO - PROCESS | 3578 | __start_cc_report 13:14:34 INFO - PROCESS | 3578 | _x_x_mozilla_cycle_collect,342 13:14:34 INFO - PROCESS | 3578 | __end_cc_report 13:14:34 INFO - PROCESS | 3578 | __startTimestamp1483046074168__endTimestamp 13:14:34 INFO - PROCESS | 3578 | 13:14:34 INFO - PROCESS | 3578 | ------- Summary: start ------- 13:14:34 INFO - PROCESS | 3578 | Number of tests: 6 13:14:34 INFO - PROCESS | 3578 | 13:14:34 INFO - PROCESS | 3578 | [#0] dojo.html Cycles:165 Average:4708.46 Median:4818.78 stddev:498.99 (10.4%) stddev-sans-first:471.77 13:14:34 INFO - PROCESS | 3578 | Values: 2580.6 2588.1 2590.9 2611.7 2613.2 4637.5 4802.0 4810.1 4825.8 4830.5 4695.3 4750.0 4772.9 4780.0 4798.1 4405.1 4420.5 4491.8 4538.5 4588.1 4425.4 4452.9 4470.0 4501.2 4503.4 4313.6 4315.6 4320.9 4360.1 4404.1 4348.0 4374.9 4381.8 4387.9 4389.5 4299.9 4361.5 4386.9 4417.9 4418.4 4728.0 4729.3 4731.0 4731.6 4748.7 4924.2 4966.5 5109.1 5125.6 5152.9 5018.5 5060.8 5063.6 5124.1 5150.4 4716.4 4757.4 4757.4 4758.6 4808.4 5138.6 5167.7 5205.1 5210.6 5229.7 4836.8 4878.9 4942.1 4957.5 4962.2 4880.5 4954.5 5054.3 5069.8 5133.1 4992.2 4996.1 5047.9 5067.9 5116.0 4910.0 5090.2 5096.1 5112.4 5157.5 4247.7 4298.8 4301.8 4303.7 4371.8 3735.8 3759.8 3762.9 3774.7 3804.9 4340.1 4353.9 4376.5 4377.6 4423.0 5010.3 5052.6 5070.8 5116.0 5162.2 4390.7 4407.4 4408.0 4448.2 4449.3 4636.1 4646.4 4647.2 4656.9 4700.6 4640.6 4693.5 4726.4 4744.9 4825.5 5138.0 5143.2 5164.6 5204.0 5226.6 4759.8 4775.5 4783.6 4792.9 4818.8 4925.1 4980.4 5015.4 5038.7 5078.1 5094.7 5166.4 5178.4 5226.6 5243.6 5004.1 5022.8 5025.6 5041.2 5079.4 4847.4 4862.3 4876.4 4912.3 4950.7 4716.4 4865.1 4897.6 4955.2 4961.4 5040.7 5056.5 5060.6 5093.6 5117.5 4923.9 4942.0 4953.6 4958.4 4975.8 13:14:34 INFO - PROCESS | 3578 | 13:14:34 INFO - PROCESS | 3578 | [#1] ext.html Cycles:180 Average:41742.86 Median:3451.53 stddev:71409.19 (2068.9%) stddev-sans-first:71542.40 13:14:34 INFO - PROCESS | 3578 | Values: 511.3 523.8 527.2 527.9 533.9 36687.8 38777.2 38838.8 42501.6 42550.4 39020.4 39344.6 39400.4 39532.8 39537.6 7628.1 7811.5 7814.9 7839.1 9350.3 9227.1 9634.6 9637.8 9646.0 9655.9 9642.0 9654.0 9688.4 9692.3 9703.5 9571.8 9613.8 9632.9 9637.7 9643.9 9449.1 9578.8 9579.9 9586.2 9597.7 32726.3 32755.5 32845.3 32855.7 32925.8 3519.9 3641.4 3666.6 3687.7 3688.2 24726.4 24841.6 25384.5 25520.2 25651.1 3431.8 3433.1 3449.4 3453.7 3466.3 225651.0 227189.0 227439.0 228105.0 229063.0 45317.8 45359.0 45379.1 45482.7 45623.3 47412.3 47606.8 47619.8 47630.8 47665.8 13266.1 13795.6 13810.3 13811.9 13834.1 9753.3 9988.7 10119.0 10322.5 10679.7 14972.3 15048.7 15121.5 15347.6 15381.7 6185.9 6461.5 6562.5 6592.6 6592.6 697.2 697.8 710.8 726.3 733.2 26242.9 27214.6 27596.2 27701.9 27725.4 885.9 901.5 901.8 923.7 930.7 13640.9 14511.5 14521.8 14719.2 14820.2 315266.0 316968.0 318154.0 318311.0 318818.0 48581.0 49054.3 49079.0 49097.5 49448.8 1129.5 1139.3 1171.9 1176.3 1176.3 24103.4 25175.2 26565.0 26689.3 26765.9 40536.6 40782.2 40870.6 40873.6 40884.8 264371.0 264959.0 266116.0 267411.0 268030.0 21081.7 21683.3 21804.2 22901.0 22951.7 35395.6 35895.3 36581.1 36720.4 37009.4 30286.5 30484.4 30943.2 30966.2 31875.7 30770.0 31080.2 31131.0 31419.5 32023.0 30298.5 30325.2 30428.0 30465.5 31114.8 26151.2 28608.6 28754.6 28913.4 29239.4 21775.3 21848.9 21994.9 22001.1 22088.0 13:14:34 INFO - PROCESS | 3578 | 13:14:34 INFO - PROCESS | 3578 | [#2] jquery.html Cycles:180 Average:21641.06 Median:5120.19 stddev:52349.37 (1022.4%) stddev-sans-first:52471.84 13:14:34 INFO - PROCESS | 3578 | Values: 360.3 366.9 371.4 379.4 384.3 15418.6 16452.7 16476.3 16635.0 16642.4 15761.8 15788.8 15926.4 16135.5 16194.8 4893.1 5065.5 5104.3 5115.3 5125.1 4989.1 5035.0 5329.0 5345.9 5393.2 5361.8 5372.1 5374.3 5379.4 5383.6 5248.9 5338.3 5555.2 5567.4 5596.2 5342.3 5351.3 5361.4 5376.9 5396.5 19494.9 19565.0 19955.4 20044.7 20067.5 2327.3 2434.4 2453.7 2469.6 2490.1 8865.7 8877.3 9084.5 9390.2 9427.3 1662.9 1711.3 1711.9 1745.1 1757.6 63798.0 65001.0 65247.7 65880.7 66207.3 9563.5 9697.1 9890.4 9934.1 10057.4 13572.7 13603.1 13603.9 13620.8 13626.3 7015.9 7110.5 7255.5 7280.6 7372.7 6782.9 6856.7 7010.4 7024.0 7024.3 4171.3 4284.1 4297.5 4301.0 4344.8 1705.7 1751.9 1787.3 1849.6 1878.5 873.5 898.6 899.2 913.2 914.8 14701.6 14981.2 15485.9 16008.1 16188.6 863.7 874.7 878.5 886.1 916.3 8780.2 8899.6 9028.2 9069.9 9278.5 309363.0 310279.0 310416.0 316865.0 324668.0 72893.3 73240.6 75688.6 77433.2 77954.6 909.9 930.6 934.2 947.3 952.2 13748.4 13754.2 13868.4 13947.3 14591.7 34938.5 35059.0 35582.1 35808.0 35999.8 46852.8 46965.5 47163.0 47334.8 49078.0 4951.4 5053.2 7461.3 7700.4 7965.4 9989.6 11001.3 11191.0 11636.1 11657.5 9832.9 9963.9 10088.5 10121.0 10224.9 9474.0 9888.3 10117.0 10424.7 10494.1 9282.9 9309.6 9514.6 10068.2 10232.2 7516.0 7537.9 7545.5 7787.9 7849.1 7259.6 8343.4 9395.2 9561.1 9801.8 13:14:34 INFO - PROCESS | 3578 | 13:14:34 INFO - PROCESS | 3578 | [#3] mootools.html Cycles:180 Average:4664.44 Median:5315.14 stddev:2535.47 (47.7%) stddev-sans-first:2529.84 13:14:34 INFO - PROCESS | 3578 | Values: 1281.5 1301.7 1312.6 1313.2 1313.8 6183.6 6377.1 6798.8 7165.7 7172.5 6949.0 7192.3 7217.1 7356.4 7371.5 2119.8 2138.1 2161.7 2164.9 2165.3 2084.1 2109.2 2119.1 2142.5 2164.5 2015.5 2033.3 2037.1 2039.5 2046.9 2026.3 2046.6 2053.3 2064.4 2076.9 2046.1 2067.8 2089.9 2112.9 2138.6 7223.5 7323.9 7355.6 7391.2 7399.1 4395.1 4507.1 4519.4 4525.4 4530.7 2774.9 2824.8 2878.5 2889.9 2891.4 1042.7 1050.5 1069.1 1080.5 1090.1 9237.3 9238.7 9286.5 9296.4 9361.0 3762.4 3807.0 3822.4 3866.1 3898.3 7678.9 7695.9 7707.0 7712.9 7742.2 4366.5 4374.5 4381.9 4382.5 4384.8 4033.2 4098.6 4118.3 4143.7 4154.5 3138.8 3211.3 3296.1 3329.6 3349.2 877.8 913.8 931.0 934.8 943.9 739.8 766.7 774.8 781.6 786.9 4432.6 4669.8 4683.4 4811.2 4827.6 767.2 811.7 812.3 813.0 817.8 2976.6 3094.6 3122.4 3153.4 3259.8 8323.5 8496.7 8599.9 8612.7 8623.9 8458.2 8475.2 8488.2 8498.3 8508.2 6813.1 6916.7 6951.7 6960.4 6969.0 4495.3 4603.7 4645.0 4672.7 4675.9 7990.4 7990.9 8091.4 8114.2 8157.8 7638.8 7784.5 7848.3 8052.8 8207.9 6074.2 6097.9 6116.1 6154.5 6157.4 6903.1 6944.1 6951.8 6979.2 6983.6 6217.7 6298.6 6325.4 6389.3 6435.6 6222.6 6293.9 6317.3 6360.3 6455.9 5279.1 5351.1 5351.9 5362.8 5363.5 3950.2 3951.5 3999.8 4024.3 4101.3 3913.3 3918.1 3970.4 3985.8 4017.9 13:14:34 INFO - PROCESS | 3578 | 13:14:34 INFO - PROCESS | 3578 | [#4] prototype.html Cycles:180 Average:4318.79 Median:4854.72 stddev:1230.35 (25.3%) stddev-sans-first:1196.81 13:14:34 INFO - PROCESS | 3578 | Values: 329.1 341.8 349.6 350.0 352.3 4888.3 4940.8 4974.0 5099.3 5101.6 4792.9 4895.0 4909.7 4909.9 4921.4 4015.3 4015.8 4023.4 4043.5 4061.9 3886.9 4016.9 4024.7 4033.6 4046.1 3936.0 3944.8 3948.2 3948.4 3949.5 3924.9 3934.7 3943.1 3947.3 3972.7 3567.6 3577.3 3600.2 3605.3 3605.8 4660.0 4790.9 4844.4 4868.7 4874.9 4544.9 4558.3 4558.9 4572.8 4592.2 5161.7 5176.0 5210.9 5217.4 5226.7 3732.7 3885.7 3896.4 3899.5 3906.2 5389.2 5389.2 5406.6 5417.9 5432.0 3997.2 4011.4 4030.3 4040.8 4046.9 4018.7 4047.9 4073.7 4082.3 4084.7 4102.8 4298.9 4310.6 4312.8 4337.8 5180.8 5187.0 5200.1 5204.9 5246.2 1248.9 1264.9 1275.8 1279.4 1287.7 859.2 868.2 870.1 877.1 885.9 4360.7 4387.7 4407.3 4411.2 4424.8 5195.0 5200.5 5211.2 5223.6 5238.3 4419.0 4441.3 4444.0 4448.0 4463.8 2652.5 2760.5 2780.4 2781.4 2785.3 4850.6 4853.6 4855.8 4871.6 4883.3 5060.3 5320.7 5333.9 5344.1 5351.7 4759.0 4761.3 4766.7 4780.8 4785.4 5149.9 5171.3 5202.7 5205.6 5216.0 4974.3 5079.4 5101.0 5111.5 5153.3 4959.5 4960.7 4972.0 4979.0 4996.6 3706.6 3747.6 3766.4 3774.5 3777.8 5207.3 5367.9 5466.2 5486.4 5515.6 5232.6 5234.8 5261.8 5273.8 5281.7 5225.3 5234.6 5237.4 5273.5 5291.9 4889.6 5139.0 5191.5 5200.8 5219.9 5235.7 5242.4 5243.6 5249.0 5253.9 5139.5 5159.5 5169.8 5180.4 5180.5 13:14:34 INFO - PROCESS | 3578 | 13:14:34 INFO - PROCESS | 3578 | [#5] yui.html Cycles:180 Average:15020.07 Median:26280.85 stddev:18894.40 (71.9%) stddev-sans-first:18916.59 13:14:34 INFO - PROCESS | 3578 | Values: 648.3 655.0 724.1 744.3 757.6 11904.3 12822.7 13217.5 13294.3 13405.9 12661.7 12780.4 12783.8 12793.1 12924.6 788.0 789.6 807.9 809.1 809.5 784.6 805.8 809.2 809.2 809.6 855.8 856.0 857.6 857.7 859.3 843.8 849.2 849.5 849.5 850.3 620.3 620.8 621.7 621.7 623.7 13744.4 13819.2 14305.8 14507.8 14510.3 10127.0 12847.6 13684.9 13878.2 13930.0 11452.5 12035.2 12227.8 12300.4 12376.7 4113.9 4156.4 4160.8 4163.8 4224.1 64796.0 65092.0 65181.7 65828.3 66358.0 9969.5 10255.4 10417.3 10433.7 10475.2 18195.5 19160.9 19451.3 19554.2 19708.3 6845.4 6994.8 7015.3 7025.5 7181.9 3608.3 3669.7 3676.7 3756.3 3776.3 2876.1 2930.2 2932.1 2942.5 2952.9 480.8 483.8 495.2 521.6 548.5 582.8 607.1 607.8 616.1 618.0 8029.7 8190.5 8246.5 8269.3 8553.3 613.1 629.5 634.4 640.3 645.7 3795.0 3997.0 4007.7 4018.9 4091.3 66037.7 67943.7 68561.0 68937.0 69027.3 56859.4 58275.1 58358.1 59284.1 60839.0 52066.5 52156.0 52167.7 52679.7 53063.2 7479.4 7562.7 7570.7 7627.2 7641.8 35905.3 37056.8 37445.1 37892.8 38309.8 34448.7 46807.5 46926.0 47005.0 47099.5 9683.4 9699.8 9727.6 9865.1 10326.8 11087.1 11141.3 11355.9 11370.4 11445.1 10055.1 11235.9 11513.7 12320.3 12711.0 11126.6 11334.2 11768.8 12063.0 12076.9 11170.6 11189.4 11695.1 11956.3 12030.5 9483.4 9495.6 10073.5 10348.9 10576.2 9576.2 9855.8 9944.2 9958.1 9987.6 13:14:34 INFO - PROCESS | 3578 | -------- Summary: end -------- 13:14:34 INFO - PROCESS | 3578 | 13:14:35 INFO - TEST-INFO | 3578: exit 0 13:14:35 INFO - TEST-OK | dromaeo_css | took 1119142ms 13:14:35 INFO - TEST-START | kraken 13:14:35 INFO - operating with platform_type : linux_ 13:14:35 INFO - Initialising browser for kraken test... 13:14:35 INFO - TEST-INFO | started process 3927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpshJ7wL/profile http://localhost:44508/getInfo.html) 13:14:35 INFO - PROCESS | 3927 | 1483046075581 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 13:14:39 INFO - PROCESS | 3927 | __metrics Screen width/height:1600/1200 13:14:39 INFO - PROCESS | 3927 | colorDepth:24 13:14:39 INFO - PROCESS | 3927 | Browser inner width/height: 1024/697 13:14:39 INFO - PROCESS | 3927 | __metrics 13:14:40 ERROR - PROCESS | 3927 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 13:14:41 INFO - TEST-INFO | 3927: exit 0 13:14:41 INFO - Browser initialized. 13:14:41 INFO - Running cycle 1/1 for kraken test... 13:14:41 INFO - TEST-INFO | started process 4048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpshJ7wL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:14:53 INFO - PROCESS | 4048 | RSS: Main: 158453760 13:14:53 INFO - PROCESS | 4048 | 13:14:56 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:44508/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44508/tests/kraken/driver.html?testName=audio-beat-detection) 13:14:57 INFO - PROCESS | 4048 | RSS: Main: 164597760 13:14:57 INFO - PROCESS | 4048 | 13:14:59 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:44508/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44508/tests/kraken/driver.html?testName=audio-dft) 13:15:00 INFO - PROCESS | 4048 | RSS: Main: 162816000 13:15:00 INFO - PROCESS | 4048 | 13:15:03 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:44508/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44508/tests/kraken/driver.html?testName=audio-fft) 13:15:04 INFO - PROCESS | 4048 | RSS: Main: 159596544 13:15:04 INFO - PROCESS | 4048 | 13:15:06 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:44508/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44508/tests/kraken/driver.html?testName=audio-oscillator) 13:15:06 INFO - PROCESS | 4048 | RSS: Main: 160481280 13:15:06 INFO - PROCESS | 4048 | 13:15:09 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:44508/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44508/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:15:09 INFO - PROCESS | 4048 | RSS: Main: 161038336 13:15:09 INFO - PROCESS | 4048 | 13:15:12 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:44508/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44508/tests/kraken/driver.html?testName=imaging-darkroom) 13:15:13 INFO - PROCESS | 4048 | RSS: Main: 165261312 13:15:13 INFO - PROCESS | 4048 | 13:15:16 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:44508/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44508/tests/kraken/driver.html?testName=imaging-desaturate) 13:15:17 INFO - PROCESS | 4048 | RSS: Main: 161734656 13:15:17 INFO - PROCESS | 4048 | 13:15:20 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:44508/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44508/tests/kraken/driver.html?testName=json-parse-financial) 13:15:21 INFO - PROCESS | 4048 | RSS: Main: 163237888 13:15:21 INFO - PROCESS | 4048 | 13:15:22 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:44508/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44508/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:15:23 INFO - PROCESS | 4048 | RSS: Main: 163434496 13:15:23 INFO - PROCESS | 4048 | 13:15:25 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:44508/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44508/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:15:26 INFO - PROCESS | 4048 | RSS: Main: 163123200 13:15:26 INFO - PROCESS | 4048 | 13:15:28 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:44508/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44508/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:15:28 INFO - PROCESS | 4048 | RSS: Main: 164261888 13:15:28 INFO - PROCESS | 4048 | 13:15:31 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:44508/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44508/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:15:32 INFO - PROCESS | 4048 | RSS: Main: 164585472 13:15:32 INFO - PROCESS | 4048 | 13:15:35 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:44508/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44508/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:15:36 INFO - PROCESS | 4048 | RSS: Main: 164524032 13:15:36 INFO - PROCESS | 4048 | 13:15:37 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:44508/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44508/tests/kraken/driver.html?testName=ai-astar) 13:15:38 INFO - PROCESS | 4048 | RSS: Main: 165654528 13:15:38 INFO - PROCESS | 4048 | 13:15:38 INFO - PROCESS | 4048 | __start_tp_report 13:15:38 INFO - PROCESS | 4048 | _x_x_mozilla_page_load 13:15:38 INFO - PROCESS | 4048 | _x_x_mozilla_page_load_details 13:15:38 INFO - PROCESS | 4048 | |i|pagename|runs| 13:15:38 INFO - PROCESS | 4048 | |0;ai-astar;108;115;115;114;115;115;117;116;115;116 13:15:38 INFO - PROCESS | 4048 | |1;audio-beat-detection;158;127;135;167;131;131;131;128;155;133 13:15:38 INFO - PROCESS | 4048 | |2;audio-dft;166;166;177;167;163;166;165;163;164;165 13:15:38 INFO - PROCESS | 4048 | |3;audio-fft;78;77;77;105;78;77;76;77;105;78 13:15:38 INFO - PROCESS | 4048 | |4;audio-oscillator;85;86;107;91;86;85;99;86;86;105 13:15:38 INFO - PROCESS | 4048 | |5;imaging-gaussian-blur;118;118;118;118;118;121;118;120;118;118 13:15:38 INFO - PROCESS | 4048 | |6;imaging-darkroom;152;151;152;154;151;152;152;152;150;150 13:15:38 INFO - PROCESS | 4048 | |7;imaging-desaturate;96;95;97;97;96;96;97;96;96;97 13:15:38 INFO - PROCESS | 4048 | |8;json-parse-financial;72;72;72;71;72;82;71;72;73;73 13:15:38 INFO - PROCESS | 4048 | |9;json-stringify-tinderbox;68;68;67;67;69;68;68;67;68;68 13:15:38 INFO - PROCESS | 4048 | |10;stanford-crypto-aes;86;92;86;88;95;85;88;85;86;91 13:15:38 INFO - PROCESS | 4048 | |11;stanford-crypto-ccm;139;135;145;135;143;134;144;135;182;135 13:15:38 INFO - PROCESS | 4048 | |12;stanford-crypto-pbkdf2;180;180;178;180;175;175;180;175;183;182 13:15:38 INFO - PROCESS | 4048 | |13;stanford-crypto-sha256-iterative;72;71;71;72;70;69;74;71;71;73 13:15:38 INFO - PROCESS | 4048 | __end_tp_report 13:15:38 INFO - PROCESS | 4048 | __start_cc_report 13:15:38 INFO - PROCESS | 4048 | _x_x_mozilla_cycle_collect,812 13:15:38 INFO - PROCESS | 4048 | __end_cc_report 13:15:38 INFO - PROCESS | 4048 | __startTimestamp1483046138246__endTimestamp 13:15:38 INFO - PROCESS | 4048 | 13:15:38 INFO - PROCESS | 4048 | ------- Summary: start ------- 13:15:38 INFO - PROCESS | 4048 | Number of tests: 14 13:15:38 INFO - PROCESS | 4048 | 13:15:38 INFO - PROCESS | 4048 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:2.46 (2.1%) stddev-sans-first:0.87 13:15:38 INFO - PROCESS | 4048 | Values: 108.0 115.0 115.0 114.0 115.0 115.0 117.0 116.0 115.0 116.0 13:15:38 INFO - PROCESS | 4048 | 13:15:38 INFO - PROCESS | 4048 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:134.00 stddev:14.55 (10.9%) stddev-sans-first:13.83 13:15:38 INFO - PROCESS | 4048 | Values: 158.0 127.0 135.0 167.0 131.0 131.0 131.0 128.0 155.0 133.0 13:15:38 INFO - PROCESS | 4048 | 13:15:38 INFO - PROCESS | 4048 | [#2] audio-dft Cycles:10 Average:166.20 Median:166.00 stddev:4.02 (2.4%) stddev-sans-first:4.27 13:15:38 INFO - PROCESS | 4048 | Values: 166.0 166.0 177.0 167.0 163.0 166.0 165.0 163.0 164.0 165.0 13:15:38 INFO - PROCESS | 4048 | 13:15:38 INFO - PROCESS | 4048 | [#3] audio-fft Cycles:10 Average:82.80 Median:77.00 stddev:11.72 (15.2%) stddev-sans-first:12.30 13:15:38 INFO - PROCESS | 4048 | Values: 78.0 77.0 77.0 105.0 78.0 77.0 76.0 77.0 105.0 78.0 13:15:38 INFO - PROCESS | 4048 | 13:15:38 INFO - PROCESS | 4048 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:86.00 stddev:8.72 (10.1%) stddev-sans-first:8.92 13:15:38 INFO - PROCESS | 4048 | Values: 85.0 86.0 107.0 91.0 86.0 85.0 99.0 86.0 86.0 105.0 13:15:38 INFO - PROCESS | 4048 | 13:15:38 INFO - PROCESS | 4048 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.00 stddev:1.08 (0.9%) stddev-sans-first:1.13 13:15:38 INFO - PROCESS | 4048 | Values: 118.0 118.0 118.0 118.0 118.0 121.0 118.0 120.0 118.0 118.0 13:15:38 INFO - PROCESS | 4048 | 13:15:38 INFO - PROCESS | 4048 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:152.00 stddev:1.17 (0.8%) stddev-sans-first:1.24 13:15:38 INFO - PROCESS | 4048 | Values: 152.0 151.0 152.0 154.0 151.0 152.0 152.0 152.0 150.0 150.0 13:15:38 INFO - PROCESS | 4048 | 13:15:38 INFO - PROCESS | 4048 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 13:15:38 INFO - PROCESS | 4048 | Values: 96.0 95.0 97.0 97.0 96.0 96.0 97.0 96.0 96.0 97.0 13:15:38 INFO - PROCESS | 4048 | 13:15:38 INFO - PROCESS | 4048 | [#8] json-parse-financial Cycles:10 Average:73.00 Median:72.00 stddev:3.23 (4.5%) stddev-sans-first:3.41 13:15:38 INFO - PROCESS | 4048 | Values: 72.0 72.0 72.0 71.0 72.0 82.0 71.0 72.0 73.0 73.0 13:15:38 INFO - PROCESS | 4048 | 13:15:38 INFO - PROCESS | 4048 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 13:15:38 INFO - PROCESS | 4048 | Values: 68.0 68.0 67.0 67.0 69.0 68.0 68.0 67.0 68.0 68.0 13:15:38 INFO - PROCESS | 4048 | 13:15:38 INFO - PROCESS | 4048 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:88.00 stddev:3.39 (3.9%) stddev-sans-first:3.50 13:15:38 INFO - PROCESS | 4048 | Values: 86.0 92.0 86.0 88.0 95.0 85.0 88.0 85.0 86.0 91.0 13:15:38 INFO - PROCESS | 4048 | 13:15:38 INFO - PROCESS | 4048 | [#11] stanford-crypto-ccm Cycles:10 Average:142.70 Median:141.00 stddev:14.45 (10.2%) stddev-sans-first:15.26 13:15:38 INFO - PROCESS | 4048 | Values: 139.0 135.0 145.0 135.0 143.0 134.0 144.0 135.0 182.0 135.0 13:15:38 INFO - PROCESS | 4048 | 13:15:38 INFO - PROCESS | 4048 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:180.00 stddev:2.94 (1.6%) stddev-sans-first:3.08 13:15:38 INFO - PROCESS | 4048 | Values: 180.0 180.0 178.0 180.0 175.0 175.0 180.0 175.0 183.0 182.0 13:15:38 INFO - PROCESS | 4048 | 13:15:38 INFO - PROCESS | 4048 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.50 stddev:1.43 (2.0%) stddev-sans-first:1.50 13:15:38 INFO - PROCESS | 4048 | Values: 72.0 71.0 71.0 72.0 70.0 69.0 74.0 71.0 71.0 73.0 13:15:38 INFO - PROCESS | 4048 | -------- Summary: end -------- 13:15:38 INFO - PROCESS | 4048 | 13:15:39 INFO - TEST-INFO | 4048: exit 0 13:15:39 INFO - TEST-OK | kraken | took 64292ms 13:15:39 INFO - SUITE-END | took 1183s 13:15:39 INFO - Completed test suite (00:19:43) 13:15:39 INFO - javascript benchmark 13:15:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6235.243512583294, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2580.600006998915, 2588.1329754532253, 2590.9093181738644, 2611.6865976082872, 2613.1899111275507, 4637.513061128583, 4802.015586804705, 4810.06203790261, 4825.831095911643, 4830.468648448667, 4695.3191787190835, 4750.0, 4772.90454190916, 4779.952200477994, 4798.088363210987, 4405.074934263808, 4420.491643461003, 4491.820327186909, 4538.500764915857, 4588.082383523292, 4425.358323043157, 4452.888677783049, 4470.038941627549, 4501.167284052461, 4503.4145561077175, 4313.568643135693, 4315.568443155659, 4320.9135817283795, 4360.1279744051, 4404.119176164748, 4348.043430445328, 4374.868753937387, 4381.75900325482, 4387.890302742425, 4389.4513185851765, 4299.892502687427, 4361.476622805252, 4386.934195987063, 4417.911641767147, 4418.403515525395, 4728.0, 4729.330879544445, 4731.030138821533, 4731.574158325767, 4748.667593268473, 4924.187509061001, 4966.453690094087, 5109.054824857413, 5125.589952803767, 5152.9484705152845, 5018.47306032865, 5060.797568097271, 5063.620228482879, 5124.103281925648, 5150.407703114115, 4716.3868697069165, 4757.35775670287, 4757.429108506966, 4758.595519380857, 4808.422989241313, 5138.640295179302, 5167.715775632301, 5205.141151710001, 5210.557102646242, 5229.712365819841, 4836.782344794493, 4878.926816097762, 4942.085714142895, 4957.529034741766, 4962.230854217602, 4880.463149053601, 4954.47977962316, 5054.317667114892, 5069.847904562869, 5133.050385678662, 4992.226204938241, 4996.100701873697, 5047.899042019212, 5067.949320506747, 5115.97442012795, 4910.017996400734, 5090.236464530276, 5096.082705113041, 5112.4120726116225, 5157.510036546522, 4247.723897946624, 4298.806553705091, 4301.806418711103, 4303.655707543389, 4371.803268852909, 3735.831887565066, 3759.774413535197, 3762.9247415051545, 3774.7168962327387, 3804.885853424402, 4340.088581397878, 4353.869383918487, 4376.452943382077, 4377.584129507692, 4423.049044455457, 5010.273510341053, 5052.57053150479, 5070.771815268322, 5115.951229997841, 5162.199859021857, 4390.736555806662, 4407.405000324915, 4408.030233348658, 4448.243798554254, 4449.3326001100095, 4636.095961287517, 4646.442426908792, 4647.16351056813, 4656.930146047812, 4700.576948074689, 4640.559146881041, 4693.483716791218, 4726.432828060655, 4744.857654270378, 4825.541573550507, 5138.049460849755, 5143.228515722672, 5164.612654050886, 5204.0, 5226.555742761908, 4759.762011899322, 4775.474697783172, 4783.6412269079265, 4792.856214313576, 4818.783154757974, 4925.064237794808, 4980.427250866197, 5015.448300686994, 5038.697678139323, 5078.08594453002, 5094.6688465249645, 5166.3800343958965, 5178.43037265908, 5226.608004399762, 5243.5542978847225, 5004.149294619996, 5022.824201152942, 5025.648204625787, 5041.218611115283, 5079.44126146131, 4847.3698419205275, 4862.343583616308, 4876.414830220397, 4912.263160525949, 4950.653454258168, 4716.363290955677, 4865.0756356292195, 4897.632677549127, 4955.231939049453, 4961.404631444249, 5040.7479626019285, 5056.519630635084, 5060.620453465931, 5093.567046801063, 5117.488251174853, 4923.876903077308, 4941.97529012367, 4953.578945789648, 4958.404991401055, 4975.825846095369], "value": 4675.7194998578825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.30462570903575, 523.7826302084635, 527.1828665568371, 527.9208118782183, 533.8558589180918, 36687.81656091719, 38777.22445551091, 38838.805805970966, 42501.57498425015, 42550.36174457386, 39020.414693779545, 39344.60655393452, 39400.40899386504, 39532.80233598828, 39537.60462395375, 7628.084629844427, 7811.4922530035365, 7814.882776758353, 7839.098503672065, 9350.25197984163, 9227.077292270786, 9634.614615415376, 9637.807243855119, 9645.987171347013, 9655.937846836843, 9641.951790241039, 9653.951730241373, 9688.418694878295, 9692.321537492378, 9703.514824258795, 9571.760705982337, 9613.759656008586, 9632.903670963271, 9637.71086867395, 9643.90356096437, 9449.102335278207, 9578.760530986712, 9579.856302155473, 9586.233101351874, 9597.664081757104, 32726.345473090405, 32755.50866737001, 32845.34309313824, 32855.6714432855, 32925.83537082299, 3519.9472007919903, 3641.362761516724, 3666.5600127984544, 3687.7418580699364, 3688.2254726507467, 24726.381840453952, 24841.62737558938, 25384.492310153877, 25520.234392968054, 25651.102211422698, 3431.7940923544415, 3433.0902310887636, 3449.379111759882, 3453.689167974869, 3466.2894106708063, 225651.0, 227189.0, 227439.0, 228105.0, 229063.0, 45317.77341113339, 45359.0, 45379.09241815145, 45482.72276435821, 45623.31565026527, 47412.288815667795, 47606.76196619064, 47619.76190119027, 47630.76184619124, 47665.76167119142, 13266.137701049402, 13795.586132416043, 13810.309484525733, 13811.930940345233, 13834.100783449245, 9753.268504862164, 9988.700338989842, 10119.0, 10322.535485903152, 10679.733006674895, 14972.326245318987, 15048.699026019638, 15121.546353609408, 15347.616309592126, 15381.692366152614, 6185.876282474325, 6461.450776683941, 6562.507811914125, 6592.571482853695, 6592.637404942774, 697.1773307497202, 697.8415829722737, 710.7638474690797, 726.2700985509634, 733.2191216354565, 26242.868785655948, 27214.591781123298, 27596.172114836587, 27701.861490692416, 27725.445491090064, 885.8892638420198, 901.4540063790499, 901.7655409593422, 923.7275003873873, 930.6742640075919, 13640.931795340959, 14511.492097776527, 14521.78217326741, 14719.190444525653, 14820.184889830947, 315266.0, 316968.0, 318154.0, 318311.0, 318818.0, 48581.0, 49054.26418603724, 49079.0, 49097.50902491001, 49448.75275623671, 1129.5312445335258, 1139.32779660001, 1171.8769529199483, 1176.2883455509464, 1176.3236139219812, 24103.44930210413, 25175.24474265775, 26565.0, 26689.33276668021, 26765.86617066902, 40536.59463405446, 40782.1843563133, 40870.59129408668, 40873.591264088165, 40884.79557602193, 264371.0, 264959.0, 266116.0, 267411.0, 268030.0, 21081.6837747437, 21683.34949951504, 21804.236851710113, 22901.0, 22951.6557251638, 35395.64604353924, 35895.28209435744, 36581.08547286232, 36720.449193261586, 37009.44485832768, 30286.54570181493, 30484.390312194075, 30943.226419339695, 30966.22584435407, 31875.68124318727, 30770.0, 31080.22299442532, 31131.0, 31419.52870706987, 32023.03930882077, 30298.545521816748, 30325.241868953453, 30428.0, 30465.54301685432, 31114.844425777726, 26151.17853698561, 28608.57087143736, 28754.568681469376, 28913.42173156567, 29239.415211696072, 21775.346739597837, 21848.890755546756, 21994.89002555041, 22001.11995520161, 22088.0], "value": 16554.422117988204, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.2974200309396, 366.92294618130194, 371.38721110168217, 379.3778203745857, 384.348529242933, 15418.61453463664, 16452.670946581075, 16476.340946362132, 16635.0, 16642.417515386966, 15761.842381576182, 15788.763168552481, 15926.442574509894, 16135.515934521954, 16194.838051619481, 4893.070316639845, 5065.518775716301, 5104.33643626328, 5115.258287548303, 5125.1287281162295, 4989.101961646902, 5034.974825125869, 5328.973355133219, 5345.946540534604, 5393.217983392406, 5361.785528578872, 5372.059889519319, 5374.328208973879, 5379.38137114231, 5383.623146379755, 5248.947510524903, 5338.3060202173665, 5555.166724991263, 5567.387587365387, 5596.188552659883, 5342.27879236302, 5351.277577527023, 5361.410244873061, 5376.865578360573, 5396.514313711746, 19494.902525487425, 19565.0, 19955.401337959884, 20044.69932951007, 20067.498312542157, 2327.3483424641126, 2434.379233295516, 2453.6932883389577, 2469.5678256305073, 2490.066225165563, 8865.734027979172, 8877.289816814638, 9084.50035248061, 9390.248780097576, 9427.34008619397, 1662.8669706423457, 1711.3069206971072, 1711.8972861628342, 1745.0576688588146, 1757.5606098475382, 63798.0, 65000.99999999953, 65247.67376163089, 65880.6705966472, 66207.3379266206, 9563.474008929576, 9697.127258546765, 9890.357126786736, 9934.105930466292, 10057.396556206651, 13572.728545429234, 13603.115797473132, 13603.863961360457, 13620.795688064687, 13626.318684065756, 7015.89476157858, 7110.537815042006, 7255.45584081196, 7280.635968201569, 7372.668229929559, 6782.93217067823, 6856.725730970805, 7010.439164866799, 7023.964880175567, 7024.262452442522, 4171.311733563928, 4284.078923031563, 4297.484301883794, 4300.956990430118, 4344.847930322424, 1705.6503416799526, 1751.9474415767547, 1787.294018862542, 1849.5838436351983, 1878.5209771508178, 873.5021038008401, 898.5641963647626, 899.150302963693, 913.164454524103, 914.8170365926841, 14701.55895323142, 14981.176035317943, 15485.922570387076, 16008.11955342444, 16188.595285117966, 863.7408777366765, 874.6807415293372, 878.4904755241944, 886.0563499872615, 916.3356566489375, 8780.165884240987, 8899.644014239488, 9028.18746312835, 9069.909300907038, 9278.536073196314, 309363.0, 310279.0, 310416.0, 316865.0, 324668.0, 72893.27106728971, 73240.63379683068, 75688.62155689186, 77433.2256677426, 77954.6102269485, 909.913558211982, 930.6137952749668, 934.2152591822901, 947.265868951568, 952.2096659772511, 13748.381322840696, 13754.174749515061, 13868.4452621894, 13947.302634868012, 14591.708165836837, 34938.47592286169, 35059.0, 35582.11044723903, 35808.0, 35999.82000090087, 46852.7657361711, 46965.53034469748, 47163.0, 47334.76332618315, 49078.0, 4951.405831300123, 5053.191489361684, 7461.253874612496, 7700.4224683150105, 7965.402594805529, 9989.60041598328, 11001.284916480403, 11191.0, 11636.12729045342, 11657.53369865196, 9832.852507212254, 9963.850542241727, 10088.495575221357, 10121.0, 10224.948875255575, 9474.0, 9888.307818452638, 10117.0, 10424.68725938223, 10494.055535001886, 9282.860757088514, 9309.581068852054, 9514.571844266886, 10068.24488163376, 10232.232582556488, 7515.962420187864, 7537.924620753723, 7545.50954187976, 7787.8831817523915, 7849.136594974662, 7259.564426134449, 8343.374246931384, 9395.24838012971, 9561.139497445263, 9801.75495612587], "value": 7976.28545174997, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.5322407321325, 1301.6615679923218, 1312.612779230127, 1313.1989486413293, 1313.750387426389, 6183.567150299481, 6377.107204991305, 6798.830029249271, 7165.749198778044, 7172.533785303952, 6949.0, 7192.280771922805, 7217.06178196835, 7356.374708149814, 7371.520851144672, 2119.7774233705472, 2138.123369418539, 2161.708169397135, 2164.8592841465334, 2165.252987719234, 2084.062172022588, 2109.24067335759, 2119.14174759222, 2142.507223338633, 2164.491344534033, 2015.5364266218778, 2033.2578608807826, 2037.0731317250616, 2039.51051747581, 2046.8976551172457, 2026.2705426046612, 2046.58045100754, 2053.3429302623167, 2064.411642681836, 2076.9376918692387, 2046.069038587439, 2067.80355866194, 2089.937301880946, 2112.8837913914726, 2138.5829763196184, 7223.530470519399, 7323.890141647879, 7355.5586664800285, 7391.22392148822, 7399.075115610549, 4395.120975804852, 4507.143642707875, 4519.435070616173, 4525.411696479437, 4530.728156310632, 2774.9306267343277, 2824.7598954088926, 2878.4962631539397, 2889.942201155965, 2891.3783536539536, 1042.723678225271, 1050.453764042701, 1069.0859315285475, 1080.4651697409754, 1090.1061129873508, 9237.261019118454, 9238.676646317346, 9286.535673216313, 9296.442213467146, 9360.95319523398, 3762.4415397529397, 3807.0, 3822.445745366906, 3866.0528170597822, 3898.317794385971, 7678.923210767933, 7695.92304076952, 7706.961465192639, 7712.922870771333, 7742.225777422325, 4366.454193225847, 4374.475062992461, 4381.868543943687, 4382.517923028464, 4384.846530371486, 4033.153037862023, 4098.590140985878, 4118.320477121241, 4143.709940304149, 4154.480689913761, 3138.764592655514, 3211.325621619486, 3296.0770984124483, 3329.617094034217, 3349.2129349602824, 877.8024944387462, 913.8400779863497, 930.972070837876, 934.8036912248368, 943.9244860411151, 739.7706710919632, 766.651173715958, 774.7598244544209, 781.5779479081347, 786.8741001439856, 4432.645388368923, 4669.766511674403, 4683.414573178353, 4811.182099043171, 4827.589654879304, 767.1867820110589, 811.7199566149669, 812.2608426332009, 812.9674813007414, 817.8200795824908, 2976.5683975823817, 3094.5667606535103, 3122.406742718876, 3153.353562519678, 3259.837008149583, 8323.542205178652, 8496.660133594587, 8599.871001934976, 8612.741617751477, 8623.913760862437, 8458.196471335214, 8475.152484751476, 8488.151184881586, 8498.277646400002, 8508.234258916727, 6813.1142951415995, 6916.654167291716, 6951.6871740771785, 6960.37356637905, 6968.965155174192, 4495.325701144854, 4603.6777425579885, 4644.954885150814, 4672.74299913508, 4675.859724208279, 7990.440669153336, 7990.880136797837, 8091.393145513992, 8114.229148230908, 8157.836843262983, 7638.847223055619, 7784.455088143775, 7848.332891704269, 8052.798680033046, 8207.876881846896, 6074.210352654127, 6097.908531371944, 6116.082587611894, 6154.5384096192065, 6157.384261573807, 6903.1371078615175, 6944.062551555476, 6951.826204344932, 6979.232284448605, 6983.615901125487, 6217.689115544114, 6298.559100862895, 6325.399087086719, 6389.2652344980925, 6435.646039467687, 6222.62664240147, 6293.905591416041, 6317.30509643948, 6360.268569114611, 6455.935440645533, 5279.128943724242, 5351.143816989263, 5351.866203344947, 5362.785488580413, 5363.463653634762, 3950.229705207457, 3951.545572259227, 3999.8400063997115, 4024.295748243987, 4101.282275601818, 3913.25648126855, 3918.0792513758674, 3970.3647416413237, 3985.7807820568987, 4017.8593749218635], "value": 3797.854588080659, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.14586647649355, 341.7641827139274, 349.64685667475874, 349.98250087495626, 352.2567382822243, 4888.289098815413, 4940.827071052514, 4973.975130124349, 5099.286099946006, 5101.591872650193, 4792.90414191716, 4894.975525122379, 4909.656324057309, 4909.877253068675, 4921.400544822938, 4015.2571774221715, 4015.7791321477307, 4023.376376661615, 4043.5147782266167, 4061.8578349757763, 3886.9222615547674, 4016.9397459038137, 4024.738392004525, 4033.556308806029, 4046.1300820323627, 3935.9803200984097, 3944.8027598620097, 3948.2300951314505, 3948.4077388391684, 3949.486566746333, 3924.862629807957, 3934.7245692801516, 3943.073377756225, 3947.2894878921784, 3972.6623237024887, 3567.571891373052, 3577.3203091412806, 3600.1539638185004, 3605.3235245610917, 3605.7836529808033, 4659.976700116477, 4790.880227994293, 4844.37023186987, 4868.659193856432, 4874.926876096862, 4544.932055914551, 4558.270676691714, 4558.8632341029825, 4572.771361431948, 4592.196365636, 5161.690298582097, 5175.974120129413, 5210.921836172461, 5217.399999000126, 5226.712530810804, 3732.6547888376886, 3885.7279990400684, 3896.376579747255, 3899.53205615328, 3906.2187562487334, 5389.221556886218, 5389.245505629215, 5406.648567843077, 5417.864553386157, 5431.972840135813, 3997.1605962747567, 4011.4183443400543, 4030.2544029354663, 4040.7575545467366, 4046.919061618751, 4018.6584140347813, 4047.919041619151, 4073.6944729145434, 4082.285440115159, 4084.6936479764136, 4102.774347410861, 4298.914021719611, 4310.612044915973, 4312.805923733439, 4337.783110844445, 5180.813799513272, 5187.0, 5200.115980283285, 5204.947950520522, 5246.213068039825, 1248.9000879929583, 1264.8988080953502, 1275.8022506511506, 1279.3986826191674, 1287.7102651903247, 859.2181115185151, 868.2055918834322, 870.0864092702637, 877.1447838357678, 885.9246964008131, 4360.71655342408, 4387.714798538085, 4407.2507673695545, 4411.205982923105, 4424.823007079745, 5194.97402512985, 5200.479952004769, 5211.2443695663915, 5223.555997740159, 5238.266642670029, 4419.0, 4441.333799930037, 4444.0002997976235, 4447.977760111179, 4463.808377010453, 2652.469506098788, 2760.5169095408223, 2780.402213524102, 2781.3602871339704, 2785.3454438207004, 4850.563449289581, 4853.616719235001, 4855.830045948375, 4871.634627402888, 4883.316335713003, 5060.316857224301, 5320.669832541865, 5333.86665333362, 5344.144936810092, 5351.678899266057, 4758.976205118952, 4761.333413322138, 4766.666333356632, 4780.760961951889, 4785.425748910084, 5149.9227511586605, 5171.276021356938, 5202.687838729688, 5205.609579281493, 5215.973920130375, 4974.278729584118, 5079.415867175175, 5101.01060586379, 5111.539961403343, 5153.278541004187, 4959.454460009469, 4960.652754307164, 4971.9502804972935, 4978.950210497848, 4996.575291100152, 3706.5922748497105, 3747.587765345755, 3766.3785475396253, 3774.5281839770028, 3777.807752449176, 5207.3230480037355, 5367.892642147213, 5466.207399926909, 5486.369067557282, 5515.586331025109, 5232.607554433356, 5234.816781412632, 5261.8423946731655, 5273.815416460406, 5281.683099014072, 5225.268462415341, 5234.612827600765, 5237.371515418175, 5273.472652734849, 5291.920621190762, 4889.584385327287, 5139.023585518889, 5191.454897235736, 5200.791968321225, 5219.869503262449, 5235.685858848481, 5242.449542797951, 5243.5542978847225, 5249.002689488985, 5253.896681696887, 5139.537441630271, 5159.477954003653, 5169.844904652867, 5180.425506400572, 5180.456052114474], "value": 3932.9520129968687, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.2804087462915, 654.9541532092755, 724.0840336973725, 744.2854859335038, 757.6059254539662, 11904.345261010641, 12822.743545129091, 13217.471301147954, 13294.335283235823, 13405.865941340584, 12661.746765064694, 12780.36098195089, 12783.808242876365, 12793.104482686216, 12924.612261632166, 787.9606019699021, 789.5775759968418, 807.9394045446586, 809.1221025187679, 809.4778867630375, 784.5959330944568, 805.7663277649475, 809.1786836361098, 809.2393150438598, 809.5790189101664, 855.8288342331527, 856.0241324889631, 857.5626430520448, 857.7341024282462, 859.3211363023204, 843.8312337532518, 849.2229609906927, 849.4860609331358, 849.4945507423073, 850.345234169692, 620.2742790934617, 620.761007012299, 621.7264403662374, 621.7481919822479, 623.688155922039, 13744.381502832397, 13819.239941803196, 14305.785413218706, 14507.782383264259, 14510.274486275644, 10127.0, 12847.614571562868, 13684.93157534216, 13878.236696981661, 13929.955253356038, 11452.541898324058, 12035.217710848767, 12227.816582751266, 12300.384980751016, 12376.690582735413, 4113.91772164558, 4156.355764856452, 4160.83356665733, 4163.770992595406, 4224.070704445017, 64796.0, 65092.0, 65181.67409162971, 65828.3417165827, 66358.0, 9969.501524923724, 10255.384676919408, 10417.270791044706, 10433.686989390331, 10475.16198704117, 18195.45413637593, 19160.904195479212, 19451.31920382808, 19554.217831286875, 19708.31020914261, 6845.383915447534, 6994.790156295319, 7015.298470152944, 7025.498004006904, 7181.928180718231, 3608.332458495187, 3669.6697297243377, 3676.6690997810324, 3756.286305601927, 3776.339140650375, 2876.0652787843615, 2930.1502564256125, 2932.1057077591113, 2942.47035533606, 2952.926176845553, 480.8389189621446, 483.82582270382636, 495.21508409171145, 521.5905514171358, 548.506344290142, 582.8164128299572, 607.1499900139839, 607.8389226854798, 616.1066453642147, 617.9691015449209, 8029.678812847537, 8190.549519776469, 8246.505209687439, 8269.338452923752, 8553.315734741205, 613.12629502959, 629.4932579273637, 634.4321831960461, 640.2604991235131, 645.6965226343611, 3794.962050379516, 3996.980015099906, 4007.7394969327484, 4018.859339923147, 4091.3044782387065, 66037.66981165063, 67943.66028169828, 68561.0, 68937.0, 69027.3097269031, 56859.43140568624, 58275.12587311194, 58358.12462813061, 59284.11073833896, 60839.0, 52066.47933520616, 52156.0, 52167.73916130471, 52679.73660131675, 53063.204051939254, 7479.36425403825, 7562.697492100255, 7570.659320330708, 7627.161012288533, 7641.808954775953, 35905.28189436249, 37056.814715926244, 37445.12774361217, 37892.810535947145, 38309.808450957564, 34448.655513444544, 46807.53192468032, 46926.0, 47005.0, 47099.52900471089, 9683.41899486033, 9699.806003880023, 9727.562259698188, 9865.06281903218, 10326.845097323396, 11087.113030957666, 11141.331520108819, 11355.943220284176, 11370.374629395463, 11445.084393248353, 10055.095041446304, 11235.88764112381, 11513.712157196138, 12320.260784352968, 12711.0, 11126.554937802397, 11334.206605537533, 11768.76462470763, 12063.0, 12076.879231207575, 11170.553177872795, 11189.440527973731, 11695.132089184155, 11956.34240116802, 12030.458629361874, 9483.383580067273, 9495.620175192915, 10073.496325183858, 10348.896511034793, 10576.206784491347, 9576.23390128802, 9855.802883942424, 9944.204463642747, 9958.103770660675, 9987.60049598008], "value": 6371.648273590338, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 115.0, 114.0, 115.0, 115.0, 117.0, 116.0, 115.0, 116.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 127.0, 135.0, 167.0, 131.0, 131.0, 131.0, 128.0, 155.0, 133.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 177.0, 167.0, 163.0, 166.0, 165.0, 163.0, 164.0, 165.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 105.0, 78.0, 77.0, 76.0, 77.0, 105.0, 78.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 107.0, 91.0, 86.0, 85.0, 99.0, 86.0, 86.0, 105.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 121.0, 118.0, 120.0, 118.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 152.0, 154.0, 151.0, 152.0, 152.0, 152.0, 150.0, 150.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 71.0, 72.0, 82.0, 71.0, 72.0, 73.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 67.0, 69.0, 68.0, 68.0, 67.0, 68.0, 68.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 92.0, 86.0, 88.0, 95.0, 85.0, 88.0, 85.0, 86.0, 91.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 135.0, 145.0, 135.0, 143.0, 134.0, 144.0, 135.0, 182.0, 135.0], "value": 142.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 180.0, 178.0, 180.0, 175.0, 175.0, 180.0, 175.0, 183.0, 182.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 71.0, 72.0, 70.0, 69.0, 74.0, 71.0, 71.0, 73.0], "value": 71.4, "unit": "score"}]}]} 13:15:39 INFO - Return code: 0 13:15:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:15:39 ERROR - # TBPL SUCCESS # 13:15:39 INFO - Running post-action listener: _resource_record_post_action 13:15:39 INFO - [mozharness: 2016-12-29 21:15:39.570624Z] Finished run-tests step (success) 13:15:39 INFO - Running post-run listener: _resource_record_post_run 13:15:39 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 405377024; Read time: 16; Write time: 323796 13:15:39 INFO - TinderboxPrint: CPU usage
13.5% 13:15:39 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 13:15:39 INFO - TinderboxPrint: I/O write bytes / time
405,377,024 / 323,796 13:15:39 INFO - TinderboxPrint: CPU idle
8,281.8 (86.5%) 13:15:39 INFO - TinderboxPrint: CPU user
1,233.8 (12.9%) 13:15:39 INFO - TinderboxPrint: Swap in / out
0 / 0 13:15:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110608384; Read time: 0; Write time: 87576 13:15:39 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294768640; Read time: 12; Write time: 236220 13:15:40 INFO - Running post-run listener: _upload_blobber_files 13:15:40 INFO - Blob upload gear active. 13:15:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:15:40 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 13:15:40 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'] 13:15:40 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 13:15:40 INFO - (blobuploader) - INFO - Open directory for files ... 13:15:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:15:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:15:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:41 INFO - (blobuploader) - INFO - Done attempting. 13:15:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:15:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:15:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:45 INFO - (blobuploader) - INFO - Done attempting. 13:15:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:15:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:15:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:45 INFO - (blobuploader) - INFO - Done attempting. 13:15:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:15:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:15:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:46 INFO - (blobuploader) - INFO - Done attempting. 13:15:46 INFO - (blobuploader) - INFO - Iteration through files over. 13:15:46 INFO - Return code: 0 13:15:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:15:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:15:46 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5d82a5f0eca4d9c4665680c3708b5ee37cc6f1d3729786087b43afe73cabcf62287f09d9b38f1c3072d95f5dad37f0b5835518a01ed0a729a47918e7c932cce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9533f800c71a8d84a7ca9394d1d8626f1cefd3647569e49fed760796c5e1481a32f98437784a71d1f3ab9d17939e35715d3bc5128bc7dec6bb509757b8a621f1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96a68fba1417e907ae68028b5967bb918693f5ba5942a423daaad12e2917dbf1e949f8714b0cd330af507e2de29b84b7d48c5c1c88690db2bf78017884b55ea4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/277f843d600e6baa64430dd2bcd98d135854fe511b22722c93c8f55fbd562a33075b685689fe70d5732bdf5c6d7a3881b5e20aaa5e2418db67aa1164570334a5"} 13:15:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:15:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:15:46 INFO - Contents: 13:15:46 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5d82a5f0eca4d9c4665680c3708b5ee37cc6f1d3729786087b43afe73cabcf62287f09d9b38f1c3072d95f5dad37f0b5835518a01ed0a729a47918e7c932cce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9533f800c71a8d84a7ca9394d1d8626f1cefd3647569e49fed760796c5e1481a32f98437784a71d1f3ab9d17939e35715d3bc5128bc7dec6bb509757b8a621f1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96a68fba1417e907ae68028b5967bb918693f5ba5942a423daaad12e2917dbf1e949f8714b0cd330af507e2de29b84b7d48c5c1c88690db2bf78017884b55ea4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/277f843d600e6baa64430dd2bcd98d135854fe511b22722c93c8f55fbd562a33075b685689fe70d5732bdf5c6d7a3881b5e20aaa5e2418db67aa1164570334a5"} 13:15:46 INFO - Running post-run listener: copy_logs_to_upload_dir 13:15:46 INFO - Copying logs to upload dir... 13:15:46 INFO - mkdir: /builds/slave/test/build/upload/logs 13:15:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.235611 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-12-29 13:15:46.548662) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 13:15:46.552481) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5d82a5f0eca4d9c4665680c3708b5ee37cc6f1d3729786087b43afe73cabcf62287f09d9b38f1c3072d95f5dad37f0b5835518a01ed0a729a47918e7c932cce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9533f800c71a8d84a7ca9394d1d8626f1cefd3647569e49fed760796c5e1481a32f98437784a71d1f3ab9d17939e35715d3bc5128bc7dec6bb509757b8a621f1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96a68fba1417e907ae68028b5967bb918693f5ba5942a423daaad12e2917dbf1e949f8714b0cd330af507e2de29b84b7d48c5c1c88690db2bf78017884b55ea4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/277f843d600e6baa64430dd2bcd98d135854fe511b22722c93c8f55fbd562a33075b685689fe70d5732bdf5c6d7a3881b5e20aaa5e2418db67aa1164570334a5"} build_url:https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/OI5DXeOgTzO9QfWcs3ugeg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5d82a5f0eca4d9c4665680c3708b5ee37cc6f1d3729786087b43afe73cabcf62287f09d9b38f1c3072d95f5dad37f0b5835518a01ed0a729a47918e7c932cce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9533f800c71a8d84a7ca9394d1d8626f1cefd3647569e49fed760796c5e1481a32f98437784a71d1f3ab9d17939e35715d3bc5128bc7dec6bb509757b8a621f1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96a68fba1417e907ae68028b5967bb918693f5ba5942a423daaad12e2917dbf1e949f8714b0cd330af507e2de29b84b7d48c5c1c88690db2bf78017884b55ea4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/277f843d600e6baa64430dd2bcd98d135854fe511b22722c93c8f55fbd562a33075b685689fe70d5732bdf5c6d7a3881b5e20aaa5e2418db67aa1164570334a5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 13:15:46.577561) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 13:15:46.577881) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1483041411.997724-1677426636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 13:15:46.662902) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 13:15:46.663224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 13:15:46.663542) ========= ========= Total master_lag: 0.16 =========