builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-059 starttime: 1480865342.53 results: success (0) buildid: 20161204063238 builduid: 685825646b304940bf15afcb07a84d66 revision: 92d16ccb4ccedcea1da6b650d5952a4eed6b0102 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-04 07:29:02.533239) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-04 07:29:02.533759) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-04 07:29:02.534201) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-04 07:29:02.549311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 07:29:02.549644) ========= 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=3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-04 07:29:06-- 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% 19.5M=0.001s 2016-12-04 07:29:06 (19.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110330 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 07:29:02.673821) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 07:29:02.674173) ========= 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=3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020075 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 07:29:02.723644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 07:29:02.724020) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 92d16ccb4ccedcea1da6b650d5952a4eed6b0102 --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 92d16ccb4ccedcea1da6b650d5952a4eed6b0102 --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=3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-04 07:29:06,938 truncating revision to first 12 chars 2016-12-04 07:29:06,939 Setting DEBUG logging. 2016-12-04 07:29:06,939 attempt 1/10 2016-12-04 07:29:06,939 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/92d16ccb4cce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-04 07:29:07,304 unpacking tar archive at: mozilla-central-92d16ccb4cce/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668862 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 07:29:03.409938) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-04 07:29:03.410335) ========= script_repo_revision: 92d16ccb4ccedcea1da6b650d5952a4eed6b0102 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-04 07:29:03.410816) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-04 07:29:03.411189) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-04 07:29:03.423146) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-04 07:29:03.423492) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:29:07 INFO - MultiFileLogger online at 20161204 07:29:07 in /builds/slave/test 07:29:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:29:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:29:07 INFO - {'append_to_log': False, 07:29:07 INFO - 'base_work_dir': '/builds/slave/test', 07:29:07 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:29:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:29:07 INFO - 'branch': 'Firefox-Non-PGO', 07:29:07 INFO - 'buildbot_json_path': 'buildprops.json', 07:29:07 INFO - 'config_files': ('talos/linux_config.py',), 07:29:07 INFO - 'default_actions': ('clobber', 07:29:07 INFO - 'read-buildbot-config', 07:29:07 INFO - 'download-and-extract', 07:29:07 INFO - 'populate-webroot', 07:29:07 INFO - 'create-virtualenv', 07:29:07 INFO - 'install', 07:29:07 INFO - 'run-tests'), 07:29:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:29:07 INFO - 'download_minidump_stackwalk': True, 07:29:07 INFO - 'download_symbols': 'ondemand', 07:29:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:29:07 INFO - 'tooltool.py': '/tools/tooltool.py', 07:29:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:29:07 INFO - '/tools/misc-python/virtualenv.py')}, 07:29:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:29:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:29:07 INFO - 'installer_path': 'installer.exe', 07:29:07 INFO - 'log_level': 'info', 07:29:07 INFO - 'log_name': 'talos', 07:29:07 INFO - 'log_to_console': True, 07:29:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:29:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:29:07 INFO - 'opt_config_files': (), 07:29:07 INFO - 'pip_index': False, 07:29:07 INFO - 'sps_profile': False, 07:29:07 INFO - 'sps_profile_interval': 0, 07:29:07 INFO - 'suite': 'dromaeojs', 07:29:07 INFO - 'system_bits': '32', 07:29:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:29:07 INFO - 'title': 'talos-linux64-ix-059', 07:29:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:29:07 INFO - 'use_talos_json': True, 07:29:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:29:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:29:07 INFO - 'work_dir': 'build'} 07:29:07 INFO - [mozharness: 2016-12-04 15:29:07.735653Z] Running clobber step. 07:29:07 INFO - Running pre-action listener: _resource_record_pre_action 07:29:07 INFO - Running main action method: clobber 07:29:07 INFO - rmtree: /builds/slave/test/build 07:29:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:29:08 INFO - Running post-action listener: _resource_record_post_action 07:29:08 INFO - [mozharness: 2016-12-04 15:29:08.726641Z] Finished clobber step (success) 07:29:08 INFO - [mozharness: 2016-12-04 15:29:08.726739Z] Running read-buildbot-config step. 07:29:08 INFO - Running pre-action listener: _resource_record_pre_action 07:29:08 INFO - Running main action method: read_buildbot_config 07:29:08 INFO - Using buildbot properties: 07:29:08 INFO - { 07:29:08 INFO - "project": "", 07:29:08 INFO - "product": "firefox", 07:29:08 INFO - "script_repo_revision": "production", 07:29:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:29:08 INFO - "repository": "", 07:29:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:29:08 INFO - "buildid": "20161204063238", 07:29:08 INFO - "pgo_build": "False", 07:29:08 INFO - "basedir": "/builds/slave/test", 07:29:08 INFO - "buildnumber": 326, 07:29:08 INFO - "slavename": "talos-linux64-ix-059", 07:29:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:29:08 INFO - "platform": "ubuntu64_hw", 07:29:08 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:29:08 INFO - "branch": "mozilla-central", 07:29:08 INFO - "repo_path": "mozilla-central", 07:29:08 INFO - "revision": "92d16ccb4ccedcea1da6b650d5952a4eed6b0102", 07:29:08 INFO - "stage_platform": "linux64", 07:29:08 INFO - "builduid": "685825646b304940bf15afcb07a84d66", 07:29:08 INFO - "slavebuilddir": "test" 07:29:08 INFO - } 07:29:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:29:08 INFO - Running post-action listener: _resource_record_post_action 07:29:08 INFO - [mozharness: 2016-12-04 15:29:08.729183Z] Finished read-buildbot-config step (success) 07:29:08 INFO - [mozharness: 2016-12-04 15:29:08.729270Z] Running download-and-extract step. 07:29:08 INFO - Running pre-action listener: _resource_record_pre_action 07:29:08 INFO - Running main action method: download_and_extract 07:29:08 INFO - mkdir: /builds/slave/test/build/tests 07:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:08 INFO - trying https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:29:08 INFO - Downloading https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/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 07:29:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/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 07:29:09 INFO - Downloaded 1361 bytes. 07:29:09 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:29:09 INFO - Using the following test package requirements: 07:29:09 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:29:09 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:29:09 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:29:09 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:09 INFO - u'jsshell-linux-x86_64.zip'], 07:29:09 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:29:09 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:29:09 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:29:09 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:29:09 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:29:09 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:29:09 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:29:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:29:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:29:09 INFO - Fetch https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:29:10 INFO - Expected file size: 20218590 07:29:10 INFO - Obtained file size: 20218590 07:29:14 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 07:29:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:29:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:29:14 INFO - Fetch https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:29:14 INFO - Expected file size: 20218590 07:29:14 INFO - Obtained file size: 20218590 07:29:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:29:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:29:19 INFO - Fetch https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:29:20 INFO - Expected file size: 14409734 07:29:20 INFO - Obtained file size: 14409734 07:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:20 INFO - trying https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:29:20 INFO - Downloading https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/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 07:29:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/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 07:29:21 INFO - Downloaded 55694318 bytes. 07:29:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:29:21 INFO - mkdir: /builds/slave/test/properties 07:29:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:29:21 INFO - Writing to file /builds/slave/test/properties/build_url 07:29:21 INFO - Contents: 07:29:21 INFO - build_url:https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:29:22 INFO - Running post-action listener: _resource_record_post_action 07:29:22 INFO - Running post-action listener: set_extra_try_arguments 07:29:22 INFO - [mozharness: 2016-12-04 15:29:22.215522Z] Finished download-and-extract step (success) 07:29:22 INFO - [mozharness: 2016-12-04 15:29:22.215819Z] Running populate-webroot step. 07:29:22 INFO - Running pre-action listener: _resource_record_pre_action 07:29:22 INFO - Running main action method: populate_webroot 07:29:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:29:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:29:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:29:22 INFO - '--tppagecycles', 07:29:22 INFO - '7'], 07:29:22 INFO - 'tests': ['tsvgm']}}, 07:29:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:29:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:29:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:29:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:29:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:29:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:29:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:29:22 INFO - 'talos_options': ['--disable-e10s'], 07:29:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:29:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:29:22 INFO - 'talos_options': ['--disable-e10s'], 07:29:22 INFO - 'tests': ['damp', 'tps']}, 07:29:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:29:22 INFO - 'tests': ['damp', 'tps']}, 07:29:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:29:22 INFO - 'tests': ['dromaeo_dom']}, 07:29:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:29:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:29:22 INFO - 'tests': ['basic_compositor_video']}, 07:29:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:29:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:29:22 INFO - 'tests': ['a11yr', 07:29:22 INFO - 'ts_paint', 07:29:22 INFO - 'tpaint', 07:29:22 INFO - 'sessionrestore', 07:29:22 INFO - 'sessionrestore_no_auto_restore', 07:29:22 INFO - 'tabpaint']}, 07:29:22 INFO - 'other-e10s': {'tests': ['a11yr', 07:29:22 INFO - 'ts_paint', 07:29:22 INFO - 'tpaint', 07:29:22 INFO - 'sessionrestore', 07:29:22 INFO - 'sessionrestore_no_auto_restore', 07:29:22 INFO - 'tabpaint']}, 07:29:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:29:22 INFO - 'ts_paint', 07:29:22 INFO - 'tpaint', 07:29:22 INFO - 'sessionrestore', 07:29:22 INFO - 'sessionrestore_no_auto_restore', 07:29:22 INFO - 'tabpaint']}, 07:29:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:29:22 INFO - 'ts_paint', 07:29:22 INFO - 'tpaint', 07:29:22 INFO - 'sessionrestore', 07:29:22 INFO - 'sessionrestore_no_auto_restore', 07:29:22 INFO - 'tabpaint']}, 07:29:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:29:22 INFO - 'tests': ['a11yr', 07:29:22 INFO - 'ts_paint', 07:29:22 INFO - 'tpaint', 07:29:22 INFO - 'sessionrestore', 07:29:22 INFO - 'sessionrestore_no_auto_restore', 07:29:22 INFO - 'tabpaint']}, 07:29:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:29:22 INFO - 'tests': ['a11yr', 07:29:22 INFO - 'ts_paint', 07:29:22 INFO - 'tpaint', 07:29:22 INFO - 'sessionrestore', 07:29:22 INFO - 'sessionrestore_no_auto_restore', 07:29:22 INFO - 'tabpaint']}, 07:29:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:29:22 INFO - 'tests': ['tsvgx', 07:29:22 INFO - 'tsvgr_opacity', 07:29:22 INFO - 'tart', 07:29:22 INFO - 'tscrollx', 07:29:22 INFO - 'cart', 07:29:22 INFO - 'tsvg_static']}, 07:29:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:29:22 INFO - 'tsvgr_opacity', 07:29:22 INFO - 'tart', 07:29:22 INFO - 'tscrollx', 07:29:22 INFO - 'cart', 07:29:22 INFO - 'tsvg_static']}, 07:29:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:29:22 INFO - 'talos_options': ['--disable-e10s'], 07:29:22 INFO - 'tests': ['tp5o']}, 07:29:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:29:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:29:22 INFO - 'talos_options': ['--disable-e10s', 07:29:22 INFO - '--xperf_path', 07:29:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:22 INFO - 'tests': ['tp5n']}, 07:29:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:29:22 INFO - 'talos_options': ['--xperf_path', 07:29:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:22 INFO - 'tests': ['tp5n']}}, 07:29:22 INFO - 'talos.zip': {'path': '', 07:29:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:29:22 INFO - Running post-action listener: _resource_record_post_action 07:29:22 INFO - [mozharness: 2016-12-04 15:29:22.238327Z] Finished populate-webroot step (success) 07:29:22 INFO - [mozharness: 2016-12-04 15:29:22.238419Z] Running create-virtualenv step. 07:29:22 INFO - Running pre-action listener: _resource_record_pre_action 07:29:22 INFO - Running main action method: create_virtualenv 07:29:22 INFO - Creating virtualenv /builds/slave/test/build/venv 07:29:22 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 07:29:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:29:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:29:22 INFO - Using real prefix '/usr' 07:29:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:29:22 INFO - Installing distribute.............................................................................................................................................................................................done. 07:29:24 INFO - Installing pip.................done. 07:29:24 INFO - Return code: 0 07:29:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:29:25 INFO - Reading from file tmpfile_stdout 07:29:25 INFO - Output received: 07:29:25 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) 07:29:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:29: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')]} 07:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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')]} 07:29:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f425e08de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fef20>, '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 0x256bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256bf90>, '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': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', '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 07:29: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', 'pip>=1.5'] in /builds/slave/test/build 07:29: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 pip>=1.5 07:29:25 INFO - Using env: {'DISPLAY': ':0', 07:29:25 INFO - 'HOME': '/home/cltbld', 07:29:25 INFO - 'LANG': 'en_US.UTF-8', 07:29:25 INFO - 'LANGUAGE': 'en_US:en', 07:29:25 INFO - 'LOGNAME': 'cltbld', 07:29:25 INFO - 'MAIL': '/var/mail/cltbld', 07:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:25 INFO - 'MOZ_NO_REMOTE': '1', 07:29:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:25 INFO - 'NO_EM_RESTART': '1', 07:29:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:25 INFO - 'PWD': '/builds/slave/test', 07:29:25 INFO - 'SHELL': '/bin/bash', 07:29:25 INFO - 'SHLVL': '1', 07:29:25 INFO - 'TERM': 'linux', 07:29:25 INFO - 'TMOUT': '86400', 07:29:25 INFO - 'USER': 'cltbld', 07:29:25 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', 07:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:25 INFO - '_': '/tools/buildbot/bin/python'} 07:29:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:25 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 07:29:25 INFO - Cleaning up... 07:29:25 INFO - Return code: 0 07:29:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:29: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')]} 07:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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')]} 07:29:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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', '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 0x7f425e08de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fef20>, '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 0x256bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256bf90>, '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': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', '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 07:29: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:29: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 psutil>=3.1.1 07:29:25 INFO - Using env: {'DISPLAY': ':0', 07:29:25 INFO - 'HOME': '/home/cltbld', 07:29:25 INFO - 'LANG': 'en_US.UTF-8', 07:29:25 INFO - 'LANGUAGE': 'en_US:en', 07:29:25 INFO - 'LOGNAME': 'cltbld', 07:29:25 INFO - 'MAIL': '/var/mail/cltbld', 07:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:25 INFO - 'MOZ_NO_REMOTE': '1', 07:29:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:25 INFO - 'NO_EM_RESTART': '1', 07:29:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:25 INFO - 'PWD': '/builds/slave/test', 07:29:25 INFO - 'SHELL': '/bin/bash', 07:29:25 INFO - 'SHLVL': '1', 07:29:25 INFO - 'TERM': 'linux', 07:29:25 INFO - 'TMOUT': '86400', 07:29:25 INFO - 'USER': 'cltbld', 07:29:25 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', 07:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:25 INFO - '_': '/tools/buildbot/bin/python'} 07:29:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:25 INFO - Downloading/unpacking psutil>=3.1.1 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:29:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:27 INFO - Installing collected packages: psutil 07:29:27 INFO - Running setup.py install for psutil 07:29:27 INFO - building 'psutil._psutil_linux' extension 07:29:27 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 07:29:27 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 07:29:27 INFO - building 'psutil._psutil_posix' extension 07:29:27 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 07:29:27 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 07:29:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:28 INFO - Successfully installed psutil 07:29:28 INFO - Cleaning up... 07:29:28 INFO - Return code: 0 07:29:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:29:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:28 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 0x7f425e08de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fef20>, '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 0x256bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256bf90>, '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': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', '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 07:29:28 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 07:29:28 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 07:29:28 INFO - Using env: {'DISPLAY': ':0', 07:29:28 INFO - 'HOME': '/home/cltbld', 07:29:28 INFO - 'LANG': 'en_US.UTF-8', 07:29:28 INFO - 'LANGUAGE': 'en_US:en', 07:29:28 INFO - 'LOGNAME': 'cltbld', 07:29:28 INFO - 'MAIL': '/var/mail/cltbld', 07:29:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:28 INFO - 'MOZ_NO_REMOTE': '1', 07:29:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:28 INFO - 'NO_EM_RESTART': '1', 07:29:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:28 INFO - 'PWD': '/builds/slave/test', 07:29:28 INFO - 'SHELL': '/bin/bash', 07:29:28 INFO - 'SHLVL': '1', 07:29:28 INFO - 'TERM': 'linux', 07:29:28 INFO - 'TMOUT': '86400', 07:29:28 INFO - 'USER': 'cltbld', 07:29:28 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', 07:29:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:28 INFO - '_': '/tools/buildbot/bin/python'} 07:29:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:29:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:29:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:29:30 INFO - Installing collected packages: mozsystemmonitor 07:29:30 INFO - Running setup.py install for mozsystemmonitor 07:29:30 INFO - Successfully installed mozsystemmonitor 07:29:30 INFO - Cleaning up... 07:29:30 INFO - Return code: 0 07:29:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f425e08de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fef20>, '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 0x256bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256bf90>, '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': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', '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 07:29:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:29:30 INFO - Using env: {'DISPLAY': ':0', 07:29:30 INFO - 'HOME': '/home/cltbld', 07:29:30 INFO - 'LANG': 'en_US.UTF-8', 07:29:30 INFO - 'LANGUAGE': 'en_US:en', 07:29:30 INFO - 'LOGNAME': 'cltbld', 07:29:30 INFO - 'MAIL': '/var/mail/cltbld', 07:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:30 INFO - 'MOZ_NO_REMOTE': '1', 07:29:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:30 INFO - 'NO_EM_RESTART': '1', 07:29:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:30 INFO - 'PWD': '/builds/slave/test', 07:29:30 INFO - 'SHELL': '/bin/bash', 07:29:30 INFO - 'SHLVL': '1', 07:29:30 INFO - 'TERM': 'linux', 07:29:30 INFO - 'TMOUT': '86400', 07:29:30 INFO - 'USER': 'cltbld', 07:29:30 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', 07:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:30 INFO - '_': '/tools/buildbot/bin/python'} 07:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:30 INFO - Downloading/unpacking jsonschema==2.5.1 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:29:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:29:32 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 07:29:32 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 07:29:32 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 07:29:32 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 07:29:32 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 07:29:32 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 07:29:33 INFO - Downloading functools32-3.2.3-2.tar.gz 07:29:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:29:33 INFO - warning: no files found matching '*.txt' 07:29:33 INFO - no previously-included directories found matching 'build' 07:29:33 INFO - no previously-included directories found matching 'dist' 07:29:33 INFO - no previously-included directories found matching '.git*' 07:29:33 INFO - Installing collected packages: jsonschema, functools32 07:29:33 INFO - Running setup.py install for functools32 07:29:33 INFO - warning: no files found matching '*.txt' 07:29:33 INFO - no previously-included directories found matching 'build' 07:29:33 INFO - no previously-included directories found matching 'dist' 07:29:33 INFO - no previously-included directories found matching '.git*' 07:29:33 INFO - Successfully installed jsonschema functools32 07:29:33 INFO - Cleaning up... 07:29:33 INFO - Return code: 0 07:29:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f425e08de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fef20>, '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 0x256bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256bf90>, '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': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', '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 07:29:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:29:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:29:33 INFO - Using env: {'DISPLAY': ':0', 07:29:33 INFO - 'HOME': '/home/cltbld', 07:29:33 INFO - 'LANG': 'en_US.UTF-8', 07:29:33 INFO - 'LANGUAGE': 'en_US:en', 07:29:33 INFO - 'LOGNAME': 'cltbld', 07:29:33 INFO - 'MAIL': '/var/mail/cltbld', 07:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:33 INFO - 'MOZ_NO_REMOTE': '1', 07:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:33 INFO - 'NO_EM_RESTART': '1', 07:29:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:33 INFO - 'PWD': '/builds/slave/test', 07:29:33 INFO - 'SHELL': '/bin/bash', 07:29:33 INFO - 'SHLVL': '1', 07:29:33 INFO - 'TERM': 'linux', 07:29:33 INFO - 'TMOUT': '86400', 07:29:33 INFO - 'USER': 'cltbld', 07:29:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', 07:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:33 INFO - '_': '/tools/buildbot/bin/python'} 07:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:29:33 INFO - Cleaning up... 07:29:33 INFO - Return code: 0 07:29:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f425e08de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fef20>, '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 0x256bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256bf90>, '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': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', '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 07:29:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:29:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:29:33 INFO - Using env: {'DISPLAY': ':0', 07:29:33 INFO - 'HOME': '/home/cltbld', 07:29:33 INFO - 'LANG': 'en_US.UTF-8', 07:29:33 INFO - 'LANGUAGE': 'en_US:en', 07:29:33 INFO - 'LOGNAME': 'cltbld', 07:29:33 INFO - 'MAIL': '/var/mail/cltbld', 07:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:33 INFO - 'MOZ_NO_REMOTE': '1', 07:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:33 INFO - 'NO_EM_RESTART': '1', 07:29:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:33 INFO - 'PWD': '/builds/slave/test', 07:29:33 INFO - 'SHELL': '/bin/bash', 07:29:33 INFO - 'SHLVL': '1', 07:29:33 INFO - 'TERM': 'linux', 07:29:33 INFO - 'TMOUT': '86400', 07:29:33 INFO - 'USER': 'cltbld', 07:29:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', 07:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:33 INFO - '_': '/tools/buildbot/bin/python'} 07:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:33 INFO - Downloading/unpacking blobuploader==1.2.4 07:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:35 INFO - Downloading blobuploader-1.2.4.tar.gz 07:29:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:29:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:29:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29:36 INFO - Downloading docopt-0.6.1.tar.gz 07:29:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:29:36 INFO - Installing collected packages: blobuploader, requests, docopt 07:29:36 INFO - Running setup.py install for blobuploader 07:29:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:29:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:29:36 INFO - Running setup.py install for requests 07:29:37 INFO - Running setup.py install for docopt 07:29:37 INFO - Successfully installed blobuploader requests docopt 07:29:37 INFO - Cleaning up... 07:29:37 INFO - Return code: 0 07:29:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:37 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')]} 07:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:37 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')]} 07:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:37 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 0x7f425e08de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fef20>, '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 0x256bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256bf90>, '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': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', '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 07:29:37 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 07:29:37 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 07:29:37 INFO - Using env: {'DISPLAY': ':0', 07:29:37 INFO - 'HOME': '/home/cltbld', 07:29:37 INFO - 'LANG': 'en_US.UTF-8', 07:29:37 INFO - 'LANGUAGE': 'en_US:en', 07:29:37 INFO - 'LOGNAME': 'cltbld', 07:29:37 INFO - 'MAIL': '/var/mail/cltbld', 07:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:37 INFO - 'MOZ_NO_REMOTE': '1', 07:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:37 INFO - 'NO_EM_RESTART': '1', 07:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:37 INFO - 'PWD': '/builds/slave/test', 07:29:37 INFO - 'SHELL': '/bin/bash', 07:29:37 INFO - 'SHLVL': '1', 07:29:37 INFO - 'TERM': 'linux', 07:29:37 INFO - 'TMOUT': '86400', 07:29:37 INFO - 'USER': 'cltbld', 07:29:37 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', 07:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:37 INFO - '_': '/tools/buildbot/bin/python'} 07:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:37 INFO - Running setup.py (path:/tmp/pip-e55InI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:37 INFO - Running setup.py (path:/tmp/pip-FSUHg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:37 INFO - Running setup.py (path:/tmp/pip-lqpq3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:37 INFO - Running setup.py (path:/tmp/pip-QYFQQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:37 INFO - Running setup.py (path:/tmp/pip-wnfsKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:37 INFO - Running setup.py (path:/tmp/pip-6GFzEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:37 INFO - Running setup.py (path:/tmp/pip-Qi_QMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:37 INFO - Running setup.py (path:/tmp/pip-0smnV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:37 INFO - Running setup.py (path:/tmp/pip-Y1c2Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:38 INFO - Running setup.py (path:/tmp/pip-Rhmn0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:38 INFO - Running setup.py (path:/tmp/pip-RJ1Rqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:38 INFO - Running setup.py (path:/tmp/pip-L9vGfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:38 INFO - Running setup.py (path:/tmp/pip-OxCD51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:38 INFO - Running setup.py (path:/tmp/pip-PYsk1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:38 INFO - Running setup.py (path:/tmp/pip-fwe0wC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:38 INFO - Running setup.py (path:/tmp/pip-STSEaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:38 INFO - Running setup.py (path:/tmp/pip-_niRE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:29:38 INFO - Running setup.py install for manifestparser 07:29:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:29:38 INFO - Running setup.py install for mozcrash 07:29:38 INFO - Running setup.py install for mozdebug 07:29:38 INFO - Running setup.py install for mozdevice 07:29:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:29:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:29:39 INFO - Running setup.py install for mozfile 07:29:39 INFO - Running setup.py install for mozhttpd 07:29:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:29:39 INFO - Running setup.py install for mozinfo 07:29:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:29:39 INFO - Running setup.py install for mozInstall 07:29:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:29:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:29:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:29:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:29:39 INFO - Running setup.py install for mozleak 07:29:39 INFO - Running setup.py install for mozlog 07:29:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:29:39 INFO - Running setup.py install for moznetwork 07:29:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:29:39 INFO - Running setup.py install for mozprocess 07:29:39 INFO - Running setup.py install for mozprofile 07:29:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:29:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:29:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:29:39 INFO - Running setup.py install for mozrunner 07:29:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:29:40 INFO - Running setup.py install for mozscreenshot 07:29:40 INFO - Running setup.py install for moztest 07:29:40 INFO - Running setup.py install for mozversion 07:29:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:29:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:29:40 INFO - Cleaning up... 07:29:40 INFO - Return code: 0 07:29:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:40 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')]} 07:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:40 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')]} 07:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:40 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 0x7f425e08de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fef20>, '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 0x256bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256bf90>, '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': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', '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 07:29:40 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 07:29:40 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 07:29:40 INFO - Using env: {'DISPLAY': ':0', 07:29:40 INFO - 'HOME': '/home/cltbld', 07:29:40 INFO - 'LANG': 'en_US.UTF-8', 07:29:40 INFO - 'LANGUAGE': 'en_US:en', 07:29:40 INFO - 'LOGNAME': 'cltbld', 07:29:40 INFO - 'MAIL': '/var/mail/cltbld', 07:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:40 INFO - 'MOZ_NO_REMOTE': '1', 07:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:40 INFO - 'NO_EM_RESTART': '1', 07:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:40 INFO - 'PWD': '/builds/slave/test', 07:29:40 INFO - 'SHELL': '/bin/bash', 07:29:40 INFO - 'SHLVL': '1', 07:29:40 INFO - 'TERM': 'linux', 07:29:40 INFO - 'TMOUT': '86400', 07:29:40 INFO - 'USER': 'cltbld', 07:29:40 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', 07:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:40 INFO - '_': '/tools/buildbot/bin/python'} 07:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:40 INFO - Running setup.py (path:/tmp/pip-f6VUYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:40 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)) 07:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:40 INFO - Running setup.py (path:/tmp/pip-t4vEgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:40 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)) 07:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:40 INFO - Running setup.py (path:/tmp/pip-np1VKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:40 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)) 07:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:40 INFO - Running setup.py (path:/tmp/pip-jTTwiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:40 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)) 07:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:40 INFO - Running setup.py (path:/tmp/pip-0yo9c7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:41 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)) 07:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:41 INFO - Running setup.py (path:/tmp/pip-aLw7g3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:41 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)) 07:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:41 INFO - Running setup.py (path:/tmp/pip-ETVywc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:41 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)) 07:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:41 INFO - Running setup.py (path:/tmp/pip-IYv7pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:41 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)) 07:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:41 INFO - Running setup.py (path:/tmp/pip-zKtwMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:41 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)) 07:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:41 INFO - Running setup.py (path:/tmp/pip-BaJmJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:41 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)) 07:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:41 INFO - Running setup.py (path:/tmp/pip-wYcNb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:41 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)) 07:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:41 INFO - Running setup.py (path:/tmp/pip-QYOMhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:41 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)) 07:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:41 INFO - Running setup.py (path:/tmp/pip-rBQHQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:41 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)) 07:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:41 INFO - Running setup.py (path:/tmp/pip-yIx5Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:41 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)) 07:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:41 INFO - Running setup.py (path:/tmp/pip-GcWqiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:41 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)) 07:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:41 INFO - Running setup.py (path:/tmp/pip-HO8zJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:41 INFO - Running setup.py (path:/tmp/pip-XSTXCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:41 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)) 07:29:41 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)) 07:29:41 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)) 07:29:41 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)) 07:29:41 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)) 07:29:41 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)) 07:29:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:29:41 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 07:29:41 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 07:29:41 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 07:29:41 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 07:29:41 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 07:29:41 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 07:29:43 INFO - Downloading blessings-1.6.tar.gz 07:29:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:29:43 INFO - Installing collected packages: blessings 07:29:43 INFO - Running setup.py install for blessings 07:29:44 INFO - Successfully installed blessings 07:29:44 INFO - Cleaning up... 07:29:44 INFO - Return code: 0 07:29:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:29:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:44 INFO - Reading from file tmpfile_stdout 07:29:44 INFO - Current package versions: 07:29:44 INFO - argparse == 1.2.1 07:29:44 INFO - blessings == 1.6 07:29:44 INFO - blobuploader == 1.2.4 07:29:44 INFO - docopt == 0.6.1 07:29:44 INFO - functools32 == 3.2.3-2 07:29:44 INFO - jsonschema == 2.5.1 07:29:44 INFO - manifestparser == 1.1 07:29:44 INFO - mozInstall == 1.12 07:29:44 INFO - mozcrash == 1.0 07:29:44 INFO - mozdebug == 0.1 07:29:44 INFO - mozdevice == 0.49 07:29:44 INFO - mozfile == 1.2 07:29:44 INFO - mozhttpd == 0.7 07:29:44 INFO - mozinfo == 0.9 07:29:44 INFO - mozleak == 0.1 07:29:44 INFO - mozlog == 3.4 07:29:44 INFO - moznetwork == 0.27 07:29:44 INFO - mozprocess == 0.23 07:29:44 INFO - mozprofile == 0.28 07:29:44 INFO - mozrunner == 6.13 07:29:44 INFO - mozscreenshot == 0.1 07:29:44 INFO - mozsystemmonitor == 0.3 07:29:44 INFO - moztest == 0.7 07:29:44 INFO - mozversion == 1.4 07:29:44 INFO - psutil == 3.1.1 07:29:44 INFO - requests == 1.2.3 07:29:44 INFO - wsgiref == 0.1.2 07:29:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:44 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')]} 07:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:44 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')]} 07:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:44 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 0x7f425e08de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fef20>, '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 0x256bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256bf90>, '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': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', '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 07:29:44 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 07:29:44 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 07:29:44 INFO - Using env: {'DISPLAY': ':0', 07:29:44 INFO - 'HOME': '/home/cltbld', 07:29:44 INFO - 'LANG': 'en_US.UTF-8', 07:29:44 INFO - 'LANGUAGE': 'en_US:en', 07:29:44 INFO - 'LOGNAME': 'cltbld', 07:29:44 INFO - 'MAIL': '/var/mail/cltbld', 07:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:44 INFO - 'MOZ_NO_REMOTE': '1', 07:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:44 INFO - 'NO_EM_RESTART': '1', 07:29:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:44 INFO - 'PWD': '/builds/slave/test', 07:29:44 INFO - 'SHELL': '/bin/bash', 07:29:44 INFO - 'SHLVL': '1', 07:29:44 INFO - 'TERM': 'linux', 07:29:44 INFO - 'TMOUT': '86400', 07:29:44 INFO - 'USER': 'cltbld', 07:29:44 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', 07:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:44 INFO - '_': '/tools/buildbot/bin/python'} 07:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:44 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)) 07:29:44 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)) 07:29:44 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)) 07:29:44 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)) 07:29:44 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)) 07:29:44 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)) 07:29:44 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)) 07:29:44 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)) 07:29:44 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)) 07:29:44 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)) 07:29:44 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)) 07:29:44 INFO - Cleaning up... 07:29:44 INFO - Return code: 0 07:29:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:29:44 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')]} 07:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:44 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')]} 07:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:44 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 0x7f425e08de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256e120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fef20>, '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 0x256bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256bf90>, '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': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', '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 07:29:44 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 07:29:44 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 07:29:44 INFO - Using env: {'DISPLAY': ':0', 07:29:44 INFO - 'HOME': '/home/cltbld', 07:29:44 INFO - 'LANG': 'en_US.UTF-8', 07:29:44 INFO - 'LANGUAGE': 'en_US:en', 07:29:44 INFO - 'LOGNAME': 'cltbld', 07:29:44 INFO - 'MAIL': '/var/mail/cltbld', 07:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:44 INFO - 'MOZ_NO_REMOTE': '1', 07:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:44 INFO - 'NO_EM_RESTART': '1', 07:29:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:44 INFO - 'PWD': '/builds/slave/test', 07:29:44 INFO - 'SHELL': '/bin/bash', 07:29:44 INFO - 'SHLVL': '1', 07:29:44 INFO - 'TERM': 'linux', 07:29:44 INFO - 'TMOUT': '86400', 07:29:44 INFO - 'USER': 'cltbld', 07:29:44 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', 07:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:44 INFO - '_': '/tools/buildbot/bin/python'} 07:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:29:44 INFO - Cleaning up... 07:29:44 INFO - Return code: 0 07:29:44 INFO - Running post-action listener: _resource_record_post_action 07:29:44 INFO - Running post-action listener: _start_resource_monitoring 07:29:44 INFO - Starting resource monitoring. 07:29:44 INFO - [mozharness: 2016-12-04 15:29:44.852880Z] Finished create-virtualenv step (success) 07:29:44 INFO - [mozharness: 2016-12-04 15:29:44.853356Z] Running install step. 07:29:44 INFO - Running pre-action listener: _resource_record_pre_action 07:29:44 INFO - Running main action method: install 07:29:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:45 INFO - Reading from file tmpfile_stdout 07:29:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:29:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:29:45 INFO - Reading from file tmpfile_stdout 07:29:45 INFO - Output received: 07:29:45 INFO - Usage: mozinstall [options] installer 07:29:45 INFO - Options: 07:29:45 INFO - -h, --help show this help message and exit 07:29:45 INFO - -d DEST, --destination=DEST 07:29:45 INFO - Directory to install application into. [default: 07:29:45 INFO - "/builds/slave/test"] 07:29:45 INFO - --app=APP Application being installed. [default: firefox] 07:29:45 INFO - mkdir: /builds/slave/test/build/application 07:29:45 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'] 07:29:45 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 07:30:01 INFO - Reading from file tmpfile_stdout 07:30:01 INFO - Output received: 07:30:01 INFO - /builds/slave/test/build/application/firefox/firefox 07:30:01 INFO - Running post-action listener: _resource_record_post_action 07:30:01 INFO - [mozharness: 2016-12-04 15:30:01.258548Z] Finished install step (success) 07:30:01 INFO - [mozharness: 2016-12-04 15:30:01.258791Z] Running run-tests step. 07:30:01 INFO - Running pre-action listener: _resource_record_pre_action 07:30:01 INFO - Running main action method: run_tests 07:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:30:01 INFO - Python 2.7.3 07:30:01 INFO - Return code: 0 07:30:01 INFO - grabbing minidump binary from tooltool 07:30:01 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')]} 07:30:01 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 0x25fef20>, '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 0x256bc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256bf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:30:01 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 07:30:01 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 07:30:01 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 07:30:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:30:01 INFO - Return code: 0 07:30:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:30:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:30:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:30:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:30:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:30:01 INFO - Using env: {'DISPLAY': ':0', 07:30:01 INFO - 'HOME': '/home/cltbld', 07:30:01 INFO - 'LANG': 'en_US.UTF-8', 07:30:01 INFO - 'LANGUAGE': 'en_US:en', 07:30:01 INFO - 'LOGNAME': 'cltbld', 07:30:01 INFO - 'MAIL': '/var/mail/cltbld', 07:30:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:30:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:01 INFO - 'MOZ_NO_REMOTE': '1', 07:30:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:01 INFO - 'NO_EM_RESTART': '1', 07:30:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:01 INFO - 'PWD': '/builds/slave/test', 07:30:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:30:01 INFO - 'SHELL': '/bin/bash', 07:30:01 INFO - 'SHLVL': '1', 07:30:01 INFO - 'TERM': 'linux', 07:30:01 INFO - 'TMOUT': '86400', 07:30:01 INFO - 'USER': 'cltbld', 07:30:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336', 07:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:01 INFO - '_': '/tools/buildbot/bin/python'} 07:30:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:30:01 INFO - mozversion application_buildid: 20161204063238 07:30:01 INFO - mozversion application_changeset: 92d16ccb4ccedcea1da6b650d5952a4eed6b0102 07:30:01 INFO - mozversion application_display_name: Nightly 07:30:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:30:01 INFO - mozversion application_name: Firefox 07:30:01 INFO - mozversion application_remotingname: firefox 07:30:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:30:01 INFO - mozversion application_vendor: Mozilla 07:30:01 INFO - mozversion application_version: 53.0a1 07:30:01 INFO - mozversion platform_buildid: 20161204063238 07:30:01 INFO - mozversion platform_changeset: 92d16ccb4ccedcea1da6b650d5952a4eed6b0102 07:30:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:30:01 INFO - mozversion platform_version: 53.0a1 07:30:01 INFO - using testdate: 1480865401 07:30:01 INFO - actual date: 1480865401 07:30:01 INFO - starting webserver on 'localhost:47091' 07:30:01 INFO - SUITE-START | Running 2 tests 07:30:01 INFO - TEST-START | dromaeo_css 07:30:01 INFO - operating with platform_type : linux_ 07:30:01 INFO - Initialising browser for dromaeo_css test... 07:30:01 INFO - TEST-INFO | started process 32617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprnlHo6/profile http://localhost:47091/getInfo.html) 07:30:05 INFO - PROCESS | 32617 | __metrics Screen width/height:1600/1200 07:30:05 INFO - PROCESS | 32617 | colorDepth:24 07:30:05 INFO - PROCESS | 32617 | Browser inner width/height: 1024/697 07:30:05 INFO - PROCESS | 32617 | __metrics 07:30:06 INFO - PROCESS | 32617 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:30:06 INFO - PROCESS | 32617 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:30:07 INFO - PROCESS | 32617 | console.error: PushService: 07:30:07 INFO - PROCESS | 32617 | stateChangeProcessEnqueue: Error transitioning state 07:30:07 INFO - PROCESS | 32617 | UnknownError 07:30:07 INFO - TEST-INFO | 32617: exit 0 07:30:07 INFO - Browser initialized. 07:30:07 INFO - Running cycle 1/1 for dromaeo_css test... 07:30:07 INFO - TEST-INFO | started process 32705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprnlHo6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:20 INFO - PROCESS | 32705 | RSS: Main: 173965312 07:30:20 INFO - PROCESS | 32705 | 07:31:11 INFO - PROCESS | 32705 | 1480865471300 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:33:24 INFO - PROCESS | 32705 | Cycle 1(1): loaded http://localhost:47091/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47091/tests/dromaeo/cssquery-ext.html) 07:33:26 INFO - PROCESS | 32705 | RSS: Main: 313991168 07:33:26 INFO - PROCESS | 32705 | 07:36:29 INFO - PROCESS | 32705 | Cycle 1(1): loaded http://localhost:47091/tests/dromaeo/cssquery-ext.html (next: http://localhost:47091/tests/dromaeo/cssquery-jquery.html) 07:36:29 INFO - PROCESS | 32705 | RSS: Main: 284606464 07:36:29 INFO - PROCESS | 32705 | 07:39:31 INFO - PROCESS | 32705 | Cycle 1(1): loaded http://localhost:47091/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47091/tests/dromaeo/cssquery-mootools.html) 07:39:32 INFO - PROCESS | 32705 | RSS: Main: 267284480 07:39:32 INFO - PROCESS | 32705 | 07:42:35 INFO - PROCESS | 32705 | Cycle 1(1): loaded http://localhost:47091/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47091/tests/dromaeo/cssquery-prototype.html) 07:42:35 INFO - PROCESS | 32705 | RSS: Main: 254476288 07:42:35 INFO - PROCESS | 32705 | 07:45:38 INFO - PROCESS | 32705 | Cycle 1(1): loaded http://localhost:47091/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47091/tests/dromaeo/cssquery-yui.html) 07:45:39 INFO - PROCESS | 32705 | RSS: Main: 226451456 07:45:39 INFO - PROCESS | 32705 | 07:48:42 INFO - PROCESS | 32705 | Cycle 1(1): loaded http://localhost:47091/tests/dromaeo/cssquery-yui.html (next: http://localhost:47091/tests/dromaeo/cssquery-dojo.html) 07:48:42 INFO - PROCESS | 32705 | RSS: Main: 319905792 07:48:42 INFO - PROCESS | 32705 | 07:48:42 INFO - PROCESS | 32705 | __start_tp_report 07:48:42 INFO - PROCESS | 32705 | _x_x_mozilla_page_load 07:48:42 INFO - PROCESS | 32705 | _x_x_mozilla_page_load_details 07:48:42 INFO - PROCESS | 32705 | |i|pagename|runs| 07:48:42 INFO - PROCESS | 32705 | |0;dojo.html;2554.32310437734;2588.598767191084;2603.5964425514044;2617.5942728877017;2629.894804207832;4471.262241730119;4542.136993971143;4612.607928326092;4623.468301145369;4629.652776041794;4547.909041819162;4569.4745104313015;4576.382188404565;4583.839565615204;4589.931151032729;4198.160367926412;4202.033532287575;4208.558101399355;4238.87283381499;4279.572042795711;4265.786710664454;4271.97864010681;4310.137972405516;4325.870223893288;4337.609615134637;4339.566043395666;4360.56394360563;4362.694611377205;4376.781160941956;4392.231359512089;4345.565443455661;4345.891352716176;4347.934780978304;4372.890677733082;4386.188555117314;4142.275101857163;4215.030542975132;4260.44614200152;4272.893177670583;4323.027318853233;4682.859514214579;4701.670883038155;4703.2709929960565;4714.339992401066;4739.0758802033615;5021.472745361721;5027.195648696191;5027.195648696227;5030.220315851049;5065.569426598743;4806.711597304173;4847.781849816767;4855.028994201174;5039.067772462106;5041.218611115283;4580.587747102777;4593.28804035375;4616.6306695464955;4626.352310676508;4670.229412147026;5029.924551131736;5032;5032.874178145503;5037.571806396424;5072.416672082758;4704.788284527204;4826.493218212107;4829.468758436569;4834.984653222792;4874.903146792014;4822.059698358787;4879.219324908068;4936.703797772145;4966.230234313687;4989.027139707722;4933.925991110136;4935.358403407534;4935.457099719028;4941.802327906916;4978.22837460187;4922.08941345845;4923.975380123148;4928.112939670822;4929.13740095489;4962.6774259673;4096.528899176573;4130.0294430808735;4130.112025914443;4139.275626765364;4239.703220774578;3650.4341827016856;3661.176235347079;3699.3341198584512;3706.79612621303;3728.291624591319;4238.279492486223;4239.27932251518;4240.936385954213;4247.341662042389;4256.361545768098;4914.8034078637165;4935.90128197434;4983.327250821165;4988.226824842155;5037;4210.263203939298;4221.303484925014;4270.039241170712;4270.103278311527;4276.35854621803;4448.243798554254;4467.195904737114;4507.616852567503;4507.661925355612;4508.18852606534;4648.2562789953445;4650.906981860411;4654;4654.1157180137025;4697.4832768395445;4857.247126695368;4976.377952755905;4990.525900039491;4990.775415106256;5032.84901452957;4551.795169217459;4562.726236425825;4589.724616523019;4605.861824145281;4618.6536009800075;4836.806527738851;4865.294532292868;4865.464798872192;4909.361782968192;4910.82812101589;4919.877003074952;4922.8769280768265;4929.975350123226;4931.3096166536;4967.081089998362;4570.405847239837;4667.509911459248;4673.766311684334;4787.3776409066595;4809.9038019240115;4793.352897358812;4860.270959356125;4862.65961382714;4881.219004959189;4907.0431265904235;4781.784819683192;4797.208460603962;4797.328374027708;4802.831900883452;4853.344798452164;4673;4707.78814953321;4904.779284932258;4911.312416261655;4939.086269040239;4690.296455531698;4715.599174070242;4764.976175119103;4775.283707443772;4806.831760888352 07:48:42 INFO - PROCESS | 32705 | |1;ext.html;564.4355644355644;576.1473019930503;580.7154494297795;582.7960213925126;591.8520369907524;27796.305092372702;30455;38951;40169.79915100428;40487.19025619493;38982.610173898254;39423;39475.407868881986;39490.21019579607;39572.80213598928;7588.203238659944;7746.612669366537;7746.8450630987345;7747.3027427531515;7748.767536973872;7355.558666480001;7541;7559.055118110236;9665.4200747955;9907.603695852193;9971.302008859382;10012.849807252896;10032.448215348153;10040.598376064949;10044.598216071385;9874.506274686273;9920.553575089067;9920.603175872957;9932.503374831302;9933.056359645821;9763.218942484584;9862.013798620152;9862.654807081717;9865.408075515492;9865.50672466381;36828.263434731154;37247.441288380694;37286.627133728856;37309.06727331811;37337.066573335615;2934.105097945126;3161.3045130071346;3191.2979144588153;3422.6748458896363;3449.3101379724158;27926.720732792615;27938.441231175264;28404;28521.429571408662;30063.398732025238;3462.8441720122655;3493.1616412061176;3511.666391692785;3576.517170182018;3591.1740299730945;239433.2113357723;239456.80271598705;239598;241241;241364;51930.48069519332;52462.475375246526;52485.24052569214;52503.737481312346;52510.21234681406;54308.72845635826;54357;54364.45635543594;54396.728016359666;54402.45597544053;14212.786808197885;14402.927985360006;14411;14421.78367324491;14431.3505892233;9677.951610241904;11194;11196.888031119584;11222.775544489064;11261.268017578996;14218.431262749582;16091.678166436606;16655.916720416564;16799.16004199785;17289.97425450541;5931.822045338647;6179.134921111048;6187;6307.432331090224;6339.302676705559;757.3411132314922;836.2557323981662;888.5201990924958;900.8063266397625;997.9151772099453;25385.61921571178;27286.846401975166;27541.86229068882;27726.861365693043;27886;968.8740463739668;970.9951450242703;979.1970584120952;997.3394298493073;1027.1833892055834;13442.865571344162;14453.205073721047;14600.151866357537;14786.260686965608;14846.480373186887;351684;353322;354441;354530;354897;47315.76342118267;47338.289925651145;47531.52468475271;47544.286835697494;47725.5227447728;1022.7954409118057;1107.3687997841314;1127.2898074213192;1136.9943150284196;1162.7906976744098;25057.373565661004;28269.858650706614;28366.716332836408;28697.569536457388;29152.854235728686;40485.39271910865;40771;40785.79607101945;40816;40821.38767918424;284414;285653;285985;286098;286232;23832.76167238375;24891.875540622183;25315.367115822253;35260.29479410346;35491.46762798508;39824;40321.1935761289;40345.59654403536;40347.79826100851;40653.796731016155;34586.82706586451;34878.476822848184;34930;34948.30103397969;35145;34311;34418.48372274468;34443.65556344505;34703.826480867436;34828.303433930676;34176.82911585426;34775;34988.65011349854;35194.47208291929;35215.11962200965;30532.542011870282;31950.48544660132;31972.6802731979;32111.35777284488;32192.83903580467;24082.51834963256;25243.95650376371;26739.93040278367;26879.328016799736;26975.595366069916 07:48:42 INFO - PROCESS | 32705 | |2;jquery.html;332.10994534647165;354.4930749028889;362.8820633294179;363.92903383840155;380.59846861561044;12486.875131248686;13442.731145377087;15482.999999999985;16257.268422920968;17223.311067557283;15249.92375038126;15266.160361180131;15498.07011579306;15569;15644.843551564481;4554.2485489894125;4868.97565512172;5131.871703207413;5137;5139.717315547643;4911.361523002005;4957.727324997124;4961.503849615027;4965.28003439501;5014.423341315741;4926.655134140611;4927.950720492803;4933.914538801476;4934;4935.6545041847085;4754.38193034905;4929.433115191745;4944.826931057396;4965.354503914468;4968.428630707479;4497.820087196541;4534.79593418297;4536.138133754576;4537.092581483684;4539.750313732743;20228.595428091503;20245.696314555295;20393.4901627459;20515.897420512803;20554.28060017892;1788.0702034941758;1805.0974512743628;1825.853931685462;1953.9218431262732;2334.253039027512;12299.93850030744;13018.414171362312;13454.32728363578;13671.931640341834;13723.45106195751;1687.856532194765;1740.9912950435166;1747.9650406991916;1774.130675968766;1812.1482903035553;64868;67780;67882.32117678858;68410.31589684139;69553.65223173852;9004.36969412135;9102.726918192464;9116.903112284212;9523.19052880513;9746.171575416169;12997;13010.21938683682;13016.869831301567;13020.348982550835;13022;6841.3842754152365;7079.929200707927;7111.431085513146;7147.452074859165;7194.856102877913;6674.83312917181;6802.8299292517095;6813.727450902007;6887.7244910203035;7007.054047703597;5825.592208545446;5827.213326200994;5834.912476312858;5944.494717948936;6139.469804862133;1681.8738594605454;1687.3082036365277;1711.2641564127296;1719.2091637846731;1745.223375597872;759.1004659478535;797.6131576185545;804.103424681476;806.717648822919;902.8692286204551;16423.6715265694;16770.059036126502;17144.742828857576;17281.481555553353;17679;835.2107258640526;842.2756429470651;864.3862857371337;866;875.5315905990265;9200.6779762708;9694;9697.806043879084;10032.749181270527;10036.482689437975;303259.48370258446;358942;363596;363929;363983;67537;67748.32251677518;68090.3190968084;68180.3181968174;68689;851.646566674823;856.3662889461878;875.7504111328241;887.9067697891758;894.3024440936081;14914.403423862925;15228.77156842626;15663.216839158224;16032.198390080683;16094.839051609333;33914.830425847715;34077.318453631284;34314.656853431145;34358;35591.64408355884;44603.33095003643;45316.32025519686;45734.54265457303;46070.76964615155;46534;7275.599842008741;7342.339189472973;7429.405647548075;7480.663370148465;8009.759707208793;11737.295762254293;11929.164958452826;11997.580084696994;12027.579034733742;12412.70364982481;9895.455749933823;10016.298859079794;10200.846987295345;10372.844407333745;10767.407792571485;9936.453495057842;10087.193024558164;10501.212409069198;10542.789144217226;10657.733556661145;9927.305088643725;10485;10742.677719668422;11081.11351091927;11175.273607215506;7414.888776668462;7581.54510729358;7693.576853273124;7714.421418393531;7858.410619203697;10176.389416635026;10300.536475858455;10415.739606509898;10512.1617163367;10819.296745711503 07:48:42 INFO - PROCESS | 32705 | |3;mootools.html;1190.6130507585026;1312.1208790110622;1351.567498400512;1371.924544150072;1615.1924037981016;5990.790322338719;6711.798646040615;6926.099607051083;6951.617661028641;7133.6789844457;6999.65001749913;7058.823529411768;7068.222495525488;7075.363217310441;7077;1768.3103589600003;2076.096897849433;2109.177420805887;2114.0909408954144;2114.228306668063;1850.5928695686928;2068.979310206901;2134.7651758306574;2135.306025541697;2141.903614337351;2070.7214142289863;2078.698588704637;2089.3836318286144;2096.308218287961;2096.4234835420307;2065.1532871522604;2080.365488525999;2080.8127268545904;2081.479630092477;2082.3648787119923;2119.3959721479305;2124.0866427436194;2130.446084018151;2141.2077531313357;2145.967810482844;7067.293270672943;7074.717011319541;7122.857542849114;7132.893006604905;7136.0723105995885;4250.936235956463;4389.978050109729;4391.6047555719815;4400.119976004812;4420.690551661385;2580.0711743772226;2657.747513986168;2756.8621568921676;2798.678152012524;2820.3654177810035;831.2061980808313;864.6671031652859;870.3559366069127;878.89892662344;879.4802889720968;9310.86033709495;9337.579808908547;9407.388519746262;9422.85865712008;9424.387414818015;3777.9244415111543;3872.302985462644;3994.6205110514456;4062.0657248832936;4067.7152599318356;8078.757637270891;8082.19178082187;8086.1913808618665;8096.433249672466;8115.147909469539;4284.764337961442;4294;4302.290122129876;4314.71954322968;4317.158154159909;3415.077928959167;3504.667056629616;3928.980355098206;3942.191850670663;3942.7831469269468;3232.612086549629;3297.6702329767313;3388.271521622863;3424.280901010816;3432.8626854926024;1128.136975213962;1133.195431243826;1134.8921852424007;1143.616888342398;1150.4707834396272;691.4330249195611;814.2793627639463;822.4160845799549;846.9370939470924;867.7440155154245;4712.835050773207;4773.403324584427;4981.405950095935;5011.799528018839;5063.06333328328;843.4138273899581;843.7468759372164;870.460314604949;870.5647176411794;913.5751875377848;3411.1983683834774;3444.0356700124007;3454.157570453172;3483.651634836496;3704;8262.049864265686;8371.748847534584;8454.40819142654;8484.36367272457;8522.275606573387;7900.328472079823;8198.549079800548;8413.831723365498;8430.15698430152;8456.238938495442;6511.739530418825;6672.766453174116;6697.665116744143;6722.0253063305545;6723.798286051427;4830.589399901048;4836.975815120902;4967.503249675004;5029.346184995927;5202.959408118467;7379.8155046124275;7457.776266712007;7550.584717840352;7610.391168706601;7762.4178186637355;7819.41354398411;7820.608969551386;7825.882611760714;7827.25641064098;7917.208279172267;5291.497307755757;5492.873960837938;5980;6154.230721159855;6156.984097624021;6371.776987805404;6642.169728783902;6645.568038077509;6789.762358317435;6797.252302246848;6001.309849367379;6043.580368025307;6141.84645383869;6200.875982480235;6214.9067763982675;5951.256092988377;5989.281286245504;6003.339632640319;6010.969945150421;6016.4585187331595;5721.399253078367;5865.530757539472;5878.735456904535;5887.970560147171;5895.616784909139;4229.111886503869;4236.301010333261;4324.697271190987;4336.352186169235;4429.357743127293;4251.171021650748;4311.611954924072;4323.956760432356;4355.455568053993;4466.687331886867 07:48:42 INFO - PROCESS | 32705 | |4;prototype.html;284.68968823981857;285.4633289415898;291.47098017098966;294.4684843856839;299.73174009261726;4573.611243044337;4673.228917228653;4690.953090469098;4747.952520474794;4768.16557102507;4549.72701637902;4650.604698600623;4660.533946605337;4691.859244222679;4703.129920964624;3679.4112941929297;3693.3351996640663;3698.7054530914234;3701.703863690912;3718.3678774608247;3500.912477188065;3624.1664417184065;3701.24124554467;3714.962850371489;3724.4971928789673;3560.2523470071314;3616.3490571697216;3661.487391765155;3672.761270517421;3684.778913265199;3657.140571965586;3662.157703728144;3662.597114317423;3667.651573100551;3668.963310366889;3255.6418793932885;3259.7392208623255;3262.4943133814295;3269.836508174582;3279.360524697685;4416.3375493675885;4479.664025198123;4561;4592.609628181609;4614.284785858197;4161.084561396518;4173.979130104361;4183.1215444756635;4185.869815149892;4191.476065491814;4833.63747718919;4888.535589119064;4896.192128298826;4902.215645496739;4902.460729319772;3481.7736847104857;3555.768875023115;3559.6440355964455;3569.660882216185;3574.338747331752;5081.59347252219;5091.0072535855525;5092.312537807348;5094.369801663469;5103.642745007851;3606.2607165531003;3612.422012477991;3618.565772107364;3620.2759448110482;3638.9818050910108;3653.5615726113037;3670.6329367063613;3671.9265614688093;3678;3693.298273328059;4033.3143365627916;4150.667946564267;4160.271952408317;4189.2459357315365;4191.8532851350665;4874.46380898101;4887.437944636341;4897.7795999180125;4898.2652602109965;4960.107180707435;1180.6340034589134;1200.3878022208562;1206.913777600167;1218.4821450883517;1234.4383305595932;831.6299246835222;836.7698882807155;850.2645211891793;852.4586887326592;870.4124715816924;4167.374893765959;4169.937450938239;4175.123224122907;4179.561146079679;4187.727797693201;4731.4795372509;4834.896819883292;4860.513948605111;4861.368022157097;4877.5366340197625;4081;4104.035551645361;4132.450331125828;4139.4542356450565;4147.129102888367;2431.878406079689;2556.2331300609744;2562.666853309095;2570.586177602311;2601.7658410743124;4546.545345465427;4570.908581828411;4574.656900732459;4584.9312260315455;4586.151561961048;4927.334809800703;4953.529414705597;4985.077760614298;4993.425756038102;5000.724960127155;4386.210482113251;4486.7083639563325;4494.865154045384;4519.367288579601;4530.957879687624;4812.470628230962;4819.542143496362;4820.927686084781;4827.831025914076;4856.514348565115;4740.170470167638;4758.833440829554;4767.976160119316;4768.8092476301945;4774.1883879739835;4398;4438.423005009328;4494.640428765756;4528.773561321855;4537.727736335831;3505.3690335738793;3513.6135025147723;3514.9824250879606;3522.172289512014;3527.8412471438332;4785.425748910153;4823.758812059453;4842.927356089591;4855.830045948375;4867.269909513601;4701.506341834058;4792.976035119802;4839.467658557626;4918.92621610669;4919.655624106278;4921.8523444296725;4923.581495572773;4926.162552366035;4926.285688575065;4932.2601609757385;4866.343043689199;4879.4873589186045;4879.999600082046;4884.755762211804;4894.755262236945;4793.808247670054;4975.253711943237;5004.374453193351;5024.723640199824;5032.345795046621;4905.6075513958085;4906.975465122651;4912.901741965212;4913.680610760289;4915.304220044079 07:48:42 INFO - PROCESS | 32705 | |5;yui.html;612.3662009819836;657.7895073576454;709.4714437743881;719.5251134251395;735.8675438421088;12596.118271720972;13494.662633434169;13516.729665406687;13541.661458463532;14130.71738565228;14407.711845763079;15389.923050384761;15410.30653620587;15413.229338533056;15421.537353879374;606.5420607441398;732.3372348025046;754.8188434775642;756.4477931110292;756.9545827250355;616.8303716477982;725.5501589014818;746.0301607909696;747.1482509938675;753.5666991479893;782.3584660578329;784.7449578886856;784.7528028670979;785.6582386661792;787.7991112266365;629.8740251949629;790.2768966395741;790.9881351779728;791.0230864881867;791.1020991175029;471.26482687008036;556.0769123255377;572.3961220911937;572.5047833623885;575.4130786597689;13410.46358145673;13463.932680336633;13521.797173042412;13531.188128712309;13559.661008474768;12233.449494772756;12518.81221781674;12826;12834.614961551168;13000;10142.39145651256;10544;10921.781564368668;10972.506237219344;11092.55629774808;3146.433641944472;3159.794613350125;3180.791299306272;3277.672232776727;3302.3230237801195;65814.67092664554;67464;68637.31362686359;69249;70938;9392.248620110375;9412.435253884789;9504.809903802023;9707.90292097084;9747.317687761788;18856.905715471334;18962.14670339838;18967.71548426775;19012.714809277873;19254.61490770177;6311.652859092794;6343.429091381798;6344.651044192521;6542.574732642363;6626.602403855784;3503.0366649171174;3554.4668299754726;3579.785212887235;3630.8366123524506;3637.308911306843;2794.399204171072;2862;2899.159243819311;2900.579415984713;2911.7525010373934;466.9182892993712;470.8540352490739;475.36301356182884;477.41993477923796;480.52908150013184;442.1716203498557;496.581647377275;566.9603127781098;585.6983653418492;588.3381196154327;7728.7681369559;7832.530162338173;7998.12020677725;8127.59362031896;8239.835203295901;547.887683024979;565.2538648983302;591.6065816232158;596.7016491754123;610.5146408605169;3698.1124530113116;3844.461775351453;3922.5096862892137;4052.5947405259826;4108.157827645326;67842;68599.65700171568;70328.94506582405;71155.6442217796;71442.64278678573;60339;62411;63337.68331158315;63805.36194638087;64865;51192.488075119516;54056;54688.45311546913;54978.725106374215;55537.44462555404;7743.186965368555;7991.920080799117;8137.511749294825;8209.739461474222;8397.412181147261;32552.51171232481;32977.505337419476;37831.43252851265;39535.406968896066;40270.79864600658;45514.31728524008;53060.469395305554;53093.20360194678;53431.46568534265;53698;9492.240620750184;9708.5145742714;9734.659286924923;9775.071368220008;9912.851307230541;10413.47932603382;10690.57237710514;10819.621313253998;11053.392063436588;11578.305301681927;10386.688399348031;10525.105366043972;10761.085307748615;11244.325340479598;11797.764044718886;11654.359010254517;11742.530298787953;11782.941085294862;11945.522179112739;12290.631281061582;11177.105831533621;11260.211785175286;11415.600453984403;12386.380680966096;12401.689957751129;9642.180414664832;9887.110160085627;9901.950490247502;10129.696109116738;10525.368477891045;9771.755706107404;10172.643957461749;10225.130863876653;10251.38491690501;10293.485325733534 07:48:42 INFO - PROCESS | 32705 | __end_tp_report 07:48:42 INFO - PROCESS | 32705 | __start_cc_report 07:48:42 INFO - PROCESS | 32705 | _x_x_mozilla_cycle_collect,1372 07:48:42 INFO - PROCESS | 32705 | __end_cc_report 07:48:42 INFO - PROCESS | 32705 | __startTimestamp1480866522865__endTimestamp 07:48:42 INFO - PROCESS | 32705 | 07:48:42 INFO - PROCESS | 32705 | ------- Summary: start ------- 07:48:42 INFO - PROCESS | 32705 | Number of tests: 6 07:48:42 INFO - PROCESS | 32705 | 07:48:42 INFO - PROCESS | 32705 | [#0] dojo.html Cycles:165 Average:4573.93 Median:4673.77 stddev:473.44 (10.1%) stddev-sans-first:447.60 07:48:42 INFO - PROCESS | 32705 | Values: 2554.3 2588.6 2603.6 2617.6 2629.9 4471.3 4542.1 4612.6 4623.5 4629.7 4547.9 4569.5 4576.4 4583.8 4589.9 4198.2 4202.0 4208.6 4238.9 4279.6 4265.8 4272.0 4310.1 4325.9 4337.6 4339.6 4360.6 4362.7 4376.8 4392.2 4345.6 4345.9 4347.9 4372.9 4386.2 4142.3 4215.0 4260.4 4272.9 4323.0 4682.9 4701.7 4703.3 4714.3 4739.1 5021.5 5027.2 5027.2 5030.2 5065.6 4806.7 4847.8 4855.0 5039.1 5041.2 4580.6 4593.3 4616.6 4626.4 4670.2 5029.9 5032.0 5032.9 5037.6 5072.4 4704.8 4826.5 4829.5 4835.0 4874.9 4822.1 4879.2 4936.7 4966.2 4989.0 4933.9 4935.4 4935.5 4941.8 4978.2 4922.1 4924.0 4928.1 4929.1 4962.7 4096.5 4130.0 4130.1 4139.3 4239.7 3650.4 3661.2 3699.3 3706.8 3728.3 4238.3 4239.3 4240.9 4247.3 4256.4 4914.8 4935.9 4983.3 4988.2 5037.0 4210.3 4221.3 4270.0 4270.1 4276.4 4448.2 4467.2 4507.6 4507.7 4508.2 4648.3 4650.9 4654.0 4654.1 4697.5 4857.2 4976.4 4990.5 4990.8 5032.8 4551.8 4562.7 4589.7 4605.9 4618.7 4836.8 4865.3 4865.5 4909.4 4910.8 4919.9 4922.9 4930.0 4931.3 4967.1 4570.4 4667.5 4673.8 4787.4 4809.9 4793.4 4860.3 4862.7 4881.2 4907.0 4781.8 4797.2 4797.3 4802.8 4853.3 4673.0 4707.8 4904.8 4911.3 4939.1 4690.3 4715.6 4765.0 4775.3 4806.8 07:48:42 INFO - PROCESS | 32705 | 07:48:42 INFO - PROCESS | 32705 | [#1] ext.html Cycles:180 Average:45002.19 Median:193439.24 stddev:77826.80 (40.2%) stddev-sans-first:77973.60 07:48:42 INFO - PROCESS | 32705 | Values: 564.4 576.1 580.7 582.8 591.9 27796.3 30455.0 38951.0 40169.8 40487.2 38982.6 39423.0 39475.4 39490.2 39572.8 7588.2 7746.6 7746.8 7747.3 7748.8 7355.6 7541.0 7559.1 9665.4 9907.6 9971.3 10012.8 10032.4 10040.6 10044.6 9874.5 9920.6 9920.6 9932.5 9933.1 9763.2 9862.0 9862.7 9865.4 9865.5 36828.3 37247.4 37286.6 37309.1 37337.1 2934.1 3161.3 3191.3 3422.7 3449.3 27926.7 27938.4 28404.0 28521.4 30063.4 3462.8 3493.2 3511.7 3576.5 3591.2 239433.2 239456.8 239598.0 241241.0 241364.0 51930.5 52462.5 52485.2 52503.7 52510.2 54308.7 54357.0 54364.5 54396.7 54402.5 14212.8 14402.9 14411.0 14421.8 14431.4 9678.0 11194.0 11196.9 11222.8 11261.3 14218.4 16091.7 16655.9 16799.2 17290.0 5931.8 6179.1 6187.0 6307.4 6339.3 757.3 836.3 888.5 900.8 997.9 25385.6 27286.8 27541.9 27726.9 27886.0 968.9 971.0 979.2 997.3 1027.2 13442.9 14453.2 14600.2 14786.3 14846.5 351684.0 353322.0 354441.0 354530.0 354897.0 47315.8 47338.3 47531.5 47544.3 47725.5 1022.8 1107.4 1127.3 1137.0 1162.8 25057.4 28269.9 28366.7 28697.6 29152.9 40485.4 40771.0 40785.8 40816.0 40821.4 284414.0 285653.0 285985.0 286098.0 286232.0 23832.8 24891.9 25315.4 35260.3 35491.5 39824.0 40321.2 40345.6 40347.8 40653.8 34586.8 34878.5 34930.0 34948.3 35145.0 34311.0 34418.5 34443.7 34703.8 34828.3 34176.8 34775.0 34988.7 35194.5 35215.1 30532.5 31950.5 31972.7 32111.4 32192.8 24082.5 25244.0 26739.9 26879.3 26975.6 07:48:42 INFO - PROCESS | 32705 | 07:48:42 INFO - PROCESS | 32705 | [#2] jquery.html Cycles:180 Average:22685.19 Median:24907.07 stddev:58004.23 (232.9%) stddev-sans-first:58142.66 07:48:42 INFO - PROCESS | 32705 | Values: 332.1 354.5 362.9 363.9 380.6 12486.9 13442.7 15483.0 16257.3 17223.3 15249.9 15266.2 15498.1 15569.0 15644.8 4554.2 4869.0 5131.9 5137.0 5139.7 4911.4 4957.7 4961.5 4965.3 5014.4 4926.7 4928.0 4933.9 4934.0 4935.7 4754.4 4929.4 4944.8 4965.4 4968.4 4497.8 4534.8 4536.1 4537.1 4539.8 20228.6 20245.7 20393.5 20515.9 20554.3 1788.1 1805.1 1825.9 1953.9 2334.3 12299.9 13018.4 13454.3 13671.9 13723.5 1687.9 1741.0 1748.0 1774.1 1812.1 64868.0 67780.0 67882.3 68410.3 69553.7 9004.4 9102.7 9116.9 9523.2 9746.2 12997.0 13010.2 13016.9 13020.3 13022.0 6841.4 7079.9 7111.4 7147.5 7194.9 6674.8 6802.8 6813.7 6887.7 7007.1 5825.6 5827.2 5834.9 5944.5 6139.5 1681.9 1687.3 1711.3 1719.2 1745.2 759.1 797.6 804.1 806.7 902.9 16423.7 16770.1 17144.7 17281.5 17679.0 835.2 842.3 864.4 866.0 875.5 9200.7 9694.0 9697.8 10032.7 10036.5 303259.5 358942.0 363596.0 363929.0 363983.0 67537.0 67748.3 68090.3 68180.3 68689.0 851.6 856.4 875.8 887.9 894.3 14914.4 15228.8 15663.2 16032.2 16094.8 33914.8 34077.3 34314.7 34358.0 35591.6 44603.3 45316.3 45734.5 46070.8 46534.0 7275.6 7342.3 7429.4 7480.7 8009.8 11737.3 11929.2 11997.6 12027.6 12412.7 9895.5 10016.3 10200.8 10372.8 10767.4 9936.5 10087.2 10501.2 10542.8 10657.7 9927.3 10485.0 10742.7 11081.1 11175.3 7414.9 7581.5 7693.6 7714.4 7858.4 10176.4 10300.5 10415.7 10512.2 10819.3 07:48:42 INFO - PROCESS | 32705 | 07:48:42 INFO - PROCESS | 32705 | [#3] mootools.html Cycles:180 Average:4652.78 Median:5392.19 stddev:2478.78 (46.0%) stddev-sans-first:2472.07 07:48:42 INFO - PROCESS | 32705 | Values: 1190.6 1312.1 1351.6 1371.9 1615.2 5990.8 6711.8 6926.1 6951.6 7133.7 6999.7 7058.8 7068.2 7075.4 7077.0 1768.3 2076.1 2109.2 2114.1 2114.2 1850.6 2069.0 2134.8 2135.3 2141.9 2070.7 2078.7 2089.4 2096.3 2096.4 2065.2 2080.4 2080.8 2081.5 2082.4 2119.4 2124.1 2130.4 2141.2 2146.0 7067.3 7074.7 7122.9 7132.9 7136.1 4250.9 4390.0 4391.6 4400.1 4420.7 2580.1 2657.7 2756.9 2798.7 2820.4 831.2 864.7 870.4 878.9 879.5 9310.9 9337.6 9407.4 9422.9 9424.4 3777.9 3872.3 3994.6 4062.1 4067.7 8078.8 8082.2 8086.2 8096.4 8115.1 4284.8 4294.0 4302.3 4314.7 4317.2 3415.1 3504.7 3929.0 3942.2 3942.8 3232.6 3297.7 3388.3 3424.3 3432.9 1128.1 1133.2 1134.9 1143.6 1150.5 691.4 814.3 822.4 846.9 867.7 4712.8 4773.4 4981.4 5011.8 5063.1 843.4 843.7 870.5 870.6 913.6 3411.2 3444.0 3454.2 3483.7 3704.0 8262.0 8371.7 8454.4 8484.4 8522.3 7900.3 8198.5 8413.8 8430.2 8456.2 6511.7 6672.8 6697.7 6722.0 6723.8 4830.6 4837.0 4967.5 5029.3 5203.0 7379.8 7457.8 7550.6 7610.4 7762.4 7819.4 7820.6 7825.9 7827.3 7917.2 5291.5 5492.9 5980.0 6154.2 6157.0 6371.8 6642.2 6645.6 6789.8 6797.3 6001.3 6043.6 6141.8 6200.9 6214.9 5951.3 5989.3 6003.3 6011.0 6016.5 5721.4 5865.5 5878.7 5888.0 5895.6 4229.1 4236.3 4324.7 4336.4 4429.4 4251.2 4311.6 4324.0 4355.5 4466.7 07:48:42 INFO - PROCESS | 32705 | 07:48:42 INFO - PROCESS | 32705 | [#4] prototype.html Cycles:180 Average:4023.06 Median:4534.34 stddev:1156.56 (25.5%) stddev-sans-first:1125.25 07:48:42 INFO - PROCESS | 32705 | Values: 284.7 285.5 291.5 294.5 299.7 4573.6 4673.2 4691.0 4748.0 4768.2 4549.7 4650.6 4660.5 4691.9 4703.1 3679.4 3693.3 3698.7 3701.7 3718.4 3500.9 3624.2 3701.2 3715.0 3724.5 3560.3 3616.3 3661.5 3672.8 3684.8 3657.1 3662.2 3662.6 3667.7 3669.0 3255.6 3259.7 3262.5 3269.8 3279.4 4416.3 4479.7 4561.0 4592.6 4614.3 4161.1 4174.0 4183.1 4185.9 4191.5 4833.6 4888.5 4896.2 4902.2 4902.5 3481.8 3555.8 3559.6 3569.7 3574.3 5081.6 5091.0 5092.3 5094.4 5103.6 3606.3 3612.4 3618.6 3620.3 3639.0 3653.6 3670.6 3671.9 3678.0 3693.3 4033.3 4150.7 4160.3 4189.2 4191.9 4874.5 4887.4 4897.8 4898.3 4960.1 1180.6 1200.4 1206.9 1218.5 1234.4 831.6 836.8 850.3 852.5 870.4 4167.4 4169.9 4175.1 4179.6 4187.7 4731.5 4834.9 4860.5 4861.4 4877.5 4081.0 4104.0 4132.5 4139.5 4147.1 2431.9 2556.2 2562.7 2570.6 2601.8 4546.5 4570.9 4574.7 4584.9 4586.2 4927.3 4953.5 4985.1 4993.4 5000.7 4386.2 4486.7 4494.9 4519.4 4531.0 4812.5 4819.5 4820.9 4827.8 4856.5 4740.2 4758.8 4768.0 4768.8 4774.2 4398.0 4438.4 4494.6 4528.8 4537.7 3505.4 3513.6 3515.0 3522.2 3527.8 4785.4 4823.8 4842.9 4855.8 4867.3 4701.5 4793.0 4839.5 4918.9 4919.7 4921.9 4923.6 4926.2 4926.3 4932.3 4866.3 4879.5 4880.0 4884.8 4894.8 4793.8 4975.3 5004.4 5024.7 5032.3 4905.6 4907.0 4912.9 4913.7 4915.3 07:48:42 INFO - PROCESS | 32705 | 07:48:42 INFO - PROCESS | 32705 | [#5] yui.html Cycles:180 Average:15420.64 Median:52126.48 stddev:19989.24 (38.3%) stddev-sans-first:20014.39 07:48:42 INFO - PROCESS | 32705 | Values: 612.4 657.8 709.5 719.5 735.9 12596.1 13494.7 13516.7 13541.7 14130.7 14407.7 15389.9 15410.3 15413.2 15421.5 606.5 732.3 754.8 756.4 757.0 616.8 725.6 746.0 747.1 753.6 782.4 784.7 784.8 785.7 787.8 629.9 790.3 791.0 791.0 791.1 471.3 556.1 572.4 572.5 575.4 13410.5 13463.9 13521.8 13531.2 13559.7 12233.4 12518.8 12826.0 12834.6 13000.0 10142.4 10544.0 10921.8 10972.5 11092.6 3146.4 3159.8 3180.8 3277.7 3302.3 65814.7 67464.0 68637.3 69249.0 70938.0 9392.2 9412.4 9504.8 9707.9 9747.3 18856.9 18962.1 18967.7 19012.7 19254.6 6311.7 6343.4 6344.7 6542.6 6626.6 3503.0 3554.5 3579.8 3630.8 3637.3 2794.4 2862.0 2899.2 2900.6 2911.8 466.9 470.9 475.4 477.4 480.5 442.2 496.6 567.0 585.7 588.3 7728.8 7832.5 7998.1 8127.6 8239.8 547.9 565.3 591.6 596.7 610.5 3698.1 3844.5 3922.5 4052.6 4108.2 67842.0 68599.7 70328.9 71155.6 71442.6 60339.0 62411.0 63337.7 63805.4 64865.0 51192.5 54056.0 54688.5 54978.7 55537.4 7743.2 7991.9 8137.5 8209.7 8397.4 32552.5 32977.5 37831.4 39535.4 40270.8 45514.3 53060.5 53093.2 53431.5 53698.0 9492.2 9708.5 9734.7 9775.1 9912.9 10413.5 10690.6 10819.6 11053.4 11578.3 10386.7 10525.1 10761.1 11244.3 11797.8 11654.4 11742.5 11782.9 11945.5 12290.6 11177.1 11260.2 11415.6 12386.4 12401.7 9642.2 9887.1 9902.0 10129.7 10525.4 9771.8 10172.6 10225.1 10251.4 10293.5 07:48:42 INFO - PROCESS | 32705 | -------- Summary: end -------- 07:48:42 INFO - PROCESS | 32705 | 07:48:43 INFO - TEST-INFO | 32705: exit 0 07:48:43 INFO - TEST-OK | dromaeo_css | took 1122362ms 07:48:43 INFO - TEST-START | kraken 07:48:43 INFO - operating with platform_type : linux_ 07:48:43 INFO - Initialising browser for kraken test... 07:48:43 INFO - TEST-INFO | started process 649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpysV5gF/profile http://localhost:47091/getInfo.html) 07:48:48 INFO - PROCESS | 649 | __metrics Screen width/height:1600/1200 07:48:48 INFO - PROCESS | 649 | colorDepth:24 07:48:48 INFO - PROCESS | 649 | Browser inner width/height: 1024/697 07:48:48 INFO - PROCESS | 649 | __metrics 07:48:48 INFO - PROCESS | 649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:48:48 INFO - PROCESS | 649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:48:49 INFO - PROCESS | 649 | console.error: PushService: 07:48:49 INFO - PROCESS | 649 | stateChangeProcessEnqueue: Error transitioning state 07:48:49 INFO - PROCESS | 649 | UnknownError 07:48:50 INFO - TEST-INFO | 649: exit 0 07:48:50 INFO - Browser initialized. 07:48:50 INFO - Running cycle 1/1 for kraken test... 07:48:50 INFO - TEST-INFO | started process 735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpysV5gF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:49:02 INFO - PROCESS | 735 | RSS: Main: 173522944 07:49:02 INFO - PROCESS | 735 | 07:49:05 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:47091/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47091/tests/kraken/driver.html?testName=audio-beat-detection) 07:49:06 INFO - PROCESS | 735 | RSS: Main: 239591424 07:49:06 INFO - PROCESS | 735 | 07:49:08 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:47091/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47091/tests/kraken/driver.html?testName=audio-dft) 07:49:09 INFO - PROCESS | 735 | RSS: Main: 217726976 07:49:09 INFO - PROCESS | 735 | 07:49:12 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:47091/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47091/tests/kraken/driver.html?testName=audio-fft) 07:49:13 INFO - PROCESS | 735 | RSS: Main: 300367872 07:49:13 INFO - PROCESS | 735 | 07:49:15 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:47091/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47091/tests/kraken/driver.html?testName=audio-oscillator) 07:49:15 INFO - PROCESS | 735 | RSS: Main: 211251200 07:49:15 INFO - PROCESS | 735 | 07:49:18 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:47091/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47091/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:49:18 INFO - PROCESS | 735 | RSS: Main: 214999040 07:49:18 INFO - PROCESS | 735 | 07:49:22 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:47091/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47091/tests/kraken/driver.html?testName=imaging-darkroom) 07:49:22 INFO - PROCESS | 735 | RSS: Main: 254050304 07:49:22 INFO - PROCESS | 735 | 07:49:26 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:47091/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47091/tests/kraken/driver.html?testName=imaging-desaturate) 07:49:26 INFO - PROCESS | 735 | RSS: Main: 248631296 07:49:26 INFO - PROCESS | 735 | 07:49:29 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:47091/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47091/tests/kraken/driver.html?testName=json-parse-financial) 07:49:30 INFO - PROCESS | 735 | RSS: Main: 249913344 07:49:30 INFO - PROCESS | 735 | 07:49:32 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:47091/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47091/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:49:32 INFO - PROCESS | 735 | RSS: Main: 213405696 07:49:32 INFO - PROCESS | 735 | 07:49:34 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:47091/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47091/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:49:35 INFO - PROCESS | 735 | RSS: Main: 221687808 07:49:35 INFO - PROCESS | 735 | 07:49:37 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:47091/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47091/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:49:37 INFO - PROCESS | 735 | RSS: Main: 229498880 07:49:37 INFO - PROCESS | 735 | 07:49:40 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:47091/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47091/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:49:41 INFO - PROCESS | 735 | RSS: Main: 237928448 07:49:41 INFO - PROCESS | 735 | 07:49:44 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:47091/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47091/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:49:45 INFO - PROCESS | 735 | RSS: Main: 234971136 07:49:45 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | Cycle 1(1): loaded http://localhost:47091/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47091/tests/kraken/driver.html?testName=ai-astar) 07:49:47 INFO - PROCESS | 735 | RSS: Main: 286412800 07:49:47 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | __start_tp_report 07:49:47 INFO - PROCESS | 735 | _x_x_mozilla_page_load 07:49:47 INFO - PROCESS | 735 | _x_x_mozilla_page_load_details 07:49:47 INFO - PROCESS | 735 | |i|pagename|runs| 07:49:47 INFO - PROCESS | 735 | |0;ai-astar;107;117;115;115;116;115;114;113;114;114 07:49:47 INFO - PROCESS | 735 | |1;audio-beat-detection;156;128;130;181;129;136;135;130;146;132 07:49:47 INFO - PROCESS | 735 | |2;audio-dft;162;160;162;161;162;163;162;163;161;161 07:49:47 INFO - PROCESS | 735 | |3;audio-fft;75;76;78;113;75;75;76;76;96;76 07:49:47 INFO - PROCESS | 735 | |4;audio-oscillator;83;85;113;85;83;83;103;84;84;114 07:49:47 INFO - PROCESS | 735 | |5;imaging-gaussian-blur;118;119;117;118;118;116;117;118;117;117 07:49:47 INFO - PROCESS | 735 | |6;imaging-darkroom;147;147;148;148;148;148;148;147;147;147 07:49:47 INFO - PROCESS | 735 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;95 07:49:47 INFO - PROCESS | 735 | |8;json-parse-financial;69;65;66;67;68;76;66;81;66;67 07:49:47 INFO - PROCESS | 735 | |9;json-stringify-tinderbox;66;67;66;65;66;66;67;66;66;66 07:49:47 INFO - PROCESS | 735 | |10;stanford-crypto-aes;84;86;91;94;84;85;85;84;84;85 07:49:47 INFO - PROCESS | 735 | |11;stanford-crypto-ccm;159;157;142;141;141;144;142;140;207;150 07:49:47 INFO - PROCESS | 735 | |12;stanford-crypto-pbkdf2;186;184;180;183;179;182;181;185;186;180 07:49:47 INFO - PROCESS | 735 | |13;stanford-crypto-sha256-iterative;79;69;72;72;75;71;71;71;74;69 07:49:47 INFO - PROCESS | 735 | __end_tp_report 07:49:47 INFO - PROCESS | 735 | __start_cc_report 07:49:47 INFO - PROCESS | 735 | _x_x_mozilla_cycle_collect,1973 07:49:47 INFO - PROCESS | 735 | __end_cc_report 07:49:47 INFO - PROCESS | 735 | __startTimestamp1480866587437__endTimestamp 07:49:47 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | ------- Summary: start ------- 07:49:47 INFO - PROCESS | 735 | Number of tests: 14 07:49:47 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:2.71 (2.4%) stddev-sans-first:1.20 07:49:47 INFO - PROCESS | 735 | Values: 107.0 117.0 115.0 115.0 116.0 115.0 114.0 113.0 114.0 114.0 07:49:47 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:135.50 stddev:16.81 (12.4%) stddev-sans-first:16.84 07:49:47 INFO - PROCESS | 735 | Values: 156.0 128.0 130.0 181.0 129.0 136.0 135.0 130.0 146.0 132.0 07:49:47 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 07:49:47 INFO - PROCESS | 735 | Values: 162.0 160.0 162.0 161.0 162.0 163.0 162.0 163.0 161.0 161.0 07:49:47 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:12.75 (16.8%) stddev-sans-first:13.29 07:49:47 INFO - PROCESS | 735 | Values: 75.0 76.0 78.0 113.0 75.0 75.0 76.0 76.0 96.0 76.0 07:49:47 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:83.50 stddev:12.97 (15.5%) stddev-sans-first:13.37 07:49:47 INFO - PROCESS | 735 | Values: 83.0 85.0 113.0 85.0 83.0 83.0 103.0 84.0 84.0 114.0 07:49:47 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 07:49:47 INFO - PROCESS | 735 | Values: 118.0 119.0 117.0 118.0 118.0 116.0 117.0 118.0 117.0 117.0 07:49:47 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:49:47 INFO - PROCESS | 735 | Values: 147.0 147.0 148.0 148.0 148.0 148.0 148.0 147.0 147.0 147.0 07:49:47 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:49:47 INFO - PROCESS | 735 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 07:49:47 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | [#8] json-parse-financial Cycles:10 Average:69.10 Median:67.50 stddev:5.22 (7.7%) stddev-sans-first:5.53 07:49:47 INFO - PROCESS | 735 | Values: 69.0 65.0 66.0 67.0 68.0 76.0 66.0 81.0 66.0 67.0 07:49:47 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 07:49:47 INFO - PROCESS | 735 | Values: 66.0 67.0 66.0 65.0 66.0 66.0 67.0 66.0 66.0 66.0 07:49:47 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.00 stddev:3.46 (4.1%) stddev-sans-first:3.57 07:49:47 INFO - PROCESS | 735 | Values: 84.0 86.0 91.0 94.0 84.0 85.0 85.0 84.0 84.0 85.0 07:49:47 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | [#11] stanford-crypto-ccm Cycles:10 Average:152.30 Median:147.00 stddev:20.42 (13.9%) stddev-sans-first:21.51 07:49:47 INFO - PROCESS | 735 | Values: 159.0 157.0 142.0 141.0 141.0 144.0 142.0 140.0 207.0 150.0 07:49:47 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.60 Median:183.50 stddev:2.59 (1.4%) stddev-sans-first:2.44 07:49:47 INFO - PROCESS | 735 | Values: 186.0 184.0 180.0 183.0 179.0 182.0 181.0 185.0 186.0 180.0 07:49:47 INFO - PROCESS | 735 | 07:49:47 INFO - PROCESS | 735 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.00 stddev:3.02 (4.2%) stddev-sans-first:2.01 07:49:47 INFO - PROCESS | 735 | Values: 79.0 69.0 72.0 72.0 75.0 71.0 71.0 71.0 74.0 69.0 07:49:47 INFO - PROCESS | 735 | -------- Summary: end -------- 07:49:47 INFO - PROCESS | 735 | 07:49:48 INFO - TEST-INFO | 735: exit 0 07:49:48 INFO - TEST-OK | kraken | took 64920ms 07:49:48 INFO - SUITE-END | took 1187s 07:49:49 INFO - Completed test suite (00:19:47) 07:49:49 INFO - javascript benchmark 07:49:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2554.32310437734, 2588.598767191084, 2603.5964425514044, 2617.5942728877017, 2629.894804207832, 4471.262241730119, 4542.136993971143, 4612.607928326092, 4623.468301145369, 4629.652776041794, 4547.909041819162, 4569.4745104313015, 4576.382188404565, 4583.839565615204, 4589.931151032729, 4198.160367926412, 4202.033532287575, 4208.558101399355, 4238.87283381499, 4279.572042795711, 4265.786710664454, 4271.97864010681, 4310.137972405516, 4325.870223893288, 4337.609615134637, 4339.566043395666, 4360.56394360563, 4362.694611377205, 4376.781160941956, 4392.231359512089, 4345.565443455661, 4345.891352716176, 4347.934780978304, 4372.890677733082, 4386.188555117314, 4142.275101857163, 4215.030542975132, 4260.44614200152, 4272.893177670583, 4323.027318853233, 4682.859514214579, 4701.670883038155, 4703.2709929960565, 4714.339992401066, 4739.0758802033615, 5021.472745361721, 5027.195648696191, 5027.195648696227, 5030.220315851049, 5065.569426598743, 4806.711597304173, 4847.781849816767, 4855.028994201174, 5039.067772462106, 5041.218611115283, 4580.587747102777, 4593.28804035375, 4616.6306695464955, 4626.352310676508, 4670.229412147026, 5029.924551131736, 5032.0, 5032.874178145503, 5037.571806396424, 5072.416672082758, 4704.788284527204, 4826.493218212107, 4829.468758436569, 4834.984653222792, 4874.903146792014, 4822.059698358787, 4879.219324908068, 4936.703797772145, 4966.230234313687, 4989.027139707722, 4933.925991110136, 4935.358403407534, 4935.457099719028, 4941.802327906916, 4978.22837460187, 4922.08941345845, 4923.975380123148, 4928.112939670822, 4929.13740095489, 4962.6774259673, 4096.528899176573, 4130.0294430808735, 4130.112025914443, 4139.275626765364, 4239.703220774578, 3650.4341827016856, 3661.176235347079, 3699.3341198584512, 3706.79612621303, 3728.291624591319, 4238.279492486223, 4239.27932251518, 4240.936385954213, 4247.341662042389, 4256.361545768098, 4914.8034078637165, 4935.90128197434, 4983.327250821165, 4988.226824842155, 5037.0, 4210.263203939298, 4221.303484925014, 4270.039241170712, 4270.103278311527, 4276.35854621803, 4448.243798554254, 4467.195904737114, 4507.616852567503, 4507.661925355612, 4508.18852606534, 4648.2562789953445, 4650.906981860411, 4654.0, 4654.1157180137025, 4697.4832768395445, 4857.247126695368, 4976.377952755905, 4990.525900039491, 4990.775415106256, 5032.84901452957, 4551.795169217459, 4562.726236425825, 4589.724616523019, 4605.861824145281, 4618.6536009800075, 4836.806527738851, 4865.294532292868, 4865.464798872192, 4909.361782968192, 4910.82812101589, 4919.877003074952, 4922.8769280768265, 4929.975350123226, 4931.3096166536, 4967.081089998362, 4570.405847239837, 4667.509911459248, 4673.766311684334, 4787.3776409066595, 4809.9038019240115, 4793.352897358812, 4860.270959356125, 4862.65961382714, 4881.219004959189, 4907.0431265904235, 4781.784819683192, 4797.208460603962, 4797.328374027708, 4802.831900883452, 4853.344798452164, 4673.0, 4707.78814953321, 4904.779284932258, 4911.312416261655, 4939.086269040239, 4690.296455531698, 4715.599174070242, 4764.976175119103, 4775.283707443772, 4806.831760888352], "value": 4544.087158798032, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.4355644355644, 576.1473019930503, 580.7154494297795, 582.7960213925126, 591.8520369907524, 27796.305092372702, 30455.0, 38951.0, 40169.79915100428, 40487.19025619493, 38982.610173898254, 39423.0, 39475.407868881986, 39490.21019579607, 39572.80213598928, 7588.203238659944, 7746.612669366537, 7746.8450630987345, 7747.3027427531515, 7748.767536973872, 7355.558666480001, 7541.0, 7559.055118110236, 9665.4200747955, 9907.603695852193, 9971.302008859382, 10012.849807252896, 10032.448215348153, 10040.598376064949, 10044.598216071385, 9874.506274686273, 9920.553575089067, 9920.603175872957, 9932.503374831302, 9933.056359645821, 9763.218942484584, 9862.013798620152, 9862.654807081717, 9865.408075515492, 9865.50672466381, 36828.263434731154, 37247.441288380694, 37286.627133728856, 37309.06727331811, 37337.066573335615, 2934.105097945126, 3161.3045130071346, 3191.2979144588153, 3422.6748458896363, 3449.3101379724158, 27926.720732792615, 27938.441231175264, 28404.0, 28521.429571408662, 30063.398732025238, 3462.8441720122655, 3493.1616412061176, 3511.666391692785, 3576.517170182018, 3591.1740299730945, 239433.2113357723, 239456.80271598705, 239598.0, 241241.0, 241364.0, 51930.48069519332, 52462.475375246526, 52485.24052569214, 52503.737481312346, 52510.21234681406, 54308.72845635826, 54357.0, 54364.45635543594, 54396.728016359666, 54402.45597544053, 14212.786808197885, 14402.927985360006, 14411.0, 14421.78367324491, 14431.3505892233, 9677.951610241904, 11194.0, 11196.888031119584, 11222.775544489064, 11261.268017578996, 14218.431262749582, 16091.678166436606, 16655.916720416564, 16799.16004199785, 17289.97425450541, 5931.822045338647, 6179.134921111048, 6187.0, 6307.432331090224, 6339.302676705559, 757.3411132314922, 836.2557323981662, 888.5201990924958, 900.8063266397625, 997.9151772099453, 25385.61921571178, 27286.846401975166, 27541.86229068882, 27726.861365693043, 27886.0, 968.8740463739668, 970.9951450242703, 979.1970584120952, 997.3394298493073, 1027.1833892055834, 13442.865571344162, 14453.205073721047, 14600.151866357537, 14786.260686965608, 14846.480373186887, 351684.0, 353322.0, 354441.0, 354530.0, 354897.0, 47315.76342118267, 47338.289925651145, 47531.52468475271, 47544.286835697494, 47725.5227447728, 1022.7954409118057, 1107.3687997841314, 1127.2898074213192, 1136.9943150284196, 1162.7906976744098, 25057.373565661004, 28269.858650706614, 28366.716332836408, 28697.569536457388, 29152.854235728686, 40485.39271910865, 40771.0, 40785.79607101945, 40816.0, 40821.38767918424, 284414.0, 285653.0, 285985.0, 286098.0, 286232.0, 23832.76167238375, 24891.875540622183, 25315.367115822253, 35260.29479410346, 35491.46762798508, 39824.0, 40321.1935761289, 40345.59654403536, 40347.79826100851, 40653.796731016155, 34586.82706586451, 34878.476822848184, 34930.0, 34948.30103397969, 35145.0, 34311.0, 34418.48372274468, 34443.65556344505, 34703.826480867436, 34828.303433930676, 34176.82911585426, 34775.0, 34988.65011349854, 35194.47208291929, 35215.11962200965, 30532.542011870282, 31950.48544660132, 31972.6802731979, 32111.35777284488, 32192.83903580467, 24082.51834963256, 25243.95650376371, 26739.93040278367, 26879.328016799736, 26975.595366069916], "value": 17500.507896007446, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.10994534647165, 354.4930749028889, 362.8820633294179, 363.92903383840155, 380.59846861561044, 12486.875131248686, 13442.731145377087, 15482.999999999985, 16257.268422920968, 17223.311067557283, 15249.92375038126, 15266.160361180131, 15498.07011579306, 15569.0, 15644.843551564481, 4554.2485489894125, 4868.97565512172, 5131.871703207413, 5137.0, 5139.717315547643, 4911.361523002005, 4957.727324997124, 4961.503849615027, 4965.28003439501, 5014.423341315741, 4926.655134140611, 4927.950720492803, 4933.914538801476, 4934.0, 4935.6545041847085, 4754.38193034905, 4929.433115191745, 4944.826931057396, 4965.354503914468, 4968.428630707479, 4497.820087196541, 4534.79593418297, 4536.138133754576, 4537.092581483684, 4539.750313732743, 20228.595428091503, 20245.696314555295, 20393.4901627459, 20515.897420512803, 20554.28060017892, 1788.0702034941758, 1805.0974512743628, 1825.853931685462, 1953.9218431262732, 2334.253039027512, 12299.93850030744, 13018.414171362312, 13454.32728363578, 13671.931640341834, 13723.45106195751, 1687.856532194765, 1740.9912950435166, 1747.9650406991916, 1774.130675968766, 1812.1482903035553, 64868.0, 67780.0, 67882.32117678858, 68410.31589684139, 69553.65223173852, 9004.36969412135, 9102.726918192464, 9116.903112284212, 9523.19052880513, 9746.171575416169, 12997.0, 13010.21938683682, 13016.869831301567, 13020.348982550835, 13022.0, 6841.3842754152365, 7079.929200707927, 7111.431085513146, 7147.452074859165, 7194.856102877913, 6674.83312917181, 6802.8299292517095, 6813.727450902007, 6887.7244910203035, 7007.054047703597, 5825.592208545446, 5827.213326200994, 5834.912476312858, 5944.494717948936, 6139.469804862133, 1681.8738594605454, 1687.3082036365277, 1711.2641564127296, 1719.2091637846731, 1745.223375597872, 759.1004659478535, 797.6131576185545, 804.103424681476, 806.717648822919, 902.8692286204551, 16423.6715265694, 16770.059036126502, 17144.742828857576, 17281.481555553353, 17679.0, 835.2107258640526, 842.2756429470651, 864.3862857371337, 866.0, 875.5315905990265, 9200.6779762708, 9694.0, 9697.806043879084, 10032.749181270527, 10036.482689437975, 303259.48370258446, 358942.0, 363596.0, 363929.0, 363983.0, 67537.0, 67748.32251677518, 68090.3190968084, 68180.3181968174, 68689.0, 851.646566674823, 856.3662889461878, 875.7504111328241, 887.9067697891758, 894.3024440936081, 14914.403423862925, 15228.77156842626, 15663.216839158224, 16032.198390080683, 16094.839051609333, 33914.830425847715, 34077.318453631284, 34314.656853431145, 34358.0, 35591.64408355884, 44603.33095003643, 45316.32025519686, 45734.54265457303, 46070.76964615155, 46534.0, 7275.599842008741, 7342.339189472973, 7429.405647548075, 7480.663370148465, 8009.759707208793, 11737.295762254293, 11929.164958452826, 11997.580084696994, 12027.579034733742, 12412.70364982481, 9895.455749933823, 10016.298859079794, 10200.846987295345, 10372.844407333745, 10767.407792571485, 9936.453495057842, 10087.193024558164, 10501.212409069198, 10542.789144217226, 10657.733556661145, 9927.305088643725, 10485.0, 10742.677719668422, 11081.11351091927, 11175.273607215506, 7414.888776668462, 7581.54510729358, 7693.576853273124, 7714.421418393531, 7858.410619203697, 10176.389416635026, 10300.536475858455, 10415.739606509898, 10512.1617163367, 10819.296745711503], "value": 8047.478089903886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1190.6130507585026, 1312.1208790110622, 1351.567498400512, 1371.924544150072, 1615.1924037981016, 5990.790322338719, 6711.798646040615, 6926.099607051083, 6951.617661028641, 7133.6789844457, 6999.65001749913, 7058.823529411768, 7068.222495525488, 7075.363217310441, 7077.0, 1768.3103589600003, 2076.096897849433, 2109.177420805887, 2114.0909408954144, 2114.228306668063, 1850.5928695686928, 2068.979310206901, 2134.7651758306574, 2135.306025541697, 2141.903614337351, 2070.7214142289863, 2078.698588704637, 2089.3836318286144, 2096.308218287961, 2096.4234835420307, 2065.1532871522604, 2080.365488525999, 2080.8127268545904, 2081.479630092477, 2082.3648787119923, 2119.3959721479305, 2124.0866427436194, 2130.446084018151, 2141.2077531313357, 2145.967810482844, 7067.293270672943, 7074.717011319541, 7122.857542849114, 7132.893006604905, 7136.0723105995885, 4250.936235956463, 4389.978050109729, 4391.6047555719815, 4400.119976004812, 4420.690551661385, 2580.0711743772226, 2657.747513986168, 2756.8621568921676, 2798.678152012524, 2820.3654177810035, 831.2061980808313, 864.6671031652859, 870.3559366069127, 878.89892662344, 879.4802889720968, 9310.86033709495, 9337.579808908547, 9407.388519746262, 9422.85865712008, 9424.387414818015, 3777.9244415111543, 3872.302985462644, 3994.6205110514456, 4062.0657248832936, 4067.7152599318356, 8078.757637270891, 8082.19178082187, 8086.1913808618665, 8096.433249672466, 8115.147909469539, 4284.764337961442, 4294.0, 4302.290122129876, 4314.71954322968, 4317.158154159909, 3415.077928959167, 3504.667056629616, 3928.980355098206, 3942.191850670663, 3942.7831469269468, 3232.612086549629, 3297.6702329767313, 3388.271521622863, 3424.280901010816, 3432.8626854926024, 1128.136975213962, 1133.195431243826, 1134.8921852424007, 1143.616888342398, 1150.4707834396272, 691.4330249195611, 814.2793627639463, 822.4160845799549, 846.9370939470924, 867.7440155154245, 4712.835050773207, 4773.403324584427, 4981.405950095935, 5011.799528018839, 5063.06333328328, 843.4138273899581, 843.7468759372164, 870.460314604949, 870.5647176411794, 913.5751875377848, 3411.1983683834774, 3444.0356700124007, 3454.157570453172, 3483.651634836496, 3704.0, 8262.049864265686, 8371.748847534584, 8454.40819142654, 8484.36367272457, 8522.275606573387, 7900.328472079823, 8198.549079800548, 8413.831723365498, 8430.15698430152, 8456.238938495442, 6511.739530418825, 6672.766453174116, 6697.665116744143, 6722.0253063305545, 6723.798286051427, 4830.589399901048, 4836.975815120902, 4967.503249675004, 5029.346184995927, 5202.959408118467, 7379.8155046124275, 7457.776266712007, 7550.584717840352, 7610.391168706601, 7762.4178186637355, 7819.41354398411, 7820.608969551386, 7825.882611760714, 7827.25641064098, 7917.208279172267, 5291.497307755757, 5492.873960837938, 5980.0, 6154.230721159855, 6156.984097624021, 6371.776987805404, 6642.169728783902, 6645.568038077509, 6789.762358317435, 6797.252302246848, 6001.309849367379, 6043.580368025307, 6141.84645383869, 6200.875982480235, 6214.9067763982675, 5951.256092988377, 5989.281286245504, 6003.339632640319, 6010.969945150421, 6016.4585187331595, 5721.399253078367, 5865.530757539472, 5878.735456904535, 5887.970560147171, 5895.616784909139, 4229.111886503869, 4236.301010333261, 4324.697271190987, 4336.352186169235, 4429.357743127293, 4251.171021650748, 4311.611954924072, 4323.956760432356, 4355.455568053993, 4466.687331886867], "value": 3817.6316730049716, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.68968823981857, 285.4633289415898, 291.47098017098966, 294.4684843856839, 299.73174009261726, 4573.611243044337, 4673.228917228653, 4690.953090469098, 4747.952520474794, 4768.16557102507, 4549.72701637902, 4650.604698600623, 4660.533946605337, 4691.859244222679, 4703.129920964624, 3679.4112941929297, 3693.3351996640663, 3698.7054530914234, 3701.703863690912, 3718.3678774608247, 3500.912477188065, 3624.1664417184065, 3701.24124554467, 3714.962850371489, 3724.4971928789673, 3560.2523470071314, 3616.3490571697216, 3661.487391765155, 3672.761270517421, 3684.778913265199, 3657.140571965586, 3662.157703728144, 3662.597114317423, 3667.651573100551, 3668.963310366889, 3255.6418793932885, 3259.7392208623255, 3262.4943133814295, 3269.836508174582, 3279.360524697685, 4416.3375493675885, 4479.664025198123, 4561.0, 4592.609628181609, 4614.284785858197, 4161.084561396518, 4173.979130104361, 4183.1215444756635, 4185.869815149892, 4191.476065491814, 4833.63747718919, 4888.535589119064, 4896.192128298826, 4902.215645496739, 4902.460729319772, 3481.7736847104857, 3555.768875023115, 3559.6440355964455, 3569.660882216185, 3574.338747331752, 5081.59347252219, 5091.0072535855525, 5092.312537807348, 5094.369801663469, 5103.642745007851, 3606.2607165531003, 3612.422012477991, 3618.565772107364, 3620.2759448110482, 3638.9818050910108, 3653.5615726113037, 3670.6329367063613, 3671.9265614688093, 3678.0, 3693.298273328059, 4033.3143365627916, 4150.667946564267, 4160.271952408317, 4189.2459357315365, 4191.8532851350665, 4874.46380898101, 4887.437944636341, 4897.7795999180125, 4898.2652602109965, 4960.107180707435, 1180.6340034589134, 1200.3878022208562, 1206.913777600167, 1218.4821450883517, 1234.4383305595932, 831.6299246835222, 836.7698882807155, 850.2645211891793, 852.4586887326592, 870.4124715816924, 4167.374893765959, 4169.937450938239, 4175.123224122907, 4179.561146079679, 4187.727797693201, 4731.4795372509, 4834.896819883292, 4860.513948605111, 4861.368022157097, 4877.5366340197625, 4081.0, 4104.035551645361, 4132.450331125828, 4139.4542356450565, 4147.129102888367, 2431.878406079689, 2556.2331300609744, 2562.666853309095, 2570.586177602311, 2601.7658410743124, 4546.545345465427, 4570.908581828411, 4574.656900732459, 4584.9312260315455, 4586.151561961048, 4927.334809800703, 4953.529414705597, 4985.077760614298, 4993.425756038102, 5000.724960127155, 4386.210482113251, 4486.7083639563325, 4494.865154045384, 4519.367288579601, 4530.957879687624, 4812.470628230962, 4819.542143496362, 4820.927686084781, 4827.831025914076, 4856.514348565115, 4740.170470167638, 4758.833440829554, 4767.976160119316, 4768.8092476301945, 4774.1883879739835, 4398.0, 4438.423005009328, 4494.640428765756, 4528.773561321855, 4537.727736335831, 3505.3690335738793, 3513.6135025147723, 3514.9824250879606, 3522.172289512014, 3527.8412471438332, 4785.425748910153, 4823.758812059453, 4842.927356089591, 4855.830045948375, 4867.269909513601, 4701.506341834058, 4792.976035119802, 4839.467658557626, 4918.92621610669, 4919.655624106278, 4921.8523444296725, 4923.581495572773, 4926.162552366035, 4926.285688575065, 4932.2601609757385, 4866.343043689199, 4879.4873589186045, 4879.999600082046, 4884.755762211804, 4894.755262236945, 4793.808247670054, 4975.253711943237, 5004.374453193351, 5024.723640199824, 5032.345795046621, 4905.6075513958085, 4906.975465122651, 4912.901741965212, 4913.680610760289, 4915.304220044079], "value": 3656.2681884364997, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.3662009819836, 657.7895073576454, 709.4714437743881, 719.5251134251395, 735.8675438421088, 12596.118271720972, 13494.662633434169, 13516.729665406687, 13541.661458463532, 14130.71738565228, 14407.711845763079, 15389.923050384761, 15410.30653620587, 15413.229338533056, 15421.537353879374, 606.5420607441398, 732.3372348025046, 754.8188434775642, 756.4477931110292, 756.9545827250355, 616.8303716477982, 725.5501589014818, 746.0301607909696, 747.1482509938675, 753.5666991479893, 782.3584660578329, 784.7449578886856, 784.7528028670979, 785.6582386661792, 787.7991112266365, 629.8740251949629, 790.2768966395741, 790.9881351779728, 791.0230864881867, 791.1020991175029, 471.26482687008036, 556.0769123255377, 572.3961220911937, 572.5047833623885, 575.4130786597689, 13410.46358145673, 13463.932680336633, 13521.797173042412, 13531.188128712309, 13559.661008474768, 12233.449494772756, 12518.81221781674, 12826.0, 12834.614961551168, 13000.0, 10142.39145651256, 10544.0, 10921.781564368668, 10972.506237219344, 11092.55629774808, 3146.433641944472, 3159.794613350125, 3180.791299306272, 3277.672232776727, 3302.3230237801195, 65814.67092664554, 67464.0, 68637.31362686359, 69249.0, 70938.0, 9392.248620110375, 9412.435253884789, 9504.809903802023, 9707.90292097084, 9747.317687761788, 18856.905715471334, 18962.14670339838, 18967.71548426775, 19012.714809277873, 19254.61490770177, 6311.652859092794, 6343.429091381798, 6344.651044192521, 6542.574732642363, 6626.602403855784, 3503.0366649171174, 3554.4668299754726, 3579.785212887235, 3630.8366123524506, 3637.308911306843, 2794.399204171072, 2862.0, 2899.159243819311, 2900.579415984713, 2911.7525010373934, 466.9182892993712, 470.8540352490739, 475.36301356182884, 477.41993477923796, 480.52908150013184, 442.1716203498557, 496.581647377275, 566.9603127781098, 585.6983653418492, 588.3381196154327, 7728.7681369559, 7832.530162338173, 7998.12020677725, 8127.59362031896, 8239.835203295901, 547.887683024979, 565.2538648983302, 591.6065816232158, 596.7016491754123, 610.5146408605169, 3698.1124530113116, 3844.461775351453, 3922.5096862892137, 4052.5947405259826, 4108.157827645326, 67842.0, 68599.65700171568, 70328.94506582405, 71155.6442217796, 71442.64278678573, 60339.0, 62411.0, 63337.68331158315, 63805.36194638087, 64865.0, 51192.488075119516, 54056.0, 54688.45311546913, 54978.725106374215, 55537.44462555404, 7743.186965368555, 7991.920080799117, 8137.511749294825, 8209.739461474222, 8397.412181147261, 32552.51171232481, 32977.505337419476, 37831.43252851265, 39535.406968896066, 40270.79864600658, 45514.31728524008, 53060.469395305554, 53093.20360194678, 53431.46568534265, 53698.0, 9492.240620750184, 9708.5145742714, 9734.659286924923, 9775.071368220008, 9912.851307230541, 10413.47932603382, 10690.57237710514, 10819.621313253998, 11053.392063436588, 11578.305301681927, 10386.688399348031, 10525.105366043972, 10761.085307748615, 11244.325340479598, 11797.764044718886, 11654.359010254517, 11742.530298787953, 11782.941085294862, 11945.522179112739, 12290.631281061582, 11177.105831533621, 11260.211785175286, 11415.600453984403, 12386.380680966096, 12401.689957751129, 9642.180414664832, 9887.110160085627, 9901.950490247502, 10129.696109116738, 10525.368477891045, 9771.755706107404, 10172.643957461749, 10225.130863876653, 10251.38491690501, 10293.485325733534], "value": 6195.00977921322, "unit": "score"}], "name": "dromaeo_css", "value": 6173.256779501864, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 115.0, 115.0, 116.0, 115.0, 114.0, 113.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 130.0, 181.0, 129.0, 136.0, 135.0, 130.0, 146.0, 132.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 161.0, 162.0, 163.0, 162.0, 163.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 113.0, 75.0, 75.0, 76.0, 76.0, 96.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 113.0, 85.0, 83.0, 83.0, 103.0, 84.0, 84.0, 114.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 118.0, 118.0, 116.0, 117.0, 118.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 66.0, 67.0, 68.0, 76.0, 66.0, 81.0, 66.0, 67.0], "value": 69.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 65.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 91.0, 94.0, 84.0, 85.0, 85.0, 84.0, 84.0, 85.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 142.0, 141.0, 141.0, 144.0, 142.0, 140.0, 207.0, 150.0], "value": 152.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 180.0, 183.0, 179.0, 182.0, 181.0, 185.0, 186.0, 180.0], "value": 182.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 69.0, 72.0, 72.0, 75.0, 71.0, 71.0, 71.0, 74.0, 69.0], "value": 72.3, "unit": "score"}], "name": "kraken", "value": 1578.0, "alertThreshold": 2.0}]} 07:49:49 INFO - Return code: 0 07:49:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:49:49 INFO - # TBPL SUCCESS # 07:49:49 INFO - Running post-action listener: _resource_record_post_action 07:49:49 INFO - [mozharness: 2016-12-04 15:49:49.267218Z] Finished run-tests step (success) 07:49:49 INFO - Running post-run listener: _resource_record_post_run 07:49:49 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 2080768; Write bytes: 410533888; Read time: 2484; Write time: 308404 07:49:49 INFO - TinderboxPrint: CPU usage
13.1% 07:49:49 INFO - TinderboxPrint: I/O read bytes / time
2,080,768 / 2,484 07:49:49 INFO - TinderboxPrint: I/O write bytes / time
410,533,888 / 308,404 07:49:49 INFO - TinderboxPrint: CPU idle
8,347.5 (86.9%) 07:49:49 INFO - TinderboxPrint: CPU user
1,208.2 (12.6%) 07:49:49 INFO - TinderboxPrint: Swap in / out
0 / 0 07:49:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115433472; Read time: 0; Write time: 73684 07:49:49 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 2080768; Write bytes: 293679104; Read time: 2484; Write time: 234656 07:49:49 INFO - Running post-run listener: _upload_blobber_files 07:49:49 INFO - Blob upload gear active. 07:49:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:49:49 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 07:49:49 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'] 07:49:49 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 07:49:50 INFO - (blobuploader) - INFO - Open directory for files ... 07:49:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:49:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:49:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:49:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:49:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:49:53 INFO - (blobuploader) - INFO - Done attempting. 07:49:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:49:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:49:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:49:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:49:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:49:55 INFO - (blobuploader) - INFO - Done attempting. 07:49:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:49:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:49:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:49:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:49:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:49:55 INFO - (blobuploader) - INFO - Done attempting. 07:49:55 INFO - (blobuploader) - INFO - Iteration through files over. 07:49:55 INFO - Return code: 0 07:49:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:49:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:49:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82a47bb69df3cd35f460961b242a4f83a4bf9e3f0b200c2193b3ec88313909eb1ae53a4584b063462051218545e66c90ebc16e2c7daca901e8746414803edb1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b949dfa2538325683f5b1c574d3a55d0ec3cea128545236de38d978912dc86b9f727ff4ff262a00896cf8c5c4b091810b48850fa442a08ed8ad32e931239afb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/351bedaf9f8e6608e6deb217ef754bd304ce5d34860812bb27bc668d891eb6888b1ed8a5c4d19f40b3be6eb7d9f8a5351d694805a3237a12dcc2932d553a6971"} 07:49:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:49:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:49:55 INFO - Contents: 07:49:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82a47bb69df3cd35f460961b242a4f83a4bf9e3f0b200c2193b3ec88313909eb1ae53a4584b063462051218545e66c90ebc16e2c7daca901e8746414803edb1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b949dfa2538325683f5b1c574d3a55d0ec3cea128545236de38d978912dc86b9f727ff4ff262a00896cf8c5c4b091810b48850fa442a08ed8ad32e931239afb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/351bedaf9f8e6608e6deb217ef754bd304ce5d34860812bb27bc668d891eb6888b1ed8a5c4d19f40b3be6eb7d9f8a5351d694805a3237a12dcc2932d553a6971"} 07:49:55 INFO - Running post-run listener: copy_logs_to_upload_dir 07:49:55 INFO - Copying logs to upload dir... 07:49:55 INFO - mkdir: /builds/slave/test/build/upload/logs 07:49:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.267078 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-04 07:49:51.687278) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-04 07:49:51.691446) ========= 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=3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82a47bb69df3cd35f460961b242a4f83a4bf9e3f0b200c2193b3ec88313909eb1ae53a4584b063462051218545e66c90ebc16e2c7daca901e8746414803edb1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b949dfa2538325683f5b1c574d3a55d0ec3cea128545236de38d978912dc86b9f727ff4ff262a00896cf8c5c4b091810b48850fa442a08ed8ad32e931239afb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/351bedaf9f8e6608e6deb217ef754bd304ce5d34860812bb27bc668d891eb6888b1ed8a5c4d19f40b3be6eb7d9f8a5351d694805a3237a12dcc2932d553a6971"} build_url:https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011783 build_url: 'https://queue.taskcluster.net/v1/task/WGgBHWn_TQqXFtt-6AhO0A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82a47bb69df3cd35f460961b242a4f83a4bf9e3f0b200c2193b3ec88313909eb1ae53a4584b063462051218545e66c90ebc16e2c7daca901e8746414803edb1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b949dfa2538325683f5b1c574d3a55d0ec3cea128545236de38d978912dc86b9f727ff4ff262a00896cf8c5c4b091810b48850fa442a08ed8ad32e931239afb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/351bedaf9f8e6608e6deb217ef754bd304ce5d34860812bb27bc668d891eb6888b1ed8a5c4d19f40b3be6eb7d9f8a5351d694805a3237a12dcc2932d553a6971"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-04 07:49:51.717846) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 07:49:51.718296) ========= 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=3a3620fb28aea1604ab609ef000001d2-1480863418.382541-1860662336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-04 07:49:51.803367) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-04 07:49:51.803748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-04 07:49:51.804140) ========= ========= Total master_lag: 0.15 =========