builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1483139275.0 results: success (0) buildid: 20161230133001 builduid: 0a1306f1b6f045f1a297c87fd561eae8 revision: e120594f18fb68bf0cc9fe119100210f8b4a354c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 15:07:55.001959) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 15:07:55.002648) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 15:07:55.002967) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 15:07:55.018411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 15:07:55.019100) ========= 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=0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-30 15:07:55-- 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% 37.2M=0s 2016-12-30 15:07:55 (37.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.070275 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 15:07:55.107707) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 15:07:55.108391) ========= 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=0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016261 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 15:07:55.160126) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 15:07:55.160506) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e120594f18fb68bf0cc9fe119100210f8b4a354c --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 e120594f18fb68bf0cc9fe119100210f8b4a354c --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=0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-30 15:07:55,227 truncating revision to first 12 chars 2016-12-30 15:07:55,227 Setting DEBUG logging. 2016-12-30 15:07:55,227 attempt 1/10 2016-12-30 15:07:55,227 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e120594f18fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-30 15:07:55,724 unpacking tar archive at: mozilla-central-e120594f18fb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.832052 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 15:07:56.010665) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 15:07:56.011660) ========= script_repo_revision: e120594f18fb68bf0cc9fe119100210f8b4a354c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 15:07:56.012969) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 15:07:56.013948) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 15:07:56.029133) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-30 15:07:56.029445) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:07:56 INFO - MultiFileLogger online at 20161230 15:07:56 in /builds/slave/test 15:07:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:07:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:07:56 INFO - {'append_to_log': False, 15:07:56 INFO - 'base_work_dir': '/builds/slave/test', 15:07:56 INFO - 'blob_upload_branch': 'Firefox', 15:07:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:07:56 INFO - 'branch': 'Firefox', 15:07:56 INFO - 'buildbot_json_path': 'buildprops.json', 15:07:56 INFO - 'config_files': ('talos/linux_config.py',), 15:07:56 INFO - 'default_actions': ('clobber', 15:07:56 INFO - 'read-buildbot-config', 15:07:56 INFO - 'download-and-extract', 15:07:56 INFO - 'populate-webroot', 15:07:56 INFO - 'create-virtualenv', 15:07:56 INFO - 'install', 15:07:56 INFO - 'run-tests'), 15:07:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:07:56 INFO - 'download_minidump_stackwalk': True, 15:07:56 INFO - 'download_symbols': 'ondemand', 15:07:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:07:56 INFO - 'tooltool.py': '/tools/tooltool.py', 15:07:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:07:56 INFO - '/tools/misc-python/virtualenv.py')}, 15:07:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:07:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:07:56 INFO - 'installer_path': 'installer.exe', 15:07:56 INFO - 'log_level': 'info', 15:07:56 INFO - 'log_name': 'talos', 15:07:56 INFO - 'log_to_console': True, 15:07:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:07:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:07:56 INFO - 'opt_config_files': (), 15:07:56 INFO - 'pip_index': False, 15:07:56 INFO - 'sps_profile': False, 15:07:56 INFO - 'sps_profile_interval': 0, 15:07:56 INFO - 'suite': 'dromaeojs-e10s', 15:07:56 INFO - 'system_bits': '32', 15:07:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:07:56 INFO - 'title': 'talos-linux64-ix-017', 15:07:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:07:56 INFO - 'use_talos_json': True, 15:07:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:07:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:07:56 INFO - 'work_dir': 'build'} 15:07:56 INFO - [mozharness: 2016-12-30 23:07:56.194177Z] Running clobber step. 15:07:56 INFO - Running pre-action listener: _resource_record_pre_action 15:07:56 INFO - Running main action method: clobber 15:07:56 INFO - rmtree: /builds/slave/test/build 15:07:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:07:57 INFO - Running post-action listener: _resource_record_post_action 15:07:57 INFO - [mozharness: 2016-12-30 23:07:57.155974Z] Finished clobber step (success) 15:07:57 INFO - [mozharness: 2016-12-30 23:07:57.156074Z] Running read-buildbot-config step. 15:07:57 INFO - Running pre-action listener: _resource_record_pre_action 15:07:57 INFO - Running main action method: read_buildbot_config 15:07:57 INFO - Using buildbot properties: 15:07:57 INFO - { 15:07:57 INFO - "project": "", 15:07:57 INFO - "product": "firefox", 15:07:57 INFO - "script_repo_revision": "production", 15:07:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:07:57 INFO - "repository": "", 15:07:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 15:07:57 INFO - "buildid": "20161230133001", 15:07:57 INFO - "pgo_build": "True", 15:07:57 INFO - "basedir": "/builds/slave/test", 15:07:57 INFO - "buildnumber": 29, 15:07:57 INFO - "slavename": "talos-linux64-ix-017", 15:07:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:07:57 INFO - "platform": "ubuntu64_hw", 15:07:57 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 15:07:57 INFO - "branch": "mozilla-central", 15:07:57 INFO - "repo_path": "mozilla-central", 15:07:57 INFO - "revision": "e120594f18fb68bf0cc9fe119100210f8b4a354c", 15:07:57 INFO - "stage_platform": "linux64-pgo", 15:07:57 INFO - "builduid": "0a1306f1b6f045f1a297c87fd561eae8", 15:07:57 INFO - "slavebuilddir": "test" 15:07:57 INFO - } 15:07:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 15:07:57 INFO - Running post-action listener: _resource_record_post_action 15:07:57 INFO - [mozharness: 2016-12-30 23:07:57.158494Z] Finished read-buildbot-config step (success) 15:07:57 INFO - [mozharness: 2016-12-30 23:07:57.158584Z] Running download-and-extract step. 15:07:57 INFO - Running pre-action listener: _resource_record_pre_action 15:07:57 INFO - Running main action method: download_and_extract 15:07:57 INFO - mkdir: /builds/slave/test/build/tests 15:07:57 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')]} 15:07:57 INFO - trying https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:07:57 INFO - Downloading https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/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 15:07:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/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 15:07:57 INFO - Downloaded 1361 bytes. 15:07:57 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:07:57 INFO - Using the following test package requirements: 15:07:57 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:07:57 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:07:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:07:57 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:07:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:07:57 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:07:57 INFO - u'jsshell-linux-x86_64.zip'], 15:07:57 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:07:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:07:57 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:07:57 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:07:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:07:57 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:07:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:07:57 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:07:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:07:57 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:07:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:07:57 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:07:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:07:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:07:57 INFO - Fetch https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:07:58 INFO - Expected file size: 21838156 15:07:58 INFO - Obtained file size: 21838156 15:08:02 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 15:08:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:08:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:08:02 INFO - Fetch https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:08:03 INFO - Expected file size: 21838156 15:08:03 INFO - Obtained file size: 21838156 15:08:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 15:08:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:08:07 INFO - Fetch https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:08:08 INFO - Expected file size: 14409776 15:08:08 INFO - Obtained file size: 14409776 15:08: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')]} 15:08:08 INFO - trying https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:08:08 INFO - Downloading https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/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 15:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/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 15:08:09 INFO - Downloaded 61363602 bytes. 15:08:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:08:09 INFO - mkdir: /builds/slave/test/properties 15:08:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:08:09 INFO - Writing to file /builds/slave/test/properties/build_url 15:08:09 INFO - Contents: 15:08:09 INFO - build_url:https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:08:10 INFO - Running post-action listener: _resource_record_post_action 15:08:10 INFO - Running post-action listener: set_extra_try_arguments 15:08:10 INFO - [mozharness: 2016-12-30 23:08:10.543814Z] Finished download-and-extract step (success) 15:08:10 INFO - [mozharness: 2016-12-30 23:08:10.544043Z] Running populate-webroot step. 15:08:10 INFO - Running pre-action listener: _resource_record_pre_action 15:08:10 INFO - Running main action method: populate_webroot 15:08:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:08:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:08:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:08:10 INFO - '--tppagecycles', 15:08:10 INFO - '7'], 15:08:10 INFO - 'tests': ['tsvgm']}}, 15:08:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:08:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:08:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:08:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:08:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:08:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:08:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:08:10 INFO - 'talos_options': ['--disable-e10s'], 15:08:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:08:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:08:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:08:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:08:10 INFO - 'talos_options': ['--disable-e10s'], 15:08:10 INFO - 'tests': ['damp', 'tps']}, 15:08:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:08:10 INFO - 'tests': ['damp', 'tps']}, 15:08:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:08:10 INFO - 'tests': ['dromaeo_dom']}, 15:08:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:08:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:08:10 INFO - 'tests': ['basic_compositor_video']}, 15:08:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:08:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:08:10 INFO - 'tests': ['a11yr', 15:08:10 INFO - 'ts_paint', 15:08:10 INFO - 'tpaint', 15:08:10 INFO - 'sessionrestore', 15:08:10 INFO - 'sessionrestore_no_auto_restore', 15:08:10 INFO - 'tabpaint']}, 15:08:10 INFO - 'other-e10s': {'tests': ['a11yr', 15:08:10 INFO - 'ts_paint', 15:08:10 INFO - 'tpaint', 15:08:10 INFO - 'sessionrestore', 15:08:10 INFO - 'sessionrestore_no_auto_restore', 15:08:10 INFO - 'tabpaint']}, 15:08:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:08:10 INFO - 'ts_paint', 15:08:10 INFO - 'tpaint', 15:08:10 INFO - 'sessionrestore', 15:08:10 INFO - 'sessionrestore_no_auto_restore', 15:08:10 INFO - 'tabpaint']}, 15:08:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:08:10 INFO - 'ts_paint', 15:08:10 INFO - 'tpaint', 15:08:10 INFO - 'sessionrestore', 15:08:10 INFO - 'sessionrestore_no_auto_restore', 15:08:10 INFO - 'tabpaint']}, 15:08:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:08:10 INFO - 'tests': ['a11yr', 15:08:10 INFO - 'ts_paint', 15:08:10 INFO - 'tpaint', 15:08:10 INFO - 'sessionrestore', 15:08:10 INFO - 'sessionrestore_no_auto_restore', 15:08:10 INFO - 'tabpaint']}, 15:08:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:08:10 INFO - 'tests': ['a11yr', 15:08:10 INFO - 'ts_paint', 15:08:10 INFO - 'tpaint', 15:08:10 INFO - 'sessionrestore', 15:08:10 INFO - 'sessionrestore_no_auto_restore', 15:08:10 INFO - 'tabpaint']}, 15:08:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:08:10 INFO - 'tests': ['tsvgx', 15:08:10 INFO - 'tsvgr_opacity', 15:08:10 INFO - 'tart', 15:08:10 INFO - 'tscrollx', 15:08:10 INFO - 'cart', 15:08:10 INFO - 'tsvg_static']}, 15:08:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:08:10 INFO - 'tsvgr_opacity', 15:08:10 INFO - 'tart', 15:08:10 INFO - 'tscrollx', 15:08:10 INFO - 'cart', 15:08:10 INFO - 'tsvg_static']}, 15:08:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:08:10 INFO - 'talos_options': ['--disable-e10s'], 15:08:10 INFO - 'tests': ['tp5o']}, 15:08:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:08:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:08:10 INFO - 'talos_options': ['--disable-e10s', 15:08:10 INFO - '--xperf_path', 15:08:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:08:10 INFO - 'tests': ['tp5n']}, 15:08:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:08:10 INFO - 'talos_options': ['--xperf_path', 15:08:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:08:10 INFO - 'tests': ['tp5n']}}, 15:08:10 INFO - 'talos.zip': {'path': '', 15:08:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:08:10 INFO - Running post-action listener: _resource_record_post_action 15:08:10 INFO - [mozharness: 2016-12-30 23:08:10.561367Z] Finished populate-webroot step (success) 15:08:10 INFO - [mozharness: 2016-12-30 23:08:10.561456Z] Running create-virtualenv step. 15:08:10 INFO - Running pre-action listener: _resource_record_pre_action 15:08:10 INFO - Running main action method: create_virtualenv 15:08:10 INFO - Creating virtualenv /builds/slave/test/build/venv 15:08:10 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 15:08:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:08:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:08:10 INFO - Using real prefix '/usr' 15:08:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:08:11 INFO - Installing distribute.............................................................................................................................................................................................done. 15:08:13 INFO - Installing pip.................done. 15:08:13 INFO - Return code: 0 15:08:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:08:13 INFO - Reading from file tmpfile_stdout 15:08:13 INFO - Output received: 15:08:13 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) 15:08:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe23f0>, '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 0x1fe2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe31a0>, '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': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', '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 15:08:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:08:13 INFO - Using env: {'DISPLAY': ':0', 15:08:13 INFO - 'HOME': '/home/cltbld', 15:08:13 INFO - 'LANG': 'en_US.UTF-8', 15:08:13 INFO - 'LANGUAGE': 'en_US:en', 15:08:13 INFO - 'LOGNAME': 'cltbld', 15:08:13 INFO - 'MAIL': '/var/mail/cltbld', 15:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:13 INFO - 'MOZ_NO_REMOTE': '1', 15:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:13 INFO - 'NO_EM_RESTART': '1', 15:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:13 INFO - 'PWD': '/builds/slave/test', 15:08:13 INFO - 'SHELL': '/bin/bash', 15:08:13 INFO - 'SHLVL': '1', 15:08:13 INFO - 'TERM': 'linux', 15:08:13 INFO - 'TMOUT': '86400', 15:08:13 INFO - 'USER': 'cltbld', 15:08:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', 15:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:13 INFO - '_': '/tools/buildbot/bin/python'} 15:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:13 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 15:08:13 INFO - Cleaning up... 15:08:13 INFO - Return code: 0 15:08:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe23f0>, '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 0x1fe2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe31a0>, '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': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', '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 15:08:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:08:13 INFO - Using env: {'DISPLAY': ':0', 15:08:13 INFO - 'HOME': '/home/cltbld', 15:08:13 INFO - 'LANG': 'en_US.UTF-8', 15:08:13 INFO - 'LANGUAGE': 'en_US:en', 15:08:13 INFO - 'LOGNAME': 'cltbld', 15:08:13 INFO - 'MAIL': '/var/mail/cltbld', 15:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:13 INFO - 'MOZ_NO_REMOTE': '1', 15:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:13 INFO - 'NO_EM_RESTART': '1', 15:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:13 INFO - 'PWD': '/builds/slave/test', 15:08:13 INFO - 'SHELL': '/bin/bash', 15:08:13 INFO - 'SHLVL': '1', 15:08:13 INFO - 'TERM': 'linux', 15:08:13 INFO - 'TMOUT': '86400', 15:08:13 INFO - 'USER': 'cltbld', 15:08:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', 15:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:13 INFO - '_': '/tools/buildbot/bin/python'} 15:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:13 INFO - Downloading/unpacking psutil>=3.1.1 15:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:08:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:08:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:08:15 INFO - Installing collected packages: psutil 15:08:15 INFO - Running setup.py install for psutil 15:08:15 INFO - building 'psutil._psutil_linux' extension 15:08:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:08:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:08:16 INFO - building 'psutil._psutil_posix' extension 15:08:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:08:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:08:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:08:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:08:16 INFO - Successfully installed psutil 15:08:16 INFO - Cleaning up... 15:08:16 INFO - Return code: 0 15:08:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe23f0>, '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 0x1fe2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe31a0>, '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': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', '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 15:08:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:08:16 INFO - Using env: {'DISPLAY': ':0', 15:08:16 INFO - 'HOME': '/home/cltbld', 15:08:16 INFO - 'LANG': 'en_US.UTF-8', 15:08:16 INFO - 'LANGUAGE': 'en_US:en', 15:08:16 INFO - 'LOGNAME': 'cltbld', 15:08:16 INFO - 'MAIL': '/var/mail/cltbld', 15:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:16 INFO - 'MOZ_NO_REMOTE': '1', 15:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:16 INFO - 'NO_EM_RESTART': '1', 15:08:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:16 INFO - 'PWD': '/builds/slave/test', 15:08:16 INFO - 'SHELL': '/bin/bash', 15:08:16 INFO - 'SHLVL': '1', 15:08:16 INFO - 'TERM': 'linux', 15:08:16 INFO - 'TMOUT': '86400', 15:08:16 INFO - 'USER': 'cltbld', 15:08:16 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', 15:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:16 INFO - '_': '/tools/buildbot/bin/python'} 15:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:08:18 INFO - Installing collected packages: mozsystemmonitor 15:08:18 INFO - Running setup.py install for mozsystemmonitor 15:08:18 INFO - Successfully installed mozsystemmonitor 15:08:18 INFO - Cleaning up... 15:08:18 INFO - Return code: 0 15:08:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:08:18 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')]} 15:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:18 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')]} 15:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:18 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 0x1c731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe23f0>, '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 0x1fe2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe31a0>, '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': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', '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 15:08:18 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 15:08:18 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 15:08:18 INFO - Using env: {'DISPLAY': ':0', 15:08:18 INFO - 'HOME': '/home/cltbld', 15:08:18 INFO - 'LANG': 'en_US.UTF-8', 15:08:18 INFO - 'LANGUAGE': 'en_US:en', 15:08:18 INFO - 'LOGNAME': 'cltbld', 15:08:18 INFO - 'MAIL': '/var/mail/cltbld', 15:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:18 INFO - 'MOZ_NO_REMOTE': '1', 15:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:18 INFO - 'NO_EM_RESTART': '1', 15:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:18 INFO - 'PWD': '/builds/slave/test', 15:08:18 INFO - 'SHELL': '/bin/bash', 15:08:18 INFO - 'SHLVL': '1', 15:08:18 INFO - 'TERM': 'linux', 15:08:18 INFO - 'TMOUT': '86400', 15:08:18 INFO - 'USER': 'cltbld', 15:08:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', 15:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:18 INFO - '_': '/tools/buildbot/bin/python'} 15:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:19 INFO - Downloading/unpacking jsonschema==2.5.1 15:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:08:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:21 INFO - Downloading functools32-3.2.3-2.tar.gz 15:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:08:21 INFO - warning: no files found matching '*.txt' 15:08:21 INFO - no previously-included directories found matching 'build' 15:08:21 INFO - no previously-included directories found matching 'dist' 15:08:21 INFO - no previously-included directories found matching '.git*' 15:08:21 INFO - Installing collected packages: jsonschema, functools32 15:08:21 INFO - Running setup.py install for functools32 15:08:21 INFO - warning: no files found matching '*.txt' 15:08:21 INFO - no previously-included directories found matching 'build' 15:08:21 INFO - no previously-included directories found matching 'dist' 15:08:21 INFO - no previously-included directories found matching '.git*' 15:08:21 INFO - Successfully installed jsonschema functools32 15:08:21 INFO - Cleaning up... 15:08:21 INFO - Return code: 0 15:08:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:08:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe23f0>, '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 0x1fe2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe31a0>, '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': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', '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 15:08:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:08:21 INFO - Using env: {'DISPLAY': ':0', 15:08:21 INFO - 'HOME': '/home/cltbld', 15:08:21 INFO - 'LANG': 'en_US.UTF-8', 15:08:21 INFO - 'LANGUAGE': 'en_US:en', 15:08:21 INFO - 'LOGNAME': 'cltbld', 15:08:21 INFO - 'MAIL': '/var/mail/cltbld', 15:08:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:21 INFO - 'MOZ_NO_REMOTE': '1', 15:08:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:21 INFO - 'NO_EM_RESTART': '1', 15:08:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:21 INFO - 'PWD': '/builds/slave/test', 15:08:21 INFO - 'SHELL': '/bin/bash', 15:08:21 INFO - 'SHLVL': '1', 15:08:21 INFO - 'TERM': 'linux', 15:08:21 INFO - 'TMOUT': '86400', 15:08:21 INFO - 'USER': 'cltbld', 15:08:21 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', 15:08:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:21 INFO - '_': '/tools/buildbot/bin/python'} 15:08:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:08:21 INFO - Cleaning up... 15:08:21 INFO - Return code: 0 15:08:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:08:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe23f0>, '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 0x1fe2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe31a0>, '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': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', '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 15:08:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:08:21 INFO - Using env: {'DISPLAY': ':0', 15:08:21 INFO - 'HOME': '/home/cltbld', 15:08:21 INFO - 'LANG': 'en_US.UTF-8', 15:08:21 INFO - 'LANGUAGE': 'en_US:en', 15:08:21 INFO - 'LOGNAME': 'cltbld', 15:08:21 INFO - 'MAIL': '/var/mail/cltbld', 15:08:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:21 INFO - 'MOZ_NO_REMOTE': '1', 15:08:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:21 INFO - 'NO_EM_RESTART': '1', 15:08:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:21 INFO - 'PWD': '/builds/slave/test', 15:08:21 INFO - 'SHELL': '/bin/bash', 15:08:21 INFO - 'SHLVL': '1', 15:08:21 INFO - 'TERM': 'linux', 15:08:21 INFO - 'TMOUT': '86400', 15:08:21 INFO - 'USER': 'cltbld', 15:08:21 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', 15:08:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:21 INFO - '_': '/tools/buildbot/bin/python'} 15:08:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:21 INFO - Downloading/unpacking blobuploader==1.2.4 15:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:23 INFO - Downloading blobuploader-1.2.4.tar.gz 15:08:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:08:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:08:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:24 INFO - Downloading docopt-0.6.1.tar.gz 15:08:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:08:24 INFO - Installing collected packages: blobuploader, requests, docopt 15:08:24 INFO - Running setup.py install for blobuploader 15:08:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:08:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:08:24 INFO - Running setup.py install for requests 15:08:25 INFO - Running setup.py install for docopt 15:08:25 INFO - Successfully installed blobuploader requests docopt 15:08:25 INFO - Cleaning up... 15:08:25 INFO - Return code: 0 15:08:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:08: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')]} 15:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08: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')]} 15:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe23f0>, '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 0x1fe2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe31a0>, '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': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', '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 15:08:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:08:25 INFO - Using env: {'DISPLAY': ':0', 15:08:25 INFO - 'HOME': '/home/cltbld', 15:08:25 INFO - 'LANG': 'en_US.UTF-8', 15:08:25 INFO - 'LANGUAGE': 'en_US:en', 15:08:25 INFO - 'LOGNAME': 'cltbld', 15:08:25 INFO - 'MAIL': '/var/mail/cltbld', 15:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:25 INFO - 'MOZ_NO_REMOTE': '1', 15:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:25 INFO - 'NO_EM_RESTART': '1', 15:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:25 INFO - 'PWD': '/builds/slave/test', 15:08:25 INFO - 'SHELL': '/bin/bash', 15:08:25 INFO - 'SHLVL': '1', 15:08:25 INFO - 'TERM': 'linux', 15:08:25 INFO - 'TMOUT': '86400', 15:08:25 INFO - 'USER': 'cltbld', 15:08:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', 15:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:25 INFO - '_': '/tools/buildbot/bin/python'} 15:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:08:25 INFO - Running setup.py (path:/tmp/pip-O7scZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:08:25 INFO - Running setup.py (path:/tmp/pip-nXX8xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:08:25 INFO - Running setup.py (path:/tmp/pip-WKvm2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:08:25 INFO - Running setup.py (path:/tmp/pip-uU1eY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:08:25 INFO - Running setup.py (path:/tmp/pip-hL2Gwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:08:26 INFO - Running setup.py (path:/tmp/pip-we315w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:08:26 INFO - Running setup.py (path:/tmp/pip-FzdG5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:08:26 INFO - Running setup.py (path:/tmp/pip-82lozf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:08:26 INFO - Running setup.py (path:/tmp/pip-cDjRUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:08:26 INFO - Running setup.py (path:/tmp/pip-eqsyn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:08:26 INFO - Running setup.py (path:/tmp/pip-S3R3A2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:08:26 INFO - Running setup.py (path:/tmp/pip-J3sqdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:08:26 INFO - Running setup.py (path:/tmp/pip-Wqfr63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:08:26 INFO - Running setup.py (path:/tmp/pip-M_C2VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:08:26 INFO - Running setup.py (path:/tmp/pip-yIaeRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:08:26 INFO - Running setup.py (path:/tmp/pip-igDq2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:08:26 INFO - Running setup.py (path:/tmp/pip-gYSMzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:08:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:08:26 INFO - Running setup.py install for manifestparser 15:08:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:08:27 INFO - Running setup.py install for mozcrash 15:08:27 INFO - Running setup.py install for mozdebug 15:08:27 INFO - Running setup.py install for mozdevice 15:08:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:08:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:08:27 INFO - Running setup.py install for mozfile 15:08:27 INFO - Running setup.py install for mozhttpd 15:08:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:08:27 INFO - Running setup.py install for mozinfo 15:08:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:08:27 INFO - Running setup.py install for mozInstall 15:08:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:08:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:08:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:08:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:08:27 INFO - Running setup.py install for mozleak 15:08:27 INFO - Running setup.py install for mozlog 15:08:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:08:27 INFO - Running setup.py install for moznetwork 15:08:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:08:28 INFO - Running setup.py install for mozprocess 15:08:28 INFO - Running setup.py install for mozprofile 15:08:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:08:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:08:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:08:28 INFO - Running setup.py install for mozrunner 15:08:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:08:28 INFO - Running setup.py install for mozscreenshot 15:08:28 INFO - Running setup.py install for moztest 15:08:28 INFO - Running setup.py install for mozversion 15:08:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:08:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:08:28 INFO - Cleaning up... 15:08:28 INFO - Return code: 0 15:08:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:08: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')]} 15:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08: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')]} 15:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe23f0>, '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 0x1fe2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe31a0>, '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': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', '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 15:08:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:08:28 INFO - Using env: {'DISPLAY': ':0', 15:08:28 INFO - 'HOME': '/home/cltbld', 15:08:28 INFO - 'LANG': 'en_US.UTF-8', 15:08:28 INFO - 'LANGUAGE': 'en_US:en', 15:08:28 INFO - 'LOGNAME': 'cltbld', 15:08:28 INFO - 'MAIL': '/var/mail/cltbld', 15:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:28 INFO - 'MOZ_NO_REMOTE': '1', 15:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:28 INFO - 'NO_EM_RESTART': '1', 15:08:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:28 INFO - 'PWD': '/builds/slave/test', 15:08:28 INFO - 'SHELL': '/bin/bash', 15:08:28 INFO - 'SHLVL': '1', 15:08:28 INFO - 'TERM': 'linux', 15:08:28 INFO - 'TMOUT': '86400', 15:08:28 INFO - 'USER': 'cltbld', 15:08:28 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', 15:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:28 INFO - '_': '/tools/buildbot/bin/python'} 15:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:08:28 INFO - Running setup.py (path:/tmp/pip-5K0Cfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:08:29 INFO - Running setup.py (path:/tmp/pip-3NKSoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:08:29 INFO - Running setup.py (path:/tmp/pip-l5wAKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:08:29 INFO - Running setup.py (path:/tmp/pip-clZZnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:08:29 INFO - Running setup.py (path:/tmp/pip-AvzLIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:08:29 INFO - Running setup.py (path:/tmp/pip-floOR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:08:29 INFO - Running setup.py (path:/tmp/pip-a1fpgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:08:29 INFO - Running setup.py (path:/tmp/pip-wercyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:08:29 INFO - Running setup.py (path:/tmp/pip-fG7U3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:08:29 INFO - Running setup.py (path:/tmp/pip-K6pdRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:08:29 INFO - Running setup.py (path:/tmp/pip-bbMnjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:08:29 INFO - Running setup.py (path:/tmp/pip-Jd4w1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:08:29 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)) 15:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:08:29 INFO - Running setup.py (path:/tmp/pip-QDCiX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:08:29 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)) 15:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:08:29 INFO - Running setup.py (path:/tmp/pip-Bfhk8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:08:29 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)) 15:08:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:08:29 INFO - Running setup.py (path:/tmp/pip-MHccn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:08:30 INFO - Running setup.py (path:/tmp/pip-8teysi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:08:30 INFO - Running setup.py (path:/tmp/pip-WrwyA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:08:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:08: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 15:08: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 15:08: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 15:08: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 15:08: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 15:08: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 15:08:32 INFO - Downloading blessings-1.6.tar.gz 15:08:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:08:32 INFO - Installing collected packages: blessings 15:08:32 INFO - Running setup.py install for blessings 15:08:32 INFO - Successfully installed blessings 15:08:32 INFO - Cleaning up... 15:08:32 INFO - Return code: 0 15:08:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:08:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:08:32 INFO - Reading from file tmpfile_stdout 15:08:32 INFO - Current package versions: 15:08:32 INFO - argparse == 1.2.1 15:08:32 INFO - blessings == 1.6 15:08:32 INFO - blobuploader == 1.2.4 15:08:32 INFO - docopt == 0.6.1 15:08:32 INFO - functools32 == 3.2.3-2 15:08:32 INFO - jsonschema == 2.5.1 15:08:32 INFO - manifestparser == 1.1 15:08:32 INFO - mozInstall == 1.12 15:08:32 INFO - mozcrash == 1.0 15:08:32 INFO - mozdebug == 0.1 15:08:32 INFO - mozdevice == 0.49 15:08:32 INFO - mozfile == 1.2 15:08:32 INFO - mozhttpd == 0.7 15:08:32 INFO - mozinfo == 0.9 15:08:32 INFO - mozleak == 0.1 15:08:32 INFO - mozlog == 3.4 15:08:32 INFO - moznetwork == 0.27 15:08:32 INFO - mozprocess == 0.23 15:08:32 INFO - mozprofile == 0.28 15:08:32 INFO - mozrunner == 6.13 15:08:32 INFO - mozscreenshot == 0.1 15:08:32 INFO - mozsystemmonitor == 0.3 15:08:32 INFO - moztest == 0.8 15:08:32 INFO - mozversion == 1.4 15:08:32 INFO - psutil == 3.1.1 15:08:32 INFO - requests == 1.2.3 15:08:32 INFO - wsgiref == 0.1.2 15:08:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe23f0>, '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 0x1fe2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe31a0>, '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': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', '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 15:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:08:32 INFO - Using env: {'DISPLAY': ':0', 15:08:32 INFO - 'HOME': '/home/cltbld', 15:08:32 INFO - 'LANG': 'en_US.UTF-8', 15:08:32 INFO - 'LANGUAGE': 'en_US:en', 15:08:32 INFO - 'LOGNAME': 'cltbld', 15:08:32 INFO - 'MAIL': '/var/mail/cltbld', 15:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:32 INFO - 'MOZ_NO_REMOTE': '1', 15:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:32 INFO - 'NO_EM_RESTART': '1', 15:08:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:32 INFO - 'PWD': '/builds/slave/test', 15:08:32 INFO - 'SHELL': '/bin/bash', 15:08:32 INFO - 'SHLVL': '1', 15:08:32 INFO - 'TERM': 'linux', 15:08:32 INFO - 'TMOUT': '86400', 15:08:32 INFO - 'USER': 'cltbld', 15:08:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', 15:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:32 INFO - '_': '/tools/buildbot/bin/python'} 15:08:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:08:33 INFO - Cleaning up... 15:08:33 INFO - Return code: 0 15:08:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:08: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')]} 15:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08: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')]} 15:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe23f0>, '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 0x1fe2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe31a0>, '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': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', '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 15:08:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:08:33 INFO - Using env: {'DISPLAY': ':0', 15:08:33 INFO - 'HOME': '/home/cltbld', 15:08:33 INFO - 'LANG': 'en_US.UTF-8', 15:08:33 INFO - 'LANGUAGE': 'en_US:en', 15:08:33 INFO - 'LOGNAME': 'cltbld', 15:08:33 INFO - 'MAIL': '/var/mail/cltbld', 15:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:33 INFO - 'MOZ_NO_REMOTE': '1', 15:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:33 INFO - 'NO_EM_RESTART': '1', 15:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:33 INFO - 'PWD': '/builds/slave/test', 15:08:33 INFO - 'SHELL': '/bin/bash', 15:08:33 INFO - 'SHLVL': '1', 15:08:33 INFO - 'TERM': 'linux', 15:08:33 INFO - 'TMOUT': '86400', 15:08:33 INFO - 'USER': 'cltbld', 15:08:33 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', 15:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:33 INFO - '_': '/tools/buildbot/bin/python'} 15:08:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:08:33 INFO - Cleaning up... 15:08:33 INFO - Return code: 0 15:08:33 INFO - Running post-action listener: _resource_record_post_action 15:08:33 INFO - Running post-action listener: _start_resource_monitoring 15:08:33 INFO - Starting resource monitoring. 15:08:33 INFO - [mozharness: 2016-12-30 23:08:33.359663Z] Finished create-virtualenv step (success) 15:08:33 INFO - [mozharness: 2016-12-30 23:08:33.360162Z] Running install step. 15:08:33 INFO - Running pre-action listener: _resource_record_pre_action 15:08:33 INFO - Running main action method: install 15:08:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:08:33 INFO - Reading from file tmpfile_stdout 15:08:33 INFO - Detecting whether we're running mozinstall >=1.0... 15:08:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:08:33 INFO - Reading from file tmpfile_stdout 15:08:33 INFO - Output received: 15:08:33 INFO - Usage: mozinstall [options] installer 15:08:33 INFO - Options: 15:08:33 INFO - -h, --help show this help message and exit 15:08:33 INFO - -d DEST, --destination=DEST 15:08:33 INFO - Directory to install application into. [default: 15:08:33 INFO - "/builds/slave/test"] 15:08:33 INFO - --app=APP Application being installed. [default: firefox] 15:08:33 INFO - mkdir: /builds/slave/test/build/application 15:08:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:08:50 INFO - Reading from file tmpfile_stdout 15:08:50 INFO - Output received: 15:08:50 INFO - /builds/slave/test/build/application/firefox/firefox 15:08:50 INFO - Running post-action listener: _resource_record_post_action 15:08:50 INFO - [mozharness: 2016-12-30 23:08:50.975982Z] Finished install step (success) 15:08:50 INFO - [mozharness: 2016-12-30 23:08:50.976227Z] Running run-tests step. 15:08:50 INFO - Running pre-action listener: _resource_record_pre_action 15:08:50 INFO - Running main action method: run_tests 15:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:08:50 INFO - Python 2.7.3 15:08:50 INFO - Return code: 0 15:08:50 INFO - grabbing minidump binary from tooltool 15:08:50 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')]} 15:08:50 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 0x1fe23f0>, '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 0x1fe2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe31a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:08:50 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 15:08:50 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 15:08:50 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 15:08:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:08:51 INFO - Return code: 0 15:08:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:08:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:08:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:08:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:08:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:08:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:08:51 INFO - Using env: {'DISPLAY': ':0', 15:08:51 INFO - 'HOME': '/home/cltbld', 15:08:51 INFO - 'LANG': 'en_US.UTF-8', 15:08:51 INFO - 'LANGUAGE': 'en_US:en', 15:08:51 INFO - 'LOGNAME': 'cltbld', 15:08:51 INFO - 'MAIL': '/var/mail/cltbld', 15:08:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:08:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:51 INFO - 'MOZ_NO_REMOTE': '1', 15:08:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:51 INFO - 'NO_EM_RESTART': '1', 15:08:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:51 INFO - 'PWD': '/builds/slave/test', 15:08:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:08:51 INFO - 'SHELL': '/bin/bash', 15:08:51 INFO - 'SHLVL': '1', 15:08:51 INFO - 'TERM': 'linux', 15:08:51 INFO - 'TMOUT': '86400', 15:08:51 INFO - 'USER': 'cltbld', 15:08:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123', 15:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:51 INFO - '_': '/tools/buildbot/bin/python'} 15:08:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:08:51 INFO - mozversion application_buildid: 20161230133001 15:08:51 INFO - mozversion application_changeset: e120594f18fb68bf0cc9fe119100210f8b4a354c 15:08:51 INFO - mozversion application_display_name: Nightly 15:08:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:08:51 INFO - mozversion application_name: Firefox 15:08:51 INFO - mozversion application_remotingname: firefox 15:08:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:08:51 INFO - mozversion application_vendor: Mozilla 15:08:51 INFO - mozversion application_version: 53.0a1 15:08:51 INFO - mozversion platform_buildid: 20161230133001 15:08:51 INFO - mozversion platform_changeset: e120594f18fb68bf0cc9fe119100210f8b4a354c 15:08:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:08:51 INFO - mozversion platform_version: 53.0a1 15:08:51 INFO - using testdate: 1483139331 15:08:51 INFO - actual date: 1483139331 15:08:51 INFO - starting webserver on 'localhost:35655' 15:08:51 INFO - SUITE-START | Running 2 tests 15:08:51 INFO - TEST-START | dromaeo_css 15:08:51 INFO - operating with platform_type : linux_ 15:08:51 INFO - Initialising browser for dromaeo_css test... 15:08:51 INFO - TEST-INFO | started process 12635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Koip8/profile http://localhost:35655/getInfo.html) 15:08:51 INFO - PROCESS | 12635 | 1483139331719 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 15:08:55 INFO - PROCESS | 12635 | __metrics Screen width/height:1600/1200 15:08:55 INFO - PROCESS | 12635 | colorDepth:24 15:08:55 INFO - PROCESS | 12635 | Browser inner width/height: 1024/697 15:08:55 INFO - PROCESS | 12635 | __metrics 15:08:55 ERROR - PROCESS | 12635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 15:08:56 INFO - TEST-INFO | 12635: exit 0 15:08:56 INFO - Browser initialized. 15:08:56 INFO - Running cycle 1/1 for dromaeo_css test... 15:08:56 INFO - TEST-INFO | started process 12756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Koip8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:09:08 INFO - PROCESS | 12756 | RSS: Main: 154902528 15:09:08 INFO - PROCESS | 12756 | 15:09:57 INFO - PROCESS | 12756 | 1483139397991 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] 15:12:08 INFO - PROCESS | 12756 | Cycle 1(1): loaded http://localhost:35655/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35655/tests/dromaeo/cssquery-ext.html) 15:12:10 INFO - PROCESS | 12756 | RSS: Main: 164638720 15:12:10 INFO - PROCESS | 12756 | 15:13:56 INFO - PROCESS | 12756 | ************************* 15:13:56 INFO - PROCESS | 12756 | A coding exception was thrown and uncaught in a Task. 15:13:56 INFO - PROCESS | 12756 | 15:13:56 INFO - PROCESS | 12756 | Full message: ReferenceError: fetch is not defined 15:13:56 INFO - PROCESS | 12756 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 15:13:56 INFO - PROCESS | 12756 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 15:13:56 INFO - PROCESS | 12756 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 15:13:56 INFO - PROCESS | 12756 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 15:13:56 INFO - PROCESS | 12756 | TaskImpl@resource://gre/modules/Task.jsm:277:3 15:13:56 INFO - PROCESS | 12756 | asyncFunction@resource://gre/modules/Task.jsm:252:14 15:13:56 INFO - PROCESS | 12756 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 15:13:56 INFO - PROCESS | 12756 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 15:13:56 INFO - PROCESS | 12756 | TaskImpl@resource://gre/modules/Task.jsm:277:3 15:13:56 INFO - PROCESS | 12756 | asyncFunction@resource://gre/modules/Task.jsm:252:14 15:13:56 INFO - PROCESS | 12756 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 15:13:56 INFO - PROCESS | 12756 | 15:13:56 INFO - PROCESS | 12756 | ************************* 15:15:12 INFO - PROCESS | 12756 | Cycle 1(1): loaded http://localhost:35655/tests/dromaeo/cssquery-ext.html (next: http://localhost:35655/tests/dromaeo/cssquery-jquery.html) 15:15:13 INFO - PROCESS | 12756 | RSS: Main: 162058240 15:15:13 INFO - PROCESS | 12756 | 15:18:14 INFO - PROCESS | 12756 | Cycle 1(1): loaded http://localhost:35655/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35655/tests/dromaeo/cssquery-mootools.html) 15:18:15 INFO - PROCESS | 12756 | RSS: Main: 165060608 15:18:15 INFO - PROCESS | 12756 | 15:21:17 INFO - PROCESS | 12756 | Cycle 1(1): loaded http://localhost:35655/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35655/tests/dromaeo/cssquery-prototype.html) 15:21:18 INFO - PROCESS | 12756 | RSS: Main: 160788480 15:21:18 INFO - PROCESS | 12756 | 15:24:20 INFO - PROCESS | 12756 | Cycle 1(1): loaded http://localhost:35655/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35655/tests/dromaeo/cssquery-yui.html) 15:24:21 INFO - PROCESS | 12756 | RSS: Main: 166117376 15:24:21 INFO - PROCESS | 12756 | 15:27:23 INFO - PROCESS | 12756 | Cycle 1(1): loaded http://localhost:35655/tests/dromaeo/cssquery-yui.html (next: http://localhost:35655/tests/dromaeo/cssquery-dojo.html) 15:27:24 INFO - PROCESS | 12756 | RSS: Main: 166199296 15:27:24 INFO - PROCESS | 12756 | 15:27:24 INFO - PROCESS | 12756 | __start_tp_report 15:27:24 INFO - PROCESS | 12756 | _x_x_mozilla_page_load 15:27:24 INFO - PROCESS | 12756 | _x_x_mozilla_page_load_details 15:27:24 INFO - PROCESS | 12756 | |i|pagename|runs| 15:27:24 INFO - PROCESS | 12756 | |0;dojo.html;3209.8876539321127;3235.4176248275317;3238.5142228665695;3257.7719559630837;3261.2499125201202;5382.0312343778105;5460.481254280842;5494.80768173114;5501.559875209983;5527.474889885464;5434.8913021739545;5473.890522189554;5544.722763861801;5572.275604171452;5585.273914391123;4928.482509336531;4980.750962451881;5006.299118123466;5082.618803589727;5113.923291150636;4950.207966725325;5090.05833920724;5092.236164575306;5102.948970510303;5125.077486052509;4867.8783030424165;4905.779239934212;5049.974750126263;5073.771680274396;5080;4935.777889994923;4961.627877909171;4978.9751051244875;5005.824796132154;5073.695578265316;4922.507749225085;4946.455889852114;4947;4964.255361695738;5005.549500544932;5335.759890804923;5408;5431.212474191259;5452.291202143736;5454.727263636842;5744.942550574483;5758.596898217126;5775.27809023872;5787.971060144672;5902.586818922677;5859.4140585941495;5866.384029676908;5867;5870.559708021916;5873.383294754032;5435.42927992563;5436.945630543723;5444.047291723932;5447.972760136174;5459.262999495097;5809.2738407699035;5879.323877754027;5957.493613042853;5974.731137098841;5984;5772.5959182856795;5775.88448231033;5793.507551858139;5806.912896306559;5821.825345239649;5825.3883342248455;5832.650040997469;5903.173555702205;5919.023361145363;5938.8812223755285;5723.484886360247;5772.624779389326;5804.564657650693;5839.270091238595;5842.59101862874;5861.238039054895;5861.88276234473;5864.091065884794;5868.853278668067;5919.55603329752;4388.341748737651;4405;4405.669574781904;4415.40392047076;4443.0669559392245;3881.301365754135;3904.375299951994;3907.492026036597;3910.0420397002918;3929.528456585228;5561.054620714488;5582.525485333711;5588.636738612058;5606.383297837235;5623.746931388097;5881.470667639933;5920.703964801743;5932.2584676915385;5952;5962.314333851576;5458.8908221835345;5464.863378415572;5542.5565954723525;5617.129344951539;5622.297212848394;4849.587785038311;4892.241702536113;4899.877503062452;4931.9753401232765;4938.308636790852;6157.076438534255;6195.473384762256;6199.225096862892;6200.441960223601;6203.131561581382;5746.3966283541295;5807.767689292381;5910.408959104056;5910.70446477683;5915.792947246998;6112.235970503687;6115.088229002258;6126.877462450815;6175.382461753788;6188;5733.3406658234835;5825.766969321349;5825.79609713658;5827.6794776286015;5839.328477225174;5764.394738552559;5892.646441213369;5951.523878089829;5957;5971.820845374646;5686.2323586315315;5699.202111704281;5702.2016917630735;5729.541636668973;5801.825945221482;5711.114777209539;5727.140928860705;5727.4845263926445;5756.740946657326;5767.884642307215;5430.104032834538;5453.863653408696;5723.771049157987;5766.538676905753;5767.798127065533;5709.9714501427225;5752.223449834386;5754.021816291157;5796.0436527972415;5818.040023396092;5572.164175373727;5605.411431799603;5625.324961004706;5628.352739435018;5629.437056294338 15:27:24 INFO - PROCESS | 12756 | |1;ext.html;549.8872731090127;551.8344496651005;560.4563573333864;574.1158615731773;582.3099626942072;41507.37738933915;42641;42695.78652106739;46314;46352.53647463524;43549.78225108878;43870.780646096806;43959.340609890874;43970;44057.7797111014;8801.69194078209;8957.19385255327;8967.237784788302;8968;9950.65172718955;9910.801783964316;10283.691489255334;10286.382817030964;10292.279540432173;10294.279400441972;10349.430781307063;10358.948205258963;10385;10392.740181495485;10416.479176041206;10203.4388108654;10275.486225688686;10312.071913527781;10319.84520232197;10351.741206469824;10107.3430227035;10152.543135558917;10211.591536338612;10216;10237.897621023769;38088.23823523542;38224.235515289816;38373;38530.422043669365;38553.421698674545;4056.411820286042;4071.9592804071876;4117.3206420940505;4121.5466298707115;4121.876343709693;29333.559996600066;29359;29596.852015739998;29616.407671846657;29721.25696857574;4104.117614712821;4248.362745588156;4264.6801489888385;4270.914581708348;4367.58507941745;321559;321909;323225;324230.3788481066;324258;50096;50273.74863125734;50405.49594504008;50670.239946400834;50735;54267.18599220936;54271.18593221105;54419.72790136103;54446.727766361706;54604.45395545994;15294.158821264937;15501.457448989231;15542.300596473186;15545.455909043128;15559.22203889801;10980.231383803057;11181.049610783175;11692.70768230784;11834.408279585987;11953.282803031672;16961.674772932824;17014.659706805796;17021;17025.31898724037;17120.57198570046;6277.96861015692;6512.706928188243;6668.33316668339;6746.325367463214;6770.898436523357;882.960266787996;900.7477906186278;905.8143080668447;910.239949642043;928.4661319741176;30018.549721754192;31042.68957310443;31363.215919602193;31518.212044699067;31932.840335798635;1027.1936529824052;1027.7379268286688;1036.5542816588788;1038.3873514626407;1044.7127040064042;15670.216489175496;16566.751498727528;16613;16708.6658266834;16778.580535486468;492726;495417;495750;496272;496950;57765.13352299719;57879.13181302284;58178.7091064542;58183;58185.054270386645;1333.6932505523785;1368.9452421903013;1399.6151058458802;1402.3759427055068;1404.5435233548933;28425.573616395355;30064.398712026075;30492.695073048984;30716.385672286877;30721.236348486662;48031.75984120057;48922.75538622284;49177;49357;49396;315038;316408;316730;317140;317189;26758;27149.86425067862;27237.72762272352;27300.863495682395;27403.725962740118;40840.38739418852;45263.32105018493;46331.30503042525;46412.535874640824;46705.29942050804;38832.223355532165;39442;39694.2061158781;39810.601893981846;41114.383284250165;39592;39645.207095858495;41015.589844101174;41578;41579.792101039304;39297.80351098226;39743.60256397399;39974.20051598894;40469.392959106226;40705.79647101746;32995.175120621214;35766.821165894005;35819;36164.09589760277;36288.4556731644;26923.192304230903;26935.73064269332;27070.289486034373;27250.727492724818;27368.315792105357 15:27:24 INFO - PROCESS | 12756 | |2;jquery.html;389.85575337125266;399.3689969847641;402.69797651761195;404.84008816517485;419.8496120629474;16496.34014639413;16554.172291385443;17807.198676059576;19157.137928793203;19160.233590656375;12009.159358844885;12539.561115360964;12544.933680637158;15238.466653667125;18785.248590056417;5166.870828229296;5341.145416733323;5354.464553544633;5360.606242376971;5363.892722145555;4497.347884556737;5736.483716465538;5761.711914404263;5763.049096899007;5785.450382213704;5733.054046082391;5737.110747834093;5739.827805165852;5742;5743.195952566644;5578.219049333096;5698.316202055759;5739.110437882135;5739.110437882135;5748.482636562709;5076.84234200467;5080.237964305346;5176.663516871429;5192.506711862367;5207.192885102815;22451.887740561357;22680.206192783175;22895.885520572458;22948.885255573783;23214.303570892902;2919.8394088325135;2974.3902499987453;3064.341166649181;3094.808498728006;3101.7518598512065;9786.41281523111;10214.591416343337;10666.78666426667;10760.3543787373;10782.191335649857;1949.7465329507215;1960.3922783937026;1975.7135215393687;1984.4939540417245;2013.6073465674199;73521.6323918377;74847.62576187139;75396;77195.61402193009;77354;10930.781384372269;11103.38931358783;11161.441927903572;11196.849449253272;11373.782112487985;15550.300236489385;15695;15707.214639267992;15714.68570628581;15775.68448631044;7922.405819563441;8180.263776260165;8212.958935205286;8325.084240733515;8440;7695.422843286776;7775.805604859811;7998.48009879356;8030.156833532512;8074.394420418492;4741.407324084489;4801.135795556834;4852.447216890561;4874.268859671007;4878.268259761065;2010.9698354524694;2023.736914201174;2042.3260324093014;2049.1496029148034;2054.613400390148;964.8456247000446;992.118775623932;1008.445355054717;1015.1878497202209;1057.2968975631272;17456.389026384015;17853.28586856537;18539.165737541844;18878.716819247722;19006.61986760257;1002.8946960569181;1003.1322905686528;1003.5333569890037;1016.9847452288221;1021.5300961557766;9783.608655653694;10451.111655509214;10679.519421626046;10695.465226738632;11001.56510123325;424312;434270;445444;451583;453860;69272.6536367315;83807.5809620948;85033;85592;86806;1037.1184493180888;1068.871735391758;1076.359566058194;1080.2330345454816;1084.3060441317405;17103.657926841643;17256.22346994363;17261.79167458316;17584.296628134733;17761.55596110056;39835.402468962406;40257.396139058525;40659.390109148975;40943.38584921288;42225.577744223396;55370.44629553814;55720.72139639276;55907.44092559185;56096.71951640379;57782.71108644598;6024.457798798129;7539.773806785805;7878.133405325295;8566.400351975302;8616.267617252604;13039.934800325938;13420;13450.798238026633;13839.100458470168;14264.144151350953;11532.36571988515;11719.531218751154;11818.822717659414;11901.285922844658;12106.818397723864;11389.943050284695;11575.652730418102;11580.073594112619;11680.357580333164;11833.881661183623;11493.195476316578;11973.640790776291;12022.819657705317;12088.516459341528;12314.938425307817;7670.8082297943;7729.690812367442;7890.092639346319;8112.716054938285;8182.345412367115;11300.717482063013;11671;11676.824847627462;11685.707857303296;11851.644450666494 15:27:24 INFO - PROCESS | 12756 | |3;mootools.html;1295.7797174480338;1319.9670008249786;1323.629383772544;1324.4371142264536;1326.7081242126733;8181.468204566699;8316.1268066853;8591.828163436727;8665.956670216648;8667.21995020448;8320.916790832105;8853.778655533615;8854.645814167425;8859.114088591154;8893.599788009538;2364.9645255321143;2384.558856611524;2391.964120538193;2401.7598240176017;2418.262429958862;2076.294060019593;2154.9030293636824;2355.3522781235124;2371.67982322386;2398.1126983016306;2339.9883000584973;2351.2946116165167;2352.5765362234793;2361.645753137026;2368.27767530903;2238.876861772602;2260.42359198405;2271.829612779048;2283.292179424384;2286.2912497125944;2352.270796053229;2352.388379021467;2357.092519380034;2366.6331718583647;2375.857448553092;8425.494470331738;8523.957380213122;8526.190011948855;8532.14678532148;8553.529555874424;5139.15203991341;5229.816956406546;5280.128778751501;5280.788768449257;5301.54936830366;3349.4138525757894;3545.468179773029;3557.5375201223933;3566.197605538733;3587.892363229107;1424.9073810202408;1483.0879009409243;1511.12354834197;1554.6424322405796;1563.9218039098;11818.881811181864;11982.580609678707;12025.699357516045;12067.818982715266;12089.879101208964;4406.9779651101535;4723.126221649006;4736.834210802605;4815.831445899376;4831.685940413862;10023.849642255373;10118.190544756402;10143.23925705575;10166.949165254275;10176.338537995007;5123.590112790967;5161.509656582619;5167.405748338914;5368.194770784414;5449.373322068013;4755.809767609257;4892.828750993698;4935.235038568956;4951.133551628451;4982.875428114254;3886.2810380079777;3899.239648268617;3980.3233450313514;3995.5205375355144;4018;1225.2342286071205;1234.3643023842728;1241.1622155045309;1265.8607553169145;1312.3831799054428;934.2759361494896;936.6768464879606;952;961.1493827962304;977.5258999385293;5541.6120871539415;5623.325200975827;5703.572232082611;5887.676177810176;6190.102435146879;924.4591913730543;932.2961164320894;932.9953350233341;938.7559234599054;954.441651633802;4129.793510324532;4237.258479766028;4246.749222911862;4259.105587826529;4271.273883439822;10262.846057309147;10578.788424231472;10637.521311540999;10659.093977011886;10663.466826658636;9784.510774461249;10336.379817210991;10347.844782328271;10389.37663740178;10614.416207108528;8070.435069545193;8102.878456823152;8239.629216685264;8264.669413223524;8268.131846156188;5805.187273781758;5920.141579471038;5962.522998160223;6044.153818465506;6147.477464415575;9413.905860941302;9540.618375264912;9599.664011759554;9606.711798646053;9640.276979226726;9080.59137338808;9558;9559.61761529531;9649.179819715402;9680.419174849532;7674.462787605037;7789.182135875878;7802.648880800264;7834.764957051298;7840.960795195988;7974.441789074709;8090.271875530995;8094.190580941859;8114.675412983414;8124.22819832115;7478.364339031244;7597.392208623407;7730.45886787942;7731.265529774662;7818.179091195342;7247.565146091251;7291.760400731994;7356.190819010012;7364.742234021784;7385.778426647209;6452.903206451813;6550.934490655032;6556.213254409501;6565.474762019123;6572.572782769296;4856.125897338513;4874.90250194987;4898.9020219594695;4986.376702912136;5128.79484820603;5049.64652474338;5102.770375333044;5247.08176069194;5248;5262.26328314044 15:27:24 INFO - PROCESS | 12756 | |4;prototype.html;384.14910972196594;400.9719319647625;405.9939100913486;406.9267531844267;412.2929176462366;5210.55710264627;5344.579469139754;5405;5437.157240627699;5489.176623506471;5157.5616072633875;5281.815136470224;5335.973320133404;5351.7056561889085;5357.383900851403;4341.761203133827;4346.348047792832;4367.694261401703;4379.737215767064;4387.692861499696;4008.5590585035625;4180.602842729936;4376.606105450509;4378.912421751563;4390.341448782692;4165.312723400635;4167.93717602011;4172.395002724603;4174.77038762868;4179.770112643803;4157.3140431828715;4187.267228235077;4205.495340559137;4216.3464662976985;4239.236937351276;3746.9063273418383;3748.906277343061;3750.774953502799;3754.812259387047;3766.4538641897047;5096.23556466533;5155.871103222412;5180;5184.170532714747;5228.895422091575;4728.172569800271;4732.455767586737;4756.167670657655;4783.449903261135;4787.234042553209;5400.29796126505;5505.752241149158;5534.782347883459;5557.360903496069;5566.276384070085;4017.196560687874;4029.5164580250266;4042.191561687674;4042.312806822847;4044.672200745204;5781.277340332458;5813.854653633651;5840.131158029432;5907.232059832238;5913.645181289094;4194.6853985950565;4207.431996680409;4213.620774130343;4219.599138081878;4220.282551966112;4076.510818701775;4132.5329508024815;4199.706020578591;4207.495100587949;4213.810378532973;4732.550407711262;4733.266343716729;4740.842916472997;4750.097481478508;4755.38180036593;5558.888822223533;5572.944270557324;5600.943990560124;5629.802956896489;5644.9435505644415;1336.712606789545;1399.8110255115632;1406.971860562783;1415.8654927781845;1425.5865798918405;972.7859870828406;979.8334283171736;996.2528103922059;1001.2290536287019;1012.1851909213154;5194.143221228309;5215.843524694265;5227.372715274191;5228.895422091613;5238.869028274247;5576.1356989666665;5587.217789509472;5595.552355811526;5598.272224610856;5647.079992802384;5080.13637681595;5158.587313015025;5229.738513074331;5259.579233661298;5463.6614029562215;2974.940501189964;2979.2998645318335;3006.864691088906;3010.2775333919703;3015.1406849048353;5809.390014048548;5828.601135727395;5834.499300419714;5905.4685078343155;5918.911216331759;5465.535429488538;5782.768689252467;5807.88384232313;5827.3007239131575;5829.387914268941;5935.910961335583;5938.524918006549;5953.91069133972;5962.22491076166;5998.340182579913;5496.587755918242;5728.198052272768;5729.770809167587;5769.30768307789;5819.301683797971;5743.540516758733;5783.739731712168;5792.4497172768515;5800.187973683772;5811.389804070512;6045.304789949037;6055.303640081447;6092;6107.358727333566;6131.417515336036;3944.56609772919;4128.298189307885;4168.979155104205;4175.306927032108;4176.686748493815;5582.441755824385;5742.19609254713;5754.712264386848;5769.567107570989;5786.681732504752;5586.581006424453;5630.521405680399;5658.405867383865;5660.320761508646;5694.515966142924;5561.860953476195;5635.492805647511;5661.377248502579;5663.490285874291;5669.773209071591;5430.185472179047;5631;5634.183043458757;5657.4059723728415;5671.206031155724;5719.456651618256;5724.942750572441;5729.742161602821;5758.424157584208;5793.333766616893;5453.563714902878;5539.584531160099;5569;5592.210492642315;5636.633618814764 15:27:24 INFO - PROCESS | 12756 | |5;yui.html;722.8084557592242;725.300085417572;766.3868904876098;805.0942689474341;843.3716880923711;14557.927210363947;14876.925615371934;14988.325525351358;15012.699746005073;15159.924200378997;14203.431862725478;14234.217118058503;14331.355089020994;14435.783463248034;14964.102153870776;792.2750683124948;818.643889907889;819.9344052475817;824.7031068815222;827.9172082791733;818.1940788323496;819.0867183090841;819.2954059508847;819.81554150316;821.1419067074892;862.6764963138822;863.1541089732067;865.1651156633847;865.904750477447;867.5965675960678;851.476342049635;858.7380848841101;859.3468963587687;859.5401460218784;860.7805009722512;627.438442593876;630.6531407725778;631.5989346764792;633.6293268437969;633.9936600633981;15691.372345106181;15939.203039847962;16135.515934521984;16234.837651623451;16287.104209268486;13637.931810340884;14070.15579065249;14147;14210.715785684331;14272.714545709028;11646.475908584134;11705.12211584126;11894.107941904393;11977.341246231454;12033.81949270753;3734.906627334311;3748.4377343398437;3801.4107813288983;3805.3530899746834;3857.324968130566;82073;83180.58409707913;85218.14781852164;85745.14254857496;85986.14013859906;11223.887761122447;11300.49147788335;11305.095592352593;11444.084473242121;11545.769084618261;21715;21755.891220544112;21871.45321366947;22028.449288767588;22130.22544210977;8235.752927412188;8297.58512074394;8377.95811020941;8386.79033024167;8446.746597602081;4546.431696037996;4644.86065418038;4659.138059459011;4731.313959475857;4812.109759694397;3678.33789917812;3697.6302369762807;3731.4402839573736;3759.6240375962734;3788.3559794834946;565.7058329668549;576.8586696259359;578.3551340255668;579.39163877928;587.9147523609053;719.2807192807193;725.7399067473857;727.2182403915812;739.4454159380465;740.76665850257;9183.90816091844;9896.752581185528;9944.950275248577;10001.449920254456;10153.593856245816;714.7962830593256;740.7999041552719;743.4352280813405;761.3984951887946;766.180187199691;4452.821887124479;4768.7615619218905;4781.2350023996;4813.711177329372;4832.9609134036355;81385.59307203426;82102.58948705219;82976.30890903054;85655;86413.56793215993;56511.71744141253;57234.141487877714;57306.713466432404;58867.41132588705;65085.349146508874;56956.71521642448;56970.43029569734;57272.42727572754;58132.41867581355;58302;9991.150752186146;10574.524146413276;10623.256372054191;10655.467226638792;10788.460576971276;38690.41964370593;39363.409548857366;39414.408783868836;40433.1913361737;40877.1824563513;48177.27734083922;49277;49377.50622493729;50129;50200.24699629436;12525.436355363849;12578.748425031632;13192.142510736772;13479.730405392034;14246.501372451914;14558.222930570859;14755.188464634548;14785.556433307018;15076.547703568911;15132.394704211709;12428;12489.875101248872;12852.485900564247;12881.935590321988;13392;12595.811062833882;12841.93579032099;13043.152195107288;13125.474981000652;13480.595582132551;13486.86513134856;13646.385912634154;13717.17696938187;14369.209693466959;14862;11072.224944253825;11119.221654484109;11477.942610286895;11547;11805.350705710925;10120.94939525327;12223.97121655034;12232.510699571918;12484;12698.936505317415 15:27:24 INFO - PROCESS | 12756 | __end_tp_report 15:27:24 INFO - PROCESS | 12756 | __start_cc_report 15:27:24 INFO - PROCESS | 12756 | _x_x_mozilla_cycle_collect,321 15:27:24 INFO - PROCESS | 12756 | __end_cc_report 15:27:24 INFO - PROCESS | 12756 | __startTimestamp1483140444198__endTimestamp 15:27:24 INFO - PROCESS | 12756 | 15:27:24 INFO - PROCESS | 12756 | ------- Summary: start ------- 15:27:24 INFO - PROCESS | 12756 | Number of tests: 6 15:27:24 INFO - PROCESS | 12756 | 15:27:24 INFO - PROCESS | 12756 | [#0] dojo.html Cycles:165 Average:5446.37 Median:5686.23 stddev:628.49 (11.1%) stddev-sans-first:605.43 15:27:24 INFO - PROCESS | 12756 | Values: 3209.9 3235.4 3238.5 3257.8 3261.2 5382.0 5460.5 5494.8 5501.6 5527.5 5434.9 5473.9 5544.7 5572.3 5585.3 4928.5 4980.8 5006.3 5082.6 5113.9 4950.2 5090.1 5092.2 5102.9 5125.1 4867.9 4905.8 5050.0 5073.8 5080.0 4935.8 4961.6 4979.0 5005.8 5073.7 4922.5 4946.5 4947.0 4964.3 5005.5 5335.8 5408.0 5431.2 5452.3 5454.7 5744.9 5758.6 5775.3 5788.0 5902.6 5859.4 5866.4 5867.0 5870.6 5873.4 5435.4 5436.9 5444.0 5448.0 5459.3 5809.3 5879.3 5957.5 5974.7 5984.0 5772.6 5775.9 5793.5 5806.9 5821.8 5825.4 5832.7 5903.2 5919.0 5938.9 5723.5 5772.6 5804.6 5839.3 5842.6 5861.2 5861.9 5864.1 5868.9 5919.6 4388.3 4405.0 4405.7 4415.4 4443.1 3881.3 3904.4 3907.5 3910.0 3929.5 5561.1 5582.5 5588.6 5606.4 5623.7 5881.5 5920.7 5932.3 5952.0 5962.3 5458.9 5464.9 5542.6 5617.1 5622.3 4849.6 4892.2 4899.9 4932.0 4938.3 6157.1 6195.5 6199.2 6200.4 6203.1 5746.4 5807.8 5910.4 5910.7 5915.8 6112.2 6115.1 6126.9 6175.4 6188.0 5733.3 5825.8 5825.8 5827.7 5839.3 5764.4 5892.6 5951.5 5957.0 5971.8 5686.2 5699.2 5702.2 5729.5 5801.8 5711.1 5727.1 5727.5 5756.7 5767.9 5430.1 5453.9 5723.8 5766.5 5767.8 5710.0 5752.2 5754.0 5796.0 5818.0 5572.2 5605.4 5625.3 5628.4 5629.4 15:27:24 INFO - PROCESS | 12756 | 15:27:24 INFO - PROCESS | 12756 | [#1] ext.html Cycles:180 Average:54127.09 Median:38298.62 stddev:102344.54 (267.2%) stddev-sans-first:102552.59 15:27:24 INFO - PROCESS | 12756 | Values: 549.9 551.8 560.5 574.1 582.3 41507.4 42641.0 42695.8 46314.0 46352.5 43549.8 43870.8 43959.3 43970.0 44057.8 8801.7 8957.2 8967.2 8968.0 9950.7 9910.8 10283.7 10286.4 10292.3 10294.3 10349.4 10358.9 10385.0 10392.7 10416.5 10203.4 10275.5 10312.1 10319.8 10351.7 10107.3 10152.5 10211.6 10216.0 10237.9 38088.2 38224.2 38373.0 38530.4 38553.4 4056.4 4072.0 4117.3 4121.5 4121.9 29333.6 29359.0 29596.9 29616.4 29721.3 4104.1 4248.4 4264.7 4270.9 4367.6 321559.0 321909.0 323225.0 324230.4 324258.0 50096.0 50273.7 50405.5 50670.2 50735.0 54267.2 54271.2 54419.7 54446.7 54604.5 15294.2 15501.5 15542.3 15545.5 15559.2 10980.2 11181.0 11692.7 11834.4 11953.3 16961.7 17014.7 17021.0 17025.3 17120.6 6278.0 6512.7 6668.3 6746.3 6770.9 883.0 900.7 905.8 910.2 928.5 30018.5 31042.7 31363.2 31518.2 31932.8 1027.2 1027.7 1036.6 1038.4 1044.7 15670.2 16566.8 16613.0 16708.7 16778.6 492726.0 495417.0 495750.0 496272.0 496950.0 57765.1 57879.1 58178.7 58183.0 58185.1 1333.7 1368.9 1399.6 1402.4 1404.5 28425.6 30064.4 30492.7 30716.4 30721.2 48031.8 48922.8 49177.0 49357.0 49396.0 315038.0 316408.0 316730.0 317140.0 317189.0 26758.0 27149.9 27237.7 27300.9 27403.7 40840.4 45263.3 46331.3 46412.5 46705.3 38832.2 39442.0 39694.2 39810.6 41114.4 39592.0 39645.2 41015.6 41578.0 41579.8 39297.8 39743.6 39974.2 40469.4 40705.8 32995.2 35766.8 35819.0 36164.1 36288.5 26923.2 26935.7 27070.3 27250.7 27368.3 15:27:24 INFO - PROCESS | 12756 | 15:27:24 INFO - PROCESS | 12756 | [#2] jquery.html Cycles:180 Average:26951.60 Median:13067.07 stddev:72858.79 (557.6%) stddev-sans-first:73035.88 15:27:24 INFO - PROCESS | 12756 | Values: 389.9 399.4 402.7 404.8 419.8 16496.3 16554.2 17807.2 19157.1 19160.2 12009.2 12539.6 12544.9 15238.5 18785.2 5166.9 5341.1 5354.5 5360.6 5363.9 4497.3 5736.5 5761.7 5763.0 5785.5 5733.1 5737.1 5739.8 5742.0 5743.2 5578.2 5698.3 5739.1 5739.1 5748.5 5076.8 5080.2 5176.7 5192.5 5207.2 22451.9 22680.2 22895.9 22948.9 23214.3 2919.8 2974.4 3064.3 3094.8 3101.8 9786.4 10214.6 10666.8 10760.4 10782.2 1949.7 1960.4 1975.7 1984.5 2013.6 73521.6 74847.6 75396.0 77195.6 77354.0 10930.8 11103.4 11161.4 11196.8 11373.8 15550.3 15695.0 15707.2 15714.7 15775.7 7922.4 8180.3 8213.0 8325.1 8440.0 7695.4 7775.8 7998.5 8030.2 8074.4 4741.4 4801.1 4852.4 4874.3 4878.3 2011.0 2023.7 2042.3 2049.1 2054.6 964.8 992.1 1008.4 1015.2 1057.3 17456.4 17853.3 18539.2 18878.7 19006.6 1002.9 1003.1 1003.5 1017.0 1021.5 9783.6 10451.1 10679.5 10695.5 11001.6 424312.0 434270.0 445444.0 451583.0 453860.0 69272.7 83807.6 85033.0 85592.0 86806.0 1037.1 1068.9 1076.4 1080.2 1084.3 17103.7 17256.2 17261.8 17584.3 17761.6 39835.4 40257.4 40659.4 40943.4 42225.6 55370.4 55720.7 55907.4 56096.7 57782.7 6024.5 7539.8 7878.1 8566.4 8616.3 13039.9 13420.0 13450.8 13839.1 14264.1 11532.4 11719.5 11818.8 11901.3 12106.8 11389.9 11575.7 11580.1 11680.4 11833.9 11493.2 11973.6 12022.8 12088.5 12314.9 7670.8 7729.7 7890.1 8112.7 8182.3 11300.7 11671.0 11676.8 11685.7 11851.6 15:27:24 INFO - PROCESS | 12756 | 15:27:24 INFO - PROCESS | 12756 | [#3] mootools.html Cycles:180 Average:5686.67 Median:5126.19 stddev:3143.45 (61.3%) stddev-sans-first:3134.94 15:27:24 INFO - PROCESS | 12756 | Values: 1295.8 1320.0 1323.6 1324.4 1326.7 8181.5 8316.1 8591.8 8666.0 8667.2 8320.9 8853.8 8854.6 8859.1 8893.6 2365.0 2384.6 2392.0 2401.8 2418.3 2076.3 2154.9 2355.4 2371.7 2398.1 2340.0 2351.3 2352.6 2361.6 2368.3 2238.9 2260.4 2271.8 2283.3 2286.3 2352.3 2352.4 2357.1 2366.6 2375.9 8425.5 8524.0 8526.2 8532.1 8553.5 5139.2 5229.8 5280.1 5280.8 5301.5 3349.4 3545.5 3557.5 3566.2 3587.9 1424.9 1483.1 1511.1 1554.6 1563.9 11818.9 11982.6 12025.7 12067.8 12089.9 4407.0 4723.1 4736.8 4815.8 4831.7 10023.8 10118.2 10143.2 10166.9 10176.3 5123.6 5161.5 5167.4 5368.2 5449.4 4755.8 4892.8 4935.2 4951.1 4982.9 3886.3 3899.2 3980.3 3995.5 4018.0 1225.2 1234.4 1241.2 1265.9 1312.4 934.3 936.7 952.0 961.1 977.5 5541.6 5623.3 5703.6 5887.7 6190.1 924.5 932.3 933.0 938.8 954.4 4129.8 4237.3 4246.7 4259.1 4271.3 10262.8 10578.8 10637.5 10659.1 10663.5 9784.5 10336.4 10347.8 10389.4 10614.4 8070.4 8102.9 8239.6 8264.7 8268.1 5805.2 5920.1 5962.5 6044.2 6147.5 9413.9 9540.6 9599.7 9606.7 9640.3 9080.6 9558.0 9559.6 9649.2 9680.4 7674.5 7789.2 7802.6 7834.8 7841.0 7974.4 8090.3 8094.2 8114.7 8124.2 7478.4 7597.4 7730.5 7731.3 7818.2 7247.6 7291.8 7356.2 7364.7 7385.8 6452.9 6550.9 6556.2 6565.5 6572.6 4856.1 4874.9 4898.9 4986.4 5128.8 5049.6 5102.8 5247.1 5248.0 5262.3 15:27:24 INFO - PROCESS | 12756 | 15:27:24 INFO - PROCESS | 12756 | [#4] prototype.html Cycles:180 Average:4736.33 Median:5348.14 stddev:1377.84 (25.8%) stddev-sans-first:1342.42 15:27:24 INFO - PROCESS | 12756 | Values: 384.1 401.0 406.0 406.9 412.3 5210.6 5344.6 5405.0 5437.2 5489.2 5157.6 5281.8 5336.0 5351.7 5357.4 4341.8 4346.3 4367.7 4379.7 4387.7 4008.6 4180.6 4376.6 4378.9 4390.3 4165.3 4167.9 4172.4 4174.8 4179.8 4157.3 4187.3 4205.5 4216.3 4239.2 3746.9 3748.9 3750.8 3754.8 3766.5 5096.2 5155.9 5180.0 5184.2 5228.9 4728.2 4732.5 4756.2 4783.4 4787.2 5400.3 5505.8 5534.8 5557.4 5566.3 4017.2 4029.5 4042.2 4042.3 4044.7 5781.3 5813.9 5840.1 5907.2 5913.6 4194.7 4207.4 4213.6 4219.6 4220.3 4076.5 4132.5 4199.7 4207.5 4213.8 4732.6 4733.3 4740.8 4750.1 4755.4 5558.9 5572.9 5600.9 5629.8 5644.9 1336.7 1399.8 1407.0 1415.9 1425.6 972.8 979.8 996.3 1001.2 1012.2 5194.1 5215.8 5227.4 5228.9 5238.9 5576.1 5587.2 5595.6 5598.3 5647.1 5080.1 5158.6 5229.7 5259.6 5463.7 2974.9 2979.3 3006.9 3010.3 3015.1 5809.4 5828.6 5834.5 5905.5 5918.9 5465.5 5782.8 5807.9 5827.3 5829.4 5935.9 5938.5 5953.9 5962.2 5998.3 5496.6 5728.2 5729.8 5769.3 5819.3 5743.5 5783.7 5792.4 5800.2 5811.4 6045.3 6055.3 6092.0 6107.4 6131.4 3944.6 4128.3 4169.0 4175.3 4176.7 5582.4 5742.2 5754.7 5769.6 5786.7 5586.6 5630.5 5658.4 5660.3 5694.5 5561.9 5635.5 5661.4 5663.5 5669.8 5430.2 5631.0 5634.2 5657.4 5671.2 5719.5 5724.9 5729.7 5758.4 5793.3 5453.6 5539.6 5569.0 5592.2 5636.6 15:27:24 INFO - PROCESS | 12756 | 15:27:24 INFO - PROCESS | 12756 | [#5] yui.html Cycles:180 Average:17282.76 Median:22665.00 stddev:22050.99 (97.3%) stddev-sans-first:22077.78 15:27:24 INFO - PROCESS | 12756 | Values: 722.8 725.3 766.4 805.1 843.4 14557.9 14876.9 14988.3 15012.7 15159.9 14203.4 14234.2 14331.4 14435.8 14964.1 792.3 818.6 819.9 824.7 827.9 818.2 819.1 819.3 819.8 821.1 862.7 863.2 865.2 865.9 867.6 851.5 858.7 859.3 859.5 860.8 627.4 630.7 631.6 633.6 634.0 15691.4 15939.2 16135.5 16234.8 16287.1 13637.9 14070.2 14147.0 14210.7 14272.7 11646.5 11705.1 11894.1 11977.3 12033.8 3734.9 3748.4 3801.4 3805.4 3857.3 82073.0 83180.6 85218.1 85745.1 85986.1 11223.9 11300.5 11305.1 11444.1 11545.8 21715.0 21755.9 21871.5 22028.4 22130.2 8235.8 8297.6 8378.0 8386.8 8446.7 4546.4 4644.9 4659.1 4731.3 4812.1 3678.3 3697.6 3731.4 3759.6 3788.4 565.7 576.9 578.4 579.4 587.9 719.3 725.7 727.2 739.4 740.8 9183.9 9896.8 9945.0 10001.4 10153.6 714.8 740.8 743.4 761.4 766.2 4452.8 4768.8 4781.2 4813.7 4833.0 81385.6 82102.6 82976.3 85655.0 86413.6 56511.7 57234.1 57306.7 58867.4 65085.3 56956.7 56970.4 57272.4 58132.4 58302.0 9991.2 10574.5 10623.3 10655.5 10788.5 38690.4 39363.4 39414.4 40433.2 40877.2 48177.3 49277.0 49377.5 50129.0 50200.2 12525.4 12578.7 13192.1 13479.7 14246.5 14558.2 14755.2 14785.6 15076.5 15132.4 12428.0 12489.9 12852.5 12881.9 13392.0 12595.8 12841.9 13043.2 13125.5 13480.6 13486.9 13646.4 13717.2 14369.2 14862.0 11072.2 11119.2 11477.9 11547.0 11805.4 10120.9 12224.0 12232.5 12484.0 12698.9 15:27:24 INFO - PROCESS | 12756 | -------- Summary: end -------- 15:27:24 INFO - PROCESS | 12756 | 15:27:24 INFO - TEST-INFO | 12756: exit 0 15:27:24 INFO - TEST-OK | dromaeo_css | took 1113719ms 15:27:24 INFO - TEST-START | kraken 15:27:24 INFO - operating with platform_type : linux_ 15:27:24 INFO - Initialising browser for kraken test... 15:27:24 INFO - TEST-INFO | started process 13116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZBCLc0/profile http://localhost:35655/getInfo.html) 15:27:25 INFO - PROCESS | 13116 | 1483140445446 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 15:27:28 INFO - PROCESS | 13116 | __metrics Screen width/height:1600/1200 15:27:28 INFO - PROCESS | 13116 | colorDepth:24 15:27:28 INFO - PROCESS | 13116 | Browser inner width/height: 1024/697 15:27:28 INFO - PROCESS | 13116 | __metrics 15:27:29 ERROR - PROCESS | 13116 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 15:27:30 INFO - TEST-INFO | 13116: exit 0 15:27:30 INFO - Browser initialized. 15:27:30 INFO - Running cycle 1/1 for kraken test... 15:27:30 INFO - TEST-INFO | started process 13238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZBCLc0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:27:42 INFO - PROCESS | 13238 | RSS: Main: 154456064 15:27:42 INFO - PROCESS | 13238 | 15:27:44 INFO - PROCESS | 13238 | Cycle 1(1): loaded http://localhost:35655/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35655/tests/kraken/driver.html?testName=audio-beat-detection) 15:27:45 INFO - PROCESS | 13238 | RSS: Main: 160739328 15:27:45 INFO - PROCESS | 13238 | 15:27:48 INFO - PROCESS | 13238 | Cycle 1(1): loaded http://localhost:35655/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35655/tests/kraken/driver.html?testName=audio-dft) 15:27:48 INFO - PROCESS | 13238 | RSS: Main: 159387648 15:27:48 INFO - PROCESS | 13238 | 15:27:51 INFO - PROCESS | 13238 | Cycle 1(1): loaded http://localhost:35655/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35655/tests/kraken/driver.html?testName=audio-fft) 15:27:52 INFO - PROCESS | 13238 | RSS: Main: 156688384 15:27:52 INFO - PROCESS | 13238 | 15:27:54 INFO - PROCESS | 13238 | Cycle 1(1): loaded http://localhost:35655/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35655/tests/kraken/driver.html?testName=audio-oscillator) 15:27:55 INFO - PROCESS | 13238 | RSS: Main: 157171712 15:27:55 INFO - PROCESS | 13238 | 15:27:57 INFO - PROCESS | 13238 | Cycle 1(1): loaded http://localhost:35655/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35655/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:27:57 INFO - PROCESS | 13238 | RSS: Main: 157237248 15:27:57 INFO - PROCESS | 13238 | 15:28:00 INFO - PROCESS | 13238 | Cycle 1(1): loaded http://localhost:35655/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35655/tests/kraken/driver.html?testName=imaging-darkroom) 15:28:01 INFO - PROCESS | 13238 | RSS: Main: 160940032 15:28:01 INFO - PROCESS | 13238 | 15:28:04 INFO - PROCESS | 13238 | Cycle 1(1): loaded http://localhost:35655/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35655/tests/kraken/driver.html?testName=imaging-desaturate) 15:28:05 INFO - PROCESS | 13238 | RSS: Main: 159678464 15:28:05 INFO - PROCESS | 13238 | 15:28:08 INFO - PROCESS | 13238 | Cycle 1(1): loaded http://localhost:35655/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35655/tests/kraken/driver.html?testName=json-parse-financial) 15:28:09 INFO - PROCESS | 13238 | RSS: Main: 160346112 15:28:09 INFO - PROCESS | 13238 | 15:28:10 INFO - PROCESS | 13238 | Cycle 1(1): loaded http://localhost:35655/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35655/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:28:11 INFO - PROCESS | 13238 | RSS: Main: 159907840 15:28:11 INFO - PROCESS | 13238 | 15:28:13 INFO - PROCESS | 13238 | Cycle 1(1): loaded http://localhost:35655/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35655/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:28:13 INFO - PROCESS | 13238 | RSS: Main: 160198656 15:28:13 INFO - PROCESS | 13238 | 15:28:15 INFO - PROCESS | 13238 | Cycle 1(1): loaded http://localhost:35655/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35655/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:28:16 INFO - PROCESS | 13238 | RSS: Main: 160624640 15:28:16 INFO - PROCESS | 13238 | 15:28:19 INFO - PROCESS | 13238 | Cycle 1(1): loaded http://localhost:35655/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:28:19 INFO - PROCESS | 13238 | RSS: Main: 160362496 15:28:19 INFO - PROCESS | 13238 | 15:28:22 INFO - PROCESS | 13238 | Cycle 1(1): loaded http://localhost:35655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:28:23 INFO - PROCESS | 13238 | RSS: Main: 160501760 15:28:23 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | Cycle 1(1): loaded http://localhost:35655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35655/tests/kraken/driver.html?testName=ai-astar) 15:28:25 INFO - PROCESS | 13238 | RSS: Main: 161665024 15:28:25 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | __start_tp_report 15:28:25 INFO - PROCESS | 13238 | _x_x_mozilla_page_load 15:28:25 INFO - PROCESS | 13238 | _x_x_mozilla_page_load_details 15:28:25 INFO - PROCESS | 13238 | |i|pagename|runs| 15:28:25 INFO - PROCESS | 13238 | |0;ai-astar;107;113;113;113;114;115;113;115;113;113 15:28:25 INFO - PROCESS | 13238 | |1;audio-beat-detection;158;123;126;171;124;128;123;122;142;126 15:28:25 INFO - PROCESS | 13238 | |2;audio-dft;161;163;163;161;163;166;173;164;161;163 15:28:25 INFO - PROCESS | 13238 | |3;audio-fft;76;75;75;106;78;77;76;75;101;75 15:28:25 INFO - PROCESS | 13238 | |4;audio-oscillator;84;84;112;84;84;85;93;83;84;110 15:28:25 INFO - PROCESS | 13238 | |5;imaging-gaussian-blur;116;117;117;118;117;118;118;118;117;121 15:28:25 INFO - PROCESS | 13238 | |6;imaging-darkroom;150;148;148;148;148;148;149;149;147;148 15:28:25 INFO - PROCESS | 13238 | |7;imaging-desaturate;97;97;96;96;96;96;96;97;96;96 15:28:25 INFO - PROCESS | 13238 | |8;json-parse-financial;56;59;57;57;58;59;59;60;57;58 15:28:25 INFO - PROCESS | 13238 | |9;json-stringify-tinderbox;67;67;71;66;67;67;66;67;67;67 15:28:25 INFO - PROCESS | 13238 | |10;stanford-crypto-aes;81;81;82;83;83;93;82;80;90;84 15:28:25 INFO - PROCESS | 13238 | |11;stanford-crypto-ccm;132;126;127;128;127;127;138;138;175;130 15:28:25 INFO - PROCESS | 13238 | |12;stanford-crypto-pbkdf2;166;167;169;173;166;165;163;171;173;164 15:28:25 INFO - PROCESS | 13238 | |13;stanford-crypto-sha256-iterative;64;63;64;64;63;63;62;66;74;61 15:28:25 INFO - PROCESS | 13238 | __end_tp_report 15:28:25 INFO - PROCESS | 13238 | __start_cc_report 15:28:25 INFO - PROCESS | 13238 | _x_x_mozilla_cycle_collect,745 15:28:25 INFO - PROCESS | 13238 | __end_cc_report 15:28:25 INFO - PROCESS | 13238 | __startTimestamp1483140505261__endTimestamp 15:28:25 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | ------- Summary: start ------- 15:28:25 INFO - PROCESS | 13238 | Number of tests: 14 15:28:25 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:2.23 (2.0%) stddev-sans-first:0.88 15:28:25 INFO - PROCESS | 13238 | Values: 107.0 113.0 113.0 113.0 114.0 115.0 113.0 115.0 113.0 113.0 15:28:25 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:127.00 stddev:17.19 (13.5%) stddev-sans-first:15.95 15:28:25 INFO - PROCESS | 13238 | Values: 158.0 123.0 126.0 171.0 124.0 128.0 123.0 122.0 142.0 126.0 15:28:25 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.58 (2.2%) stddev-sans-first:3.66 15:28:25 INFO - PROCESS | 13238 | Values: 161.0 163.0 163.0 161.0 163.0 166.0 173.0 164.0 161.0 163.0 15:28:25 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.50 stddev:11.75 (15.6%) stddev-sans-first:12.30 15:28:25 INFO - PROCESS | 13238 | Values: 76.0 75.0 75.0 106.0 78.0 77.0 76.0 75.0 101.0 75.0 15:28:25 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:84.00 stddev:11.28 (13.4%) stddev-sans-first:11.74 15:28:25 INFO - PROCESS | 13238 | Values: 84.0 84.0 112.0 84.0 84.0 85.0 93.0 83.0 84.0 110.0 15:28:25 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:1.34 (1.1%) stddev-sans-first:1.27 15:28:25 INFO - PROCESS | 13238 | Values: 116.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 117.0 121.0 15:28:25 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.60 15:28:25 INFO - PROCESS | 13238 | Values: 150.0 148.0 148.0 148.0 148.0 148.0 149.0 149.0 147.0 148.0 15:28:25 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 15:28:25 INFO - PROCESS | 13238 | Values: 97.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 15:28:25 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.50 stddev:1.25 (2.1%) stddev-sans-first:1.09 15:28:25 INFO - PROCESS | 13238 | Values: 56.0 59.0 57.0 57.0 58.0 59.0 59.0 60.0 57.0 58.0 15:28:25 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 15:28:25 INFO - PROCESS | 13238 | Values: 67.0 67.0 71.0 66.0 67.0 67.0 66.0 67.0 67.0 67.0 15:28:25 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:4.23 (5.1%) stddev-sans-first:4.35 15:28:25 INFO - PROCESS | 13238 | Values: 81.0 81.0 82.0 83.0 83.0 93.0 82.0 80.0 90.0 84.0 15:28:25 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:131.00 stddev:14.81 (11.3%) stddev-sans-first:15.67 15:28:25 INFO - PROCESS | 13238 | Values: 132.0 126.0 127.0 128.0 127.0 127.0 138.0 138.0 175.0 130.0 15:28:25 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:168.00 stddev:3.62 (2.2%) stddev-sans-first:3.79 15:28:25 INFO - PROCESS | 13238 | Values: 166.0 167.0 169.0 173.0 166.0 165.0 163.0 171.0 173.0 164.0 15:28:25 INFO - PROCESS | 13238 | 15:28:25 INFO - PROCESS | 13238 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.00 stddev:3.63 (5.7%) stddev-sans-first:3.84 15:28:25 INFO - PROCESS | 13238 | Values: 64.0 63.0 64.0 64.0 63.0 63.0 62.0 66.0 74.0 61.0 15:28:25 INFO - PROCESS | 13238 | -------- Summary: end -------- 15:28:25 INFO - PROCESS | 13238 | 15:28:26 INFO - TEST-INFO | 13238: exit 0 15:28:26 INFO - TEST-OK | kraken | took 61330ms 15:28:26 INFO - SUITE-END | took 1175s 15:28:26 INFO - Completed test suite (00:19:35) 15:28:26 INFO - javascript benchmark 15:28:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7181.260654788953, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3209.8876539321127, 3235.4176248275317, 3238.5142228665695, 3257.7719559630837, 3261.2499125201202, 5382.0312343778105, 5460.481254280842, 5494.80768173114, 5501.559875209983, 5527.474889885464, 5434.8913021739545, 5473.890522189554, 5544.722763861801, 5572.275604171452, 5585.273914391123, 4928.482509336531, 4980.750962451881, 5006.299118123466, 5082.618803589727, 5113.923291150636, 4950.207966725325, 5090.05833920724, 5092.236164575306, 5102.948970510303, 5125.077486052509, 4867.8783030424165, 4905.779239934212, 5049.974750126263, 5073.771680274396, 5080.0, 4935.777889994923, 4961.627877909171, 4978.9751051244875, 5005.824796132154, 5073.695578265316, 4922.507749225085, 4946.455889852114, 4947.0, 4964.255361695738, 5005.549500544932, 5335.759890804923, 5408.0, 5431.212474191259, 5452.291202143736, 5454.727263636842, 5744.942550574483, 5758.596898217126, 5775.27809023872, 5787.971060144672, 5902.586818922677, 5859.4140585941495, 5866.384029676908, 5867.0, 5870.559708021916, 5873.383294754032, 5435.42927992563, 5436.945630543723, 5444.047291723932, 5447.972760136174, 5459.262999495097, 5809.2738407699035, 5879.323877754027, 5957.493613042853, 5974.731137098841, 5984.0, 5772.5959182856795, 5775.88448231033, 5793.507551858139, 5806.912896306559, 5821.825345239649, 5825.3883342248455, 5832.650040997469, 5903.173555702205, 5919.023361145363, 5938.8812223755285, 5723.484886360247, 5772.624779389326, 5804.564657650693, 5839.270091238595, 5842.59101862874, 5861.238039054895, 5861.88276234473, 5864.091065884794, 5868.853278668067, 5919.55603329752, 4388.341748737651, 4405.0, 4405.669574781904, 4415.40392047076, 4443.0669559392245, 3881.301365754135, 3904.375299951994, 3907.492026036597, 3910.0420397002918, 3929.528456585228, 5561.054620714488, 5582.525485333711, 5588.636738612058, 5606.383297837235, 5623.746931388097, 5881.470667639933, 5920.703964801743, 5932.2584676915385, 5952.0, 5962.314333851576, 5458.8908221835345, 5464.863378415572, 5542.5565954723525, 5617.129344951539, 5622.297212848394, 4849.587785038311, 4892.241702536113, 4899.877503062452, 4931.9753401232765, 4938.308636790852, 6157.076438534255, 6195.473384762256, 6199.225096862892, 6200.441960223601, 6203.131561581382, 5746.3966283541295, 5807.767689292381, 5910.408959104056, 5910.70446477683, 5915.792947246998, 6112.235970503687, 6115.088229002258, 6126.877462450815, 6175.382461753788, 6188.0, 5733.3406658234835, 5825.766969321349, 5825.79609713658, 5827.6794776286015, 5839.328477225174, 5764.394738552559, 5892.646441213369, 5951.523878089829, 5957.0, 5971.820845374646, 5686.2323586315315, 5699.202111704281, 5702.2016917630735, 5729.541636668973, 5801.825945221482, 5711.114777209539, 5727.140928860705, 5727.4845263926445, 5756.740946657326, 5767.884642307215, 5430.104032834538, 5453.863653408696, 5723.771049157987, 5766.538676905753, 5767.798127065533, 5709.9714501427225, 5752.223449834386, 5754.021816291157, 5796.0436527972415, 5818.040023396092, 5572.164175373727, 5605.411431799603, 5625.324961004706, 5628.352739435018, 5629.437056294338], "value": 5403.722268820879, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.8872731090127, 551.8344496651005, 560.4563573333864, 574.1158615731773, 582.3099626942072, 41507.37738933915, 42641.0, 42695.78652106739, 46314.0, 46352.53647463524, 43549.78225108878, 43870.780646096806, 43959.340609890874, 43970.0, 44057.7797111014, 8801.69194078209, 8957.19385255327, 8967.237784788302, 8968.0, 9950.65172718955, 9910.801783964316, 10283.691489255334, 10286.382817030964, 10292.279540432173, 10294.279400441972, 10349.430781307063, 10358.948205258963, 10385.0, 10392.740181495485, 10416.479176041206, 10203.4388108654, 10275.486225688686, 10312.071913527781, 10319.84520232197, 10351.741206469824, 10107.3430227035, 10152.543135558917, 10211.591536338612, 10216.0, 10237.897621023769, 38088.23823523542, 38224.235515289816, 38373.0, 38530.422043669365, 38553.421698674545, 4056.411820286042, 4071.9592804071876, 4117.3206420940505, 4121.5466298707115, 4121.876343709693, 29333.559996600066, 29359.0, 29596.852015739998, 29616.407671846657, 29721.25696857574, 4104.117614712821, 4248.362745588156, 4264.6801489888385, 4270.914581708348, 4367.58507941745, 321559.0, 321909.0, 323225.0, 324230.3788481066, 324258.0, 50096.0, 50273.74863125734, 50405.49594504008, 50670.239946400834, 50735.0, 54267.18599220936, 54271.18593221105, 54419.72790136103, 54446.727766361706, 54604.45395545994, 15294.158821264937, 15501.457448989231, 15542.300596473186, 15545.455909043128, 15559.22203889801, 10980.231383803057, 11181.049610783175, 11692.70768230784, 11834.408279585987, 11953.282803031672, 16961.674772932824, 17014.659706805796, 17021.0, 17025.31898724037, 17120.57198570046, 6277.96861015692, 6512.706928188243, 6668.33316668339, 6746.325367463214, 6770.898436523357, 882.960266787996, 900.7477906186278, 905.8143080668447, 910.239949642043, 928.4661319741176, 30018.549721754192, 31042.68957310443, 31363.215919602193, 31518.212044699067, 31932.840335798635, 1027.1936529824052, 1027.7379268286688, 1036.5542816588788, 1038.3873514626407, 1044.7127040064042, 15670.216489175496, 16566.751498727528, 16613.0, 16708.6658266834, 16778.580535486468, 492726.0, 495417.0, 495750.0, 496272.0, 496950.0, 57765.13352299719, 57879.13181302284, 58178.7091064542, 58183.0, 58185.054270386645, 1333.6932505523785, 1368.9452421903013, 1399.6151058458802, 1402.3759427055068, 1404.5435233548933, 28425.573616395355, 30064.398712026075, 30492.695073048984, 30716.385672286877, 30721.236348486662, 48031.75984120057, 48922.75538622284, 49177.0, 49357.0, 49396.0, 315038.0, 316408.0, 316730.0, 317140.0, 317189.0, 26758.0, 27149.86425067862, 27237.72762272352, 27300.863495682395, 27403.725962740118, 40840.38739418852, 45263.32105018493, 46331.30503042525, 46412.535874640824, 46705.29942050804, 38832.223355532165, 39442.0, 39694.2061158781, 39810.601893981846, 41114.383284250165, 39592.0, 39645.207095858495, 41015.589844101174, 41578.0, 41579.792101039304, 39297.80351098226, 39743.60256397399, 39974.20051598894, 40469.392959106226, 40705.79647101746, 32995.175120621214, 35766.821165894005, 35819.0, 36164.09589760277, 36288.4556731644, 26923.192304230903, 26935.73064269332, 27070.289486034373, 27250.727492724818, 27368.315792105357], "value": 19475.047474751875, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.85575337125266, 399.3689969847641, 402.69797651761195, 404.84008816517485, 419.8496120629474, 16496.34014639413, 16554.172291385443, 17807.198676059576, 19157.137928793203, 19160.233590656375, 12009.159358844885, 12539.561115360964, 12544.933680637158, 15238.466653667125, 18785.248590056417, 5166.870828229296, 5341.145416733323, 5354.464553544633, 5360.606242376971, 5363.892722145555, 4497.347884556737, 5736.483716465538, 5761.711914404263, 5763.049096899007, 5785.450382213704, 5733.054046082391, 5737.110747834093, 5739.827805165852, 5742.0, 5743.195952566644, 5578.219049333096, 5698.316202055759, 5739.110437882135, 5739.110437882135, 5748.482636562709, 5076.84234200467, 5080.237964305346, 5176.663516871429, 5192.506711862367, 5207.192885102815, 22451.887740561357, 22680.206192783175, 22895.885520572458, 22948.885255573783, 23214.303570892902, 2919.8394088325135, 2974.3902499987453, 3064.341166649181, 3094.808498728006, 3101.7518598512065, 9786.41281523111, 10214.591416343337, 10666.78666426667, 10760.3543787373, 10782.191335649857, 1949.7465329507215, 1960.3922783937026, 1975.7135215393687, 1984.4939540417245, 2013.6073465674199, 73521.6323918377, 74847.62576187139, 75396.0, 77195.61402193009, 77354.0, 10930.781384372269, 11103.38931358783, 11161.441927903572, 11196.849449253272, 11373.782112487985, 15550.300236489385, 15695.0, 15707.214639267992, 15714.68570628581, 15775.68448631044, 7922.405819563441, 8180.263776260165, 8212.958935205286, 8325.084240733515, 8440.0, 7695.422843286776, 7775.805604859811, 7998.48009879356, 8030.156833532512, 8074.394420418492, 4741.407324084489, 4801.135795556834, 4852.447216890561, 4874.268859671007, 4878.268259761065, 2010.9698354524694, 2023.736914201174, 2042.3260324093014, 2049.1496029148034, 2054.613400390148, 964.8456247000446, 992.118775623932, 1008.445355054717, 1015.1878497202209, 1057.2968975631272, 17456.389026384015, 17853.28586856537, 18539.165737541844, 18878.716819247722, 19006.61986760257, 1002.8946960569181, 1003.1322905686528, 1003.5333569890037, 1016.9847452288221, 1021.5300961557766, 9783.608655653694, 10451.111655509214, 10679.519421626046, 10695.465226738632, 11001.56510123325, 424312.0, 434270.0, 445444.0, 451583.0, 453860.0, 69272.6536367315, 83807.5809620948, 85033.0, 85592.0, 86806.0, 1037.1184493180888, 1068.871735391758, 1076.359566058194, 1080.2330345454816, 1084.3060441317405, 17103.657926841643, 17256.22346994363, 17261.79167458316, 17584.296628134733, 17761.55596110056, 39835.402468962406, 40257.396139058525, 40659.390109148975, 40943.38584921288, 42225.577744223396, 55370.44629553814, 55720.72139639276, 55907.44092559185, 56096.71951640379, 57782.71108644598, 6024.457798798129, 7539.773806785805, 7878.133405325295, 8566.400351975302, 8616.267617252604, 13039.934800325938, 13420.0, 13450.798238026633, 13839.100458470168, 14264.144151350953, 11532.36571988515, 11719.531218751154, 11818.822717659414, 11901.285922844658, 12106.818397723864, 11389.943050284695, 11575.652730418102, 11580.073594112619, 11680.357580333164, 11833.881661183623, 11493.195476316578, 11973.640790776291, 12022.819657705317, 12088.516459341528, 12314.938425307817, 7670.8082297943, 7729.690812367442, 7890.092639346319, 8112.716054938285, 8182.345412367115, 11300.717482063013, 11671.0, 11676.824847627462, 11685.707857303296, 11851.644450666494], "value": 9068.982312772989, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.7797174480338, 1319.9670008249786, 1323.629383772544, 1324.4371142264536, 1326.7081242126733, 8181.468204566699, 8316.1268066853, 8591.828163436727, 8665.956670216648, 8667.21995020448, 8320.916790832105, 8853.778655533615, 8854.645814167425, 8859.114088591154, 8893.599788009538, 2364.9645255321143, 2384.558856611524, 2391.964120538193, 2401.7598240176017, 2418.262429958862, 2076.294060019593, 2154.9030293636824, 2355.3522781235124, 2371.67982322386, 2398.1126983016306, 2339.9883000584973, 2351.2946116165167, 2352.5765362234793, 2361.645753137026, 2368.27767530903, 2238.876861772602, 2260.42359198405, 2271.829612779048, 2283.292179424384, 2286.2912497125944, 2352.270796053229, 2352.388379021467, 2357.092519380034, 2366.6331718583647, 2375.857448553092, 8425.494470331738, 8523.957380213122, 8526.190011948855, 8532.14678532148, 8553.529555874424, 5139.15203991341, 5229.816956406546, 5280.128778751501, 5280.788768449257, 5301.54936830366, 3349.4138525757894, 3545.468179773029, 3557.5375201223933, 3566.197605538733, 3587.892363229107, 1424.9073810202408, 1483.0879009409243, 1511.12354834197, 1554.6424322405796, 1563.9218039098, 11818.881811181864, 11982.580609678707, 12025.699357516045, 12067.818982715266, 12089.879101208964, 4406.9779651101535, 4723.126221649006, 4736.834210802605, 4815.831445899376, 4831.685940413862, 10023.849642255373, 10118.190544756402, 10143.23925705575, 10166.949165254275, 10176.338537995007, 5123.590112790967, 5161.509656582619, 5167.405748338914, 5368.194770784414, 5449.373322068013, 4755.809767609257, 4892.828750993698, 4935.235038568956, 4951.133551628451, 4982.875428114254, 3886.2810380079777, 3899.239648268617, 3980.3233450313514, 3995.5205375355144, 4018.0, 1225.2342286071205, 1234.3643023842728, 1241.1622155045309, 1265.8607553169145, 1312.3831799054428, 934.2759361494896, 936.6768464879606, 952.0, 961.1493827962304, 977.5258999385293, 5541.6120871539415, 5623.325200975827, 5703.572232082611, 5887.676177810176, 6190.102435146879, 924.4591913730543, 932.2961164320894, 932.9953350233341, 938.7559234599054, 954.441651633802, 4129.793510324532, 4237.258479766028, 4246.749222911862, 4259.105587826529, 4271.273883439822, 10262.846057309147, 10578.788424231472, 10637.521311540999, 10659.093977011886, 10663.466826658636, 9784.510774461249, 10336.379817210991, 10347.844782328271, 10389.37663740178, 10614.416207108528, 8070.435069545193, 8102.878456823152, 8239.629216685264, 8264.669413223524, 8268.131846156188, 5805.187273781758, 5920.141579471038, 5962.522998160223, 6044.153818465506, 6147.477464415575, 9413.905860941302, 9540.618375264912, 9599.664011759554, 9606.711798646053, 9640.276979226726, 9080.59137338808, 9558.0, 9559.61761529531, 9649.179819715402, 9680.419174849532, 7674.462787605037, 7789.182135875878, 7802.648880800264, 7834.764957051298, 7840.960795195988, 7974.441789074709, 8090.271875530995, 8094.190580941859, 8114.675412983414, 8124.22819832115, 7478.364339031244, 7597.392208623407, 7730.45886787942, 7731.265529774662, 7818.179091195342, 7247.565146091251, 7291.760400731994, 7356.190819010012, 7364.742234021784, 7385.778426647209, 6452.903206451813, 6550.934490655032, 6556.213254409501, 6565.474762019123, 6572.572782769296, 4856.125897338513, 4874.90250194987, 4898.9020219594695, 4986.376702912136, 5128.79484820603, 5049.64652474338, 5102.770375333044, 5247.08176069194, 5248.0, 5262.26328314044], "value": 4601.272617571902, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.14910972196594, 400.9719319647625, 405.9939100913486, 406.9267531844267, 412.2929176462366, 5210.55710264627, 5344.579469139754, 5405.0, 5437.157240627699, 5489.176623506471, 5157.5616072633875, 5281.815136470224, 5335.973320133404, 5351.7056561889085, 5357.383900851403, 4341.761203133827, 4346.348047792832, 4367.694261401703, 4379.737215767064, 4387.692861499696, 4008.5590585035625, 4180.602842729936, 4376.606105450509, 4378.912421751563, 4390.341448782692, 4165.312723400635, 4167.93717602011, 4172.395002724603, 4174.77038762868, 4179.770112643803, 4157.3140431828715, 4187.267228235077, 4205.495340559137, 4216.3464662976985, 4239.236937351276, 3746.9063273418383, 3748.906277343061, 3750.774953502799, 3754.812259387047, 3766.4538641897047, 5096.23556466533, 5155.871103222412, 5180.0, 5184.170532714747, 5228.895422091575, 4728.172569800271, 4732.455767586737, 4756.167670657655, 4783.449903261135, 4787.234042553209, 5400.29796126505, 5505.752241149158, 5534.782347883459, 5557.360903496069, 5566.276384070085, 4017.196560687874, 4029.5164580250266, 4042.191561687674, 4042.312806822847, 4044.672200745204, 5781.277340332458, 5813.854653633651, 5840.131158029432, 5907.232059832238, 5913.645181289094, 4194.6853985950565, 4207.431996680409, 4213.620774130343, 4219.599138081878, 4220.282551966112, 4076.510818701775, 4132.5329508024815, 4199.706020578591, 4207.495100587949, 4213.810378532973, 4732.550407711262, 4733.266343716729, 4740.842916472997, 4750.097481478508, 4755.38180036593, 5558.888822223533, 5572.944270557324, 5600.943990560124, 5629.802956896489, 5644.9435505644415, 1336.712606789545, 1399.8110255115632, 1406.971860562783, 1415.8654927781845, 1425.5865798918405, 972.7859870828406, 979.8334283171736, 996.2528103922059, 1001.2290536287019, 1012.1851909213154, 5194.143221228309, 5215.843524694265, 5227.372715274191, 5228.895422091613, 5238.869028274247, 5576.1356989666665, 5587.217789509472, 5595.552355811526, 5598.272224610856, 5647.079992802384, 5080.13637681595, 5158.587313015025, 5229.738513074331, 5259.579233661298, 5463.6614029562215, 2974.940501189964, 2979.2998645318335, 3006.864691088906, 3010.2775333919703, 3015.1406849048353, 5809.390014048548, 5828.601135727395, 5834.499300419714, 5905.4685078343155, 5918.911216331759, 5465.535429488538, 5782.768689252467, 5807.88384232313, 5827.3007239131575, 5829.387914268941, 5935.910961335583, 5938.524918006549, 5953.91069133972, 5962.22491076166, 5998.340182579913, 5496.587755918242, 5728.198052272768, 5729.770809167587, 5769.30768307789, 5819.301683797971, 5743.540516758733, 5783.739731712168, 5792.4497172768515, 5800.187973683772, 5811.389804070512, 6045.304789949037, 6055.303640081447, 6092.0, 6107.358727333566, 6131.417515336036, 3944.56609772919, 4128.298189307885, 4168.979155104205, 4175.306927032108, 4176.686748493815, 5582.441755824385, 5742.19609254713, 5754.712264386848, 5769.567107570989, 5786.681732504752, 5586.581006424453, 5630.521405680399, 5658.405867383865, 5660.320761508646, 5694.515966142924, 5561.860953476195, 5635.492805647511, 5661.377248502579, 5663.490285874291, 5669.773209071591, 5430.185472179047, 5631.0, 5634.183043458757, 5657.4059723728415, 5671.206031155724, 5719.456651618256, 5724.942750572441, 5729.742161602821, 5758.424157584208, 5793.333766616893, 5453.563714902878, 5539.584531160099, 5569.0, 5592.210492642315, 5636.633618814764], "value": 4315.048824013084, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.8084557592242, 725.300085417572, 766.3868904876098, 805.0942689474341, 843.3716880923711, 14557.927210363947, 14876.925615371934, 14988.325525351358, 15012.699746005073, 15159.924200378997, 14203.431862725478, 14234.217118058503, 14331.355089020994, 14435.783463248034, 14964.102153870776, 792.2750683124948, 818.643889907889, 819.9344052475817, 824.7031068815222, 827.9172082791733, 818.1940788323496, 819.0867183090841, 819.2954059508847, 819.81554150316, 821.1419067074892, 862.6764963138822, 863.1541089732067, 865.1651156633847, 865.904750477447, 867.5965675960678, 851.476342049635, 858.7380848841101, 859.3468963587687, 859.5401460218784, 860.7805009722512, 627.438442593876, 630.6531407725778, 631.5989346764792, 633.6293268437969, 633.9936600633981, 15691.372345106181, 15939.203039847962, 16135.515934521984, 16234.837651623451, 16287.104209268486, 13637.931810340884, 14070.15579065249, 14147.0, 14210.715785684331, 14272.714545709028, 11646.475908584134, 11705.12211584126, 11894.107941904393, 11977.341246231454, 12033.81949270753, 3734.906627334311, 3748.4377343398437, 3801.4107813288983, 3805.3530899746834, 3857.324968130566, 82073.0, 83180.58409707913, 85218.14781852164, 85745.14254857496, 85986.14013859906, 11223.887761122447, 11300.49147788335, 11305.095592352593, 11444.084473242121, 11545.769084618261, 21715.0, 21755.891220544112, 21871.45321366947, 22028.449288767588, 22130.22544210977, 8235.752927412188, 8297.58512074394, 8377.95811020941, 8386.79033024167, 8446.746597602081, 4546.431696037996, 4644.86065418038, 4659.138059459011, 4731.313959475857, 4812.109759694397, 3678.33789917812, 3697.6302369762807, 3731.4402839573736, 3759.6240375962734, 3788.3559794834946, 565.7058329668549, 576.8586696259359, 578.3551340255668, 579.39163877928, 587.9147523609053, 719.2807192807193, 725.7399067473857, 727.2182403915812, 739.4454159380465, 740.76665850257, 9183.90816091844, 9896.752581185528, 9944.950275248577, 10001.449920254456, 10153.593856245816, 714.7962830593256, 740.7999041552719, 743.4352280813405, 761.3984951887946, 766.180187199691, 4452.821887124479, 4768.7615619218905, 4781.2350023996, 4813.711177329372, 4832.9609134036355, 81385.59307203426, 82102.58948705219, 82976.30890903054, 85655.0, 86413.56793215993, 56511.71744141253, 57234.141487877714, 57306.713466432404, 58867.41132588705, 65085.349146508874, 56956.71521642448, 56970.43029569734, 57272.42727572754, 58132.41867581355, 58302.0, 9991.150752186146, 10574.524146413276, 10623.256372054191, 10655.467226638792, 10788.460576971276, 38690.41964370593, 39363.409548857366, 39414.408783868836, 40433.1913361737, 40877.1824563513, 48177.27734083922, 49277.0, 49377.50622493729, 50129.0, 50200.24699629436, 12525.436355363849, 12578.748425031632, 13192.142510736772, 13479.730405392034, 14246.501372451914, 14558.222930570859, 14755.188464634548, 14785.556433307018, 15076.547703568911, 15132.394704211709, 12428.0, 12489.875101248872, 12852.485900564247, 12881.935590321988, 13392.0, 12595.811062833882, 12841.93579032099, 13043.152195107288, 13125.474981000652, 13480.595582132551, 13486.86513134856, 13646.385912634154, 13717.17696938187, 14369.209693466959, 14862.0, 11072.224944253825, 11119.221654484109, 11477.942610286895, 11547.0, 11805.350705710925, 10120.94939525327, 12223.97121655034, 12232.510699571918, 12484.0, 12698.936505317415], "value": 7237.150974520068, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 113.0, 113.0, 114.0, 115.0, 113.0, 115.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 123.0, 126.0, 171.0, 124.0, 128.0, 123.0, 122.0, 142.0, 126.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 161.0, 163.0, 166.0, 173.0, 164.0, 161.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 106.0, 78.0, 77.0, 76.0, 75.0, 101.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 112.0, 84.0, 84.0, 85.0, 93.0, 83.0, 84.0, 110.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 121.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 147.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 57.0, 57.0, 58.0, 59.0, 59.0, 60.0, 57.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 71.0, 66.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 82.0, 83.0, 83.0, 93.0, 82.0, 80.0, 90.0, 84.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 126.0, 127.0, 128.0, 127.0, 127.0, 138.0, 138.0, 175.0, 130.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 169.0, 173.0, 166.0, 165.0, 163.0, 171.0, 173.0, 164.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 63.0, 63.0, 62.0, 66.0, 74.0, 61.0], "value": 64.4, "unit": "score"}]}]} 15:28:26 INFO - Return code: 0 15:28:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:28:26 ERROR - # TBPL SUCCESS # 15:28:26 INFO - Running post-action listener: _resource_record_post_action 15:28:26 INFO - [mozharness: 2016-12-30 23:28:26.572931Z] Finished run-tests step (success) 15:28:26 INFO - Running post-run listener: _resource_record_post_run 15:28:26 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 40960; Write bytes: 402812928; Read time: 52; Write time: 277068 15:28:26 INFO - TinderboxPrint: CPU usage
13.4% 15:28:26 INFO - TinderboxPrint: I/O read bytes / time
40,960 / 52 15:28:26 INFO - TinderboxPrint: I/O write bytes / time
402,812,928 / 277,068 15:28:26 INFO - TinderboxPrint: CPU idle
8,242.0 (86.6%) 15:28:26 INFO - TinderboxPrint: CPU user
1,217.8 (12.8%) 15:28:26 INFO - TinderboxPrint: Swap in / out
0 / 0 15:28:26 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105824256; Read time: 0; Write time: 92020 15:28:26 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 36864; Write bytes: 296988672; Read time: 36; Write time: 185048 15:28:27 INFO - Running post-run listener: _upload_blobber_files 15:28:27 INFO - Blob upload gear active. 15:28:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:28:27 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 15:28:27 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:28:27 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:28:27 INFO - (blobuploader) - INFO - Open directory for files ... 15:28:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:28:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:28:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:28:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:28:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:28:28 INFO - (blobuploader) - INFO - Done attempting. 15:28:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:28:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:28:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:28:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:28:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:28:29 INFO - (blobuploader) - INFO - Done attempting. 15:28:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:28:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:28:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:28:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:28:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:28:30 INFO - (blobuploader) - INFO - Done attempting. 15:28:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:28:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:28:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:28:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:28:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:28:33 INFO - (blobuploader) - INFO - Done attempting. 15:28:33 INFO - (blobuploader) - INFO - Iteration through files over. 15:28:33 INFO - Return code: 0 15:28:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:28:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:28:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dec0d9c0e61e14a5099bc13a24a57bb67b9c0683c5eb18b5c6e59be0449577d8ec3e07ff5352d6d2a443cb0bbba20cb425ac668920413292a32a1d9e045880a2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bded84534a01c1824b9efb20671abac8ef8d00ea83b68e011039f708541fe4fcab163069121f2c71524f1a97d74640f558c4b8e2216cac6d0b1774d08646779", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34c6e5e1e96cd372f0cf8578b082c2ddb78e818c1ec94a7a08345b2bce527675a8396d70d87e3b1b36d597a4d9a8eacc9ad268153d052e28ea1d0cffe8370760", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ed054cb1eb871bd8cf05dd4c0fe3ec5747bc03ea700b26337925413b1215697bce17ed385a695c79468232e5d9425d9e2b85523f4696b3b406aa981f3747015"} 15:28:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:28:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:28:33 INFO - Contents: 15:28:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dec0d9c0e61e14a5099bc13a24a57bb67b9c0683c5eb18b5c6e59be0449577d8ec3e07ff5352d6d2a443cb0bbba20cb425ac668920413292a32a1d9e045880a2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bded84534a01c1824b9efb20671abac8ef8d00ea83b68e011039f708541fe4fcab163069121f2c71524f1a97d74640f558c4b8e2216cac6d0b1774d08646779", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34c6e5e1e96cd372f0cf8578b082c2ddb78e818c1ec94a7a08345b2bce527675a8396d70d87e3b1b36d597a4d9a8eacc9ad268153d052e28ea1d0cffe8370760", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ed054cb1eb871bd8cf05dd4c0fe3ec5747bc03ea700b26337925413b1215697bce17ed385a695c79468232e5d9425d9e2b85523f4696b3b406aa981f3747015"} 15:28:33 INFO - Running post-run listener: copy_logs_to_upload_dir 15:28:33 INFO - Copying logs to upload dir... 15:28:33 INFO - mkdir: /builds/slave/test/build/upload/logs 15:28:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.178437 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-30 15:28:33.224234) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 15:28:33.227610) ========= 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=0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dec0d9c0e61e14a5099bc13a24a57bb67b9c0683c5eb18b5c6e59be0449577d8ec3e07ff5352d6d2a443cb0bbba20cb425ac668920413292a32a1d9e045880a2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bded84534a01c1824b9efb20671abac8ef8d00ea83b68e011039f708541fe4fcab163069121f2c71524f1a97d74640f558c4b8e2216cac6d0b1774d08646779", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34c6e5e1e96cd372f0cf8578b082c2ddb78e818c1ec94a7a08345b2bce527675a8396d70d87e3b1b36d597a4d9a8eacc9ad268153d052e28ea1d0cffe8370760", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ed054cb1eb871bd8cf05dd4c0fe3ec5747bc03ea700b26337925413b1215697bce17ed385a695c79468232e5d9425d9e2b85523f4696b3b406aa981f3747015"} build_url:https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011462 build_url: 'https://queue.taskcluster.net/v1/task/X1lCCT1xTAiOGrnsiQrP7w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dec0d9c0e61e14a5099bc13a24a57bb67b9c0683c5eb18b5c6e59be0449577d8ec3e07ff5352d6d2a443cb0bbba20cb425ac668920413292a32a1d9e045880a2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bded84534a01c1824b9efb20671abac8ef8d00ea83b68e011039f708541fe4fcab163069121f2c71524f1a97d74640f558c4b8e2216cac6d0b1774d08646779", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34c6e5e1e96cd372f0cf8578b082c2ddb78e818c1ec94a7a08345b2bce527675a8396d70d87e3b1b36d597a4d9a8eacc9ad268153d052e28ea1d0cffe8370760", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ed054cb1eb871bd8cf05dd4c0fe3ec5747bc03ea700b26337925413b1215697bce17ed385a695c79468232e5d9425d9e2b85523f4696b3b406aa981f3747015"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 15:28:33.254455) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 15:28:33.254834) ========= 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=0333a256a5e4f052382dd180000001b1-1483139274.345960-1148900123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 15:28:33.339387) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 15:28:33.339743) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 15:28:33.340097) ========= ========= Total master_lag: 0.18 =========