builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1483118041.21 results: success (0) buildid: 20161230073208 builduid: 60b8413d39e94d92b0c04d4ebc136282 revision: 9104708cc3ac0ccfe4cf5d518e13736773c565d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 09:14:01.207076) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-30 09:14:01.207540) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 09:14:01.207824) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-30 09:14:01.222122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 09:14:01.222409) ========= 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=920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-30 09:14:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.4M=0s 2016-12-30 09:14:02 (69.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128285 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 09:14:01.365784) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 09:14:01.366333) ========= 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=920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016839 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 09:14:01.416363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 09:14:01.416722) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9104708cc3ac0ccfe4cf5d518e13736773c565d7 --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 9104708cc3ac0ccfe4cf5d518e13736773c565d7 --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=920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-30 09:14:02,143 truncating revision to first 12 chars 2016-12-30 09:14:02,143 Setting DEBUG logging. 2016-12-30 09:14:02,143 attempt 1/10 2016-12-30 09:14:02,143 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9104708cc3ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-30 09:14:02,441 unpacking tar archive at: mozilla-central-9104708cc3ac/testing/mozharness/ program finished with exit code 0 elapsedTime=0.616269 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 09:14:02.046403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 09:14:02.046737) ========= script_repo_revision: 9104708cc3ac0ccfe4cf5d518e13736773c565d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-30 09:14:02.047152) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 09:14:02.047448) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-30 09:14:02.056088) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-30 09:14:02.056421) ========= /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=920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:14:02 INFO - MultiFileLogger online at 20161230 09:14:02 in /builds/slave/test 09:14:02 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 09:14:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:14:02 INFO - {'append_to_log': False, 09:14:02 INFO - 'base_work_dir': '/builds/slave/test', 09:14:02 INFO - 'blob_upload_branch': 'Firefox', 09:14:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:14:02 INFO - 'branch': 'Firefox', 09:14:02 INFO - 'buildbot_json_path': 'buildprops.json', 09:14:02 INFO - 'config_files': ('talos/linux_config.py',), 09:14:02 INFO - 'default_actions': ('clobber', 09:14:02 INFO - 'read-buildbot-config', 09:14:02 INFO - 'download-and-extract', 09:14:02 INFO - 'populate-webroot', 09:14:02 INFO - 'create-virtualenv', 09:14:02 INFO - 'install', 09:14:02 INFO - 'run-tests'), 09:14:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:14:02 INFO - 'download_minidump_stackwalk': True, 09:14:02 INFO - 'download_symbols': 'ondemand', 09:14:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:14:02 INFO - 'tooltool.py': '/tools/tooltool.py', 09:14:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:14:02 INFO - '/tools/misc-python/virtualenv.py')}, 09:14:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:14:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:14:02 INFO - 'installer_path': 'installer.exe', 09:14:02 INFO - 'log_level': 'info', 09:14:02 INFO - 'log_name': 'talos', 09:14:02 INFO - 'log_to_console': True, 09:14:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:14:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:14:02 INFO - 'opt_config_files': (), 09:14:02 INFO - 'pip_index': False, 09:14:02 INFO - 'sps_profile': False, 09:14:02 INFO - 'sps_profile_interval': 0, 09:14:02 INFO - 'suite': 'dromaeojs-e10s', 09:14:02 INFO - 'system_bits': '32', 09:14:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:14:02 INFO - 'title': 'talos-linux64-ix-053', 09:14:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:14:02 INFO - 'use_talos_json': True, 09:14:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:14:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:14:02 INFO - 'work_dir': 'build'} 09:14:02 INFO - [mozharness: 2016-12-30 17:14:02.886674Z] Running clobber step. 09:14:02 INFO - Running pre-action listener: _resource_record_pre_action 09:14:02 INFO - Running main action method: clobber 09:14:02 INFO - rmtree: /builds/slave/test/build 09:14:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:14:03 INFO - Running post-action listener: _resource_record_post_action 09:14:03 INFO - [mozharness: 2016-12-30 17:14:03.347081Z] Finished clobber step (success) 09:14:03 INFO - [mozharness: 2016-12-30 17:14:03.347183Z] Running read-buildbot-config step. 09:14:03 INFO - Running pre-action listener: _resource_record_pre_action 09:14:03 INFO - Running main action method: read_buildbot_config 09:14:03 INFO - Using buildbot properties: 09:14:03 INFO - { 09:14:03 INFO - "project": "", 09:14:03 INFO - "product": "firefox", 09:14:03 INFO - "script_repo_revision": "production", 09:14:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:14:03 INFO - "repository": "", 09:14:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 09:14:03 INFO - "buildid": "20161230073208", 09:14:03 INFO - "pgo_build": "True", 09:14:03 INFO - "basedir": "/builds/slave/test", 09:14:03 INFO - "buildnumber": 230, 09:14:03 INFO - "slavename": "talos-linux64-ix-053", 09:14:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:14:03 INFO - "platform": "ubuntu64_hw", 09:14:03 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:14:03 INFO - "branch": "mozilla-central", 09:14:03 INFO - "repo_path": "mozilla-central", 09:14:03 INFO - "revision": "9104708cc3ac0ccfe4cf5d518e13736773c565d7", 09:14:03 INFO - "stage_platform": "linux64-pgo", 09:14:03 INFO - "builduid": "60b8413d39e94d92b0c04d4ebc136282", 09:14:03 INFO - "slavebuilddir": "test" 09:14:03 INFO - } 09:14:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 09:14:03 INFO - Running post-action listener: _resource_record_post_action 09:14:03 INFO - [mozharness: 2016-12-30 17:14:03.349635Z] Finished read-buildbot-config step (success) 09:14:03 INFO - [mozharness: 2016-12-30 17:14:03.349725Z] Running download-and-extract step. 09:14:03 INFO - Running pre-action listener: _resource_record_pre_action 09:14:03 INFO - Running main action method: download_and_extract 09:14:03 INFO - mkdir: /builds/slave/test/build/tests 09:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:03 INFO - trying https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:14:03 INFO - Downloading https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/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 09:14:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/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 09:14:03 INFO - Downloaded 1361 bytes. 09:14:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:14:03 INFO - Using the following test package requirements: 09:14:03 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:14:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:14:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:14:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:03 INFO - u'jsshell-linux-x86_64.zip'], 09:14:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:14:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:14:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:14:03 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:14:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:14:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:14:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:14:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:14:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:14:03 INFO - Fetch https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:14:04 INFO - Expected file size: 21834924 09:14:04 INFO - Obtained file size: 21834924 09:14:08 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:14:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:14:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:14:08 INFO - Fetch https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:14:09 INFO - Expected file size: 21834924 09:14:09 INFO - Obtained file size: 21834924 09:14:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 09:14:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:14:13 INFO - Fetch https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:14:14 INFO - Expected file size: 14409776 09:14:14 INFO - Obtained file size: 14409776 09:14:15 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')]} 09:14:15 INFO - trying https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:14:15 INFO - Downloading https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/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 09:14:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/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 09:14:16 INFO - Downloaded 61360321 bytes. 09:14:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:14:16 INFO - mkdir: /builds/slave/test/properties 09:14:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:14:16 INFO - Writing to file /builds/slave/test/properties/build_url 09:14:16 INFO - Contents: 09:14:16 INFO - build_url:https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:14:16 INFO - Running post-action listener: _resource_record_post_action 09:14:16 INFO - Running post-action listener: set_extra_try_arguments 09:14:16 INFO - [mozharness: 2016-12-30 17:14:16.736017Z] Finished download-and-extract step (success) 09:14:16 INFO - [mozharness: 2016-12-30 17:14:16.736244Z] Running populate-webroot step. 09:14:16 INFO - Running pre-action listener: _resource_record_pre_action 09:14:16 INFO - Running main action method: populate_webroot 09:14:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:14:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:14:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:14:16 INFO - '--tppagecycles', 09:14:16 INFO - '7'], 09:14:16 INFO - 'tests': ['tsvgm']}}, 09:14:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:14:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:14:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:14:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:14:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:14:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:14:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:14:16 INFO - 'talos_options': ['--disable-e10s'], 09:14:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:14:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:14:16 INFO - 'talos_options': ['--disable-e10s'], 09:14:16 INFO - 'tests': ['damp', 'tps']}, 09:14:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:14:16 INFO - 'tests': ['damp', 'tps']}, 09:14:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:14:16 INFO - 'tests': ['dromaeo_dom']}, 09:14:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:14:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:14:16 INFO - 'tests': ['basic_compositor_video']}, 09:14:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:14:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:14:16 INFO - 'tests': ['a11yr', 09:14:16 INFO - 'ts_paint', 09:14:16 INFO - 'tpaint', 09:14:16 INFO - 'sessionrestore', 09:14:16 INFO - 'sessionrestore_no_auto_restore', 09:14:16 INFO - 'tabpaint']}, 09:14:16 INFO - 'other-e10s': {'tests': ['a11yr', 09:14:16 INFO - 'ts_paint', 09:14:16 INFO - 'tpaint', 09:14:16 INFO - 'sessionrestore', 09:14:16 INFO - 'sessionrestore_no_auto_restore', 09:14:16 INFO - 'tabpaint']}, 09:14:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:14:16 INFO - 'ts_paint', 09:14:16 INFO - 'tpaint', 09:14:16 INFO - 'sessionrestore', 09:14:16 INFO - 'sessionrestore_no_auto_restore', 09:14:16 INFO - 'tabpaint']}, 09:14:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:14:16 INFO - 'ts_paint', 09:14:16 INFO - 'tpaint', 09:14:16 INFO - 'sessionrestore', 09:14:16 INFO - 'sessionrestore_no_auto_restore', 09:14:16 INFO - 'tabpaint']}, 09:14:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:14:16 INFO - 'tests': ['a11yr', 09:14:16 INFO - 'ts_paint', 09:14:16 INFO - 'tpaint', 09:14:16 INFO - 'sessionrestore', 09:14:16 INFO - 'sessionrestore_no_auto_restore', 09:14:16 INFO - 'tabpaint']}, 09:14:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:14:16 INFO - 'tests': ['a11yr', 09:14:16 INFO - 'ts_paint', 09:14:16 INFO - 'tpaint', 09:14:16 INFO - 'sessionrestore', 09:14:16 INFO - 'sessionrestore_no_auto_restore', 09:14:16 INFO - 'tabpaint']}, 09:14:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:14:16 INFO - 'tests': ['tsvgx', 09:14:16 INFO - 'tsvgr_opacity', 09:14:16 INFO - 'tart', 09:14:16 INFO - 'tscrollx', 09:14:16 INFO - 'cart', 09:14:16 INFO - 'tsvg_static']}, 09:14:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:14:16 INFO - 'tsvgr_opacity', 09:14:16 INFO - 'tart', 09:14:16 INFO - 'tscrollx', 09:14:16 INFO - 'cart', 09:14:16 INFO - 'tsvg_static']}, 09:14:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:14:16 INFO - 'talos_options': ['--disable-e10s'], 09:14:16 INFO - 'tests': ['tp5o']}, 09:14:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:14:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:14:16 INFO - 'talos_options': ['--disable-e10s', 09:14:16 INFO - '--xperf_path', 09:14:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:16 INFO - 'tests': ['tp5n']}, 09:14:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:14:16 INFO - 'talos_options': ['--xperf_path', 09:14:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:16 INFO - 'tests': ['tp5n']}}, 09:14:16 INFO - 'talos.zip': {'path': '', 09:14:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:14:16 INFO - Running post-action listener: _resource_record_post_action 09:14:16 INFO - [mozharness: 2016-12-30 17:14:16.762846Z] Finished populate-webroot step (success) 09:14:16 INFO - [mozharness: 2016-12-30 17:14:16.762935Z] Running create-virtualenv step. 09:14:16 INFO - Running pre-action listener: _resource_record_pre_action 09:14:16 INFO - Running main action method: create_virtualenv 09:14:16 INFO - Creating virtualenv /builds/slave/test/build/venv 09:14:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:14:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:14:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:14:16 INFO - Using real prefix '/usr' 09:14:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:14:17 INFO - Installing distribute.............................................................................................................................................................................................done. 09:14:19 INFO - Installing pip.................done. 09:14:19 INFO - Return code: 0 09:14:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:14:19 INFO - Reading from file tmpfile_stdout 09:14:19 INFO - Output received: 09:14:19 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:14:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf713f0>, '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 0xf71cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf721a0>, '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': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', '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 09:14:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:14:19 INFO - Using env: {'DISPLAY': ':0', 09:14:19 INFO - 'HOME': '/home/cltbld', 09:14:19 INFO - 'LANG': 'en_US.UTF-8', 09:14:19 INFO - 'LANGUAGE': 'en_US:en', 09:14:19 INFO - 'LOGNAME': 'cltbld', 09:14:19 INFO - 'MAIL': '/var/mail/cltbld', 09:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:19 INFO - 'MOZ_NO_REMOTE': '1', 09:14:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:19 INFO - 'NO_EM_RESTART': '1', 09:14:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:19 INFO - 'PWD': '/builds/slave/test', 09:14:19 INFO - 'SHELL': '/bin/bash', 09:14:19 INFO - 'SHLVL': '1', 09:14:19 INFO - 'TERM': 'linux', 09:14:19 INFO - 'TMOUT': '86400', 09:14:19 INFO - 'USER': 'cltbld', 09:14:19 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', 09:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:19 INFO - '_': '/tools/buildbot/bin/python'} 09:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:14:19 INFO - Cleaning up... 09:14:19 INFO - Return code: 0 09:14:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf713f0>, '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 0xf71cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf721a0>, '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': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', '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 09:14:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:14:19 INFO - Using env: {'DISPLAY': ':0', 09:14:19 INFO - 'HOME': '/home/cltbld', 09:14:19 INFO - 'LANG': 'en_US.UTF-8', 09:14:19 INFO - 'LANGUAGE': 'en_US:en', 09:14:19 INFO - 'LOGNAME': 'cltbld', 09:14:19 INFO - 'MAIL': '/var/mail/cltbld', 09:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:19 INFO - 'MOZ_NO_REMOTE': '1', 09:14:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:19 INFO - 'NO_EM_RESTART': '1', 09:14:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:19 INFO - 'PWD': '/builds/slave/test', 09:14:19 INFO - 'SHELL': '/bin/bash', 09:14:19 INFO - 'SHLVL': '1', 09:14:19 INFO - 'TERM': 'linux', 09:14:19 INFO - 'TMOUT': '86400', 09:14:19 INFO - 'USER': 'cltbld', 09:14:19 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', 09:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:19 INFO - '_': '/tools/buildbot/bin/python'} 09:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:19 INFO - Downloading/unpacking psutil>=3.1.1 09:14: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 09:14: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 09:14: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 09:14: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 09:14: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 09:14: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 09:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:14:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:22 INFO - Installing collected packages: psutil 09:14:22 INFO - Running setup.py install for psutil 09:14:22 INFO - building 'psutil._psutil_linux' extension 09:14:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:14:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:14:22 INFO - building 'psutil._psutil_posix' extension 09:14:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:14:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:14:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:22 INFO - Successfully installed psutil 09:14:22 INFO - Cleaning up... 09:14:22 INFO - Return code: 0 09:14:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf713f0>, '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 0xf71cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf721a0>, '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': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', '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 09:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:14:22 INFO - Using env: {'DISPLAY': ':0', 09:14:22 INFO - 'HOME': '/home/cltbld', 09:14:22 INFO - 'LANG': 'en_US.UTF-8', 09:14:22 INFO - 'LANGUAGE': 'en_US:en', 09:14:22 INFO - 'LOGNAME': 'cltbld', 09:14:22 INFO - 'MAIL': '/var/mail/cltbld', 09:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:22 INFO - 'MOZ_NO_REMOTE': '1', 09:14:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:22 INFO - 'NO_EM_RESTART': '1', 09:14:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:22 INFO - 'PWD': '/builds/slave/test', 09:14:22 INFO - 'SHELL': '/bin/bash', 09:14:22 INFO - 'SHLVL': '1', 09:14:22 INFO - 'TERM': 'linux', 09:14:22 INFO - 'TMOUT': '86400', 09:14:22 INFO - 'USER': 'cltbld', 09:14:22 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', 09:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:22 INFO - '_': '/tools/buildbot/bin/python'} 09:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:14:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:14:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:14:24 INFO - Installing collected packages: mozsystemmonitor 09:14:24 INFO - Running setup.py install for mozsystemmonitor 09:14:25 INFO - Successfully installed mozsystemmonitor 09:14:25 INFO - Cleaning up... 09:14:25 INFO - Return code: 0 09:14:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:14: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')]} 09:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14: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')]} 09:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf713f0>, '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 0xf71cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf721a0>, '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': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', '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 09:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:14:25 INFO - Using env: {'DISPLAY': ':0', 09:14:25 INFO - 'HOME': '/home/cltbld', 09:14:25 INFO - 'LANG': 'en_US.UTF-8', 09:14:25 INFO - 'LANGUAGE': 'en_US:en', 09:14:25 INFO - 'LOGNAME': 'cltbld', 09:14:25 INFO - 'MAIL': '/var/mail/cltbld', 09:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:25 INFO - 'MOZ_NO_REMOTE': '1', 09:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:25 INFO - 'NO_EM_RESTART': '1', 09:14:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:25 INFO - 'PWD': '/builds/slave/test', 09:14:25 INFO - 'SHELL': '/bin/bash', 09:14:25 INFO - 'SHLVL': '1', 09:14:25 INFO - 'TERM': 'linux', 09:14:25 INFO - 'TMOUT': '86400', 09:14:25 INFO - 'USER': 'cltbld', 09:14:25 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', 09:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:25 INFO - '_': '/tools/buildbot/bin/python'} 09:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:25 INFO - Downloading/unpacking jsonschema==2.5.1 09:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:14:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:27 INFO - Downloading functools32-3.2.3-2.tar.gz 09:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:14:27 INFO - warning: no files found matching '*.txt' 09:14:27 INFO - no previously-included directories found matching 'build' 09:14:27 INFO - no previously-included directories found matching 'dist' 09:14:27 INFO - no previously-included directories found matching '.git*' 09:14:27 INFO - Installing collected packages: jsonschema, functools32 09:14:27 INFO - Running setup.py install for functools32 09:14:27 INFO - warning: no files found matching '*.txt' 09:14:27 INFO - no previously-included directories found matching 'build' 09:14:27 INFO - no previously-included directories found matching 'dist' 09:14:27 INFO - no previously-included directories found matching '.git*' 09:14:27 INFO - Successfully installed jsonschema functools32 09:14:27 INFO - Cleaning up... 09:14:27 INFO - Return code: 0 09:14:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf713f0>, '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 0xf71cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf721a0>, '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': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', '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 09:14:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:14:27 INFO - Using env: {'DISPLAY': ':0', 09:14:27 INFO - 'HOME': '/home/cltbld', 09:14:27 INFO - 'LANG': 'en_US.UTF-8', 09:14:27 INFO - 'LANGUAGE': 'en_US:en', 09:14:27 INFO - 'LOGNAME': 'cltbld', 09:14:27 INFO - 'MAIL': '/var/mail/cltbld', 09:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:27 INFO - 'MOZ_NO_REMOTE': '1', 09:14:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:27 INFO - 'NO_EM_RESTART': '1', 09:14:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:27 INFO - 'PWD': '/builds/slave/test', 09:14:27 INFO - 'SHELL': '/bin/bash', 09:14:27 INFO - 'SHLVL': '1', 09:14:27 INFO - 'TERM': 'linux', 09:14:27 INFO - 'TMOUT': '86400', 09:14:27 INFO - 'USER': 'cltbld', 09:14:27 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', 09:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:27 INFO - '_': '/tools/buildbot/bin/python'} 09:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:14:28 INFO - Cleaning up... 09:14:28 INFO - Return code: 0 09:14:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:14: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')]} 09:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14: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')]} 09:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf713f0>, '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 0xf71cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf721a0>, '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': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', '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 09:14:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:14:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:14:28 INFO - Using env: {'DISPLAY': ':0', 09:14:28 INFO - 'HOME': '/home/cltbld', 09:14:28 INFO - 'LANG': 'en_US.UTF-8', 09:14:28 INFO - 'LANGUAGE': 'en_US:en', 09:14:28 INFO - 'LOGNAME': 'cltbld', 09:14:28 INFO - 'MAIL': '/var/mail/cltbld', 09:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:28 INFO - 'MOZ_NO_REMOTE': '1', 09:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:28 INFO - 'NO_EM_RESTART': '1', 09:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:28 INFO - 'PWD': '/builds/slave/test', 09:14:28 INFO - 'SHELL': '/bin/bash', 09:14:28 INFO - 'SHLVL': '1', 09:14:28 INFO - 'TERM': 'linux', 09:14:28 INFO - 'TMOUT': '86400', 09:14:28 INFO - 'USER': 'cltbld', 09:14:28 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', 09:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:28 INFO - '_': '/tools/buildbot/bin/python'} 09:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:28 INFO - Downloading/unpacking blobuploader==1.2.4 09:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:30 INFO - Downloading blobuploader-1.2.4.tar.gz 09:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:14:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:14: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 09:14: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 09:14: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 09:14: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 09:14: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 09:14: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 09:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:14:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:14: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 09:14: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 09:14: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 09:14: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 09:14: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 09:14: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 09:14:30 INFO - Downloading docopt-0.6.1.tar.gz 09:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:14:31 INFO - Installing collected packages: blobuploader, requests, docopt 09:14:31 INFO - Running setup.py install for blobuploader 09:14:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:14:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:14:31 INFO - Running setup.py install for requests 09:14:31 INFO - Running setup.py install for docopt 09:14:31 INFO - Successfully installed blobuploader requests docopt 09:14:31 INFO - Cleaning up... 09:14:31 INFO - Return code: 0 09:14:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf713f0>, '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 0xf71cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf721a0>, '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': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', '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 09:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:14:31 INFO - Using env: {'DISPLAY': ':0', 09:14:31 INFO - 'HOME': '/home/cltbld', 09:14:31 INFO - 'LANG': 'en_US.UTF-8', 09:14:31 INFO - 'LANGUAGE': 'en_US:en', 09:14:31 INFO - 'LOGNAME': 'cltbld', 09:14:31 INFO - 'MAIL': '/var/mail/cltbld', 09:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:31 INFO - 'MOZ_NO_REMOTE': '1', 09:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:31 INFO - 'NO_EM_RESTART': '1', 09:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:31 INFO - 'PWD': '/builds/slave/test', 09:14:31 INFO - 'SHELL': '/bin/bash', 09:14:31 INFO - 'SHLVL': '1', 09:14:31 INFO - 'TERM': 'linux', 09:14:31 INFO - 'TMOUT': '86400', 09:14:31 INFO - 'USER': 'cltbld', 09:14:31 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', 09:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:31 INFO - '_': '/tools/buildbot/bin/python'} 09:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:31 INFO - Running setup.py (path:/tmp/pip-iXiZuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:31 INFO - Running setup.py (path:/tmp/pip-so7KbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:32 INFO - Running setup.py (path:/tmp/pip-pK7egM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:32 INFO - Running setup.py (path:/tmp/pip-k2QKjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:32 INFO - Running setup.py (path:/tmp/pip-9tBWJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:32 INFO - Running setup.py (path:/tmp/pip-3Qyghf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:32 INFO - Running setup.py (path:/tmp/pip-lMpvkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:32 INFO - Running setup.py (path:/tmp/pip-3v2kRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:32 INFO - Running setup.py (path:/tmp/pip-G5I7IA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:32 INFO - Running setup.py (path:/tmp/pip-Nz52tE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:32 INFO - Running setup.py (path:/tmp/pip-VlhXRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:32 INFO - Running setup.py (path:/tmp/pip-SDlWer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:32 INFO - Running setup.py (path:/tmp/pip-aW3dWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:32 INFO - Running setup.py (path:/tmp/pip-U2T9pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:32 INFO - Running setup.py (path:/tmp/pip-IM2Y2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:32 INFO - Running setup.py (path:/tmp/pip-hHi6aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:33 INFO - Running setup.py (path:/tmp/pip-AN1GT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:14:33 INFO - Running setup.py install for manifestparser 09:14:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:14:33 INFO - Running setup.py install for mozcrash 09:14:33 INFO - Running setup.py install for mozdebug 09:14:33 INFO - Running setup.py install for mozdevice 09:14:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:14:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:14:33 INFO - Running setup.py install for mozfile 09:14:33 INFO - Running setup.py install for mozhttpd 09:14:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:14:33 INFO - Running setup.py install for mozinfo 09:14:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:14:33 INFO - Running setup.py install for mozInstall 09:14:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:14:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:14:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:14:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:14:33 INFO - Running setup.py install for mozleak 09:14:33 INFO - Running setup.py install for mozlog 09:14:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:14:34 INFO - Running setup.py install for moznetwork 09:14:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:14:34 INFO - Running setup.py install for mozprocess 09:14:34 INFO - Running setup.py install for mozprofile 09:14:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:14:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:14:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:14:34 INFO - Running setup.py install for mozrunner 09:14:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:14:34 INFO - Running setup.py install for mozscreenshot 09:14:34 INFO - Running setup.py install for moztest 09:14:34 INFO - Running setup.py install for mozversion 09:14:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:14:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:14:34 INFO - Cleaning up... 09:14:34 INFO - Return code: 0 09:14:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf713f0>, '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 0xf71cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf721a0>, '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': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', '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 09:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:14:34 INFO - Using env: {'DISPLAY': ':0', 09:14:34 INFO - 'HOME': '/home/cltbld', 09:14:34 INFO - 'LANG': 'en_US.UTF-8', 09:14:34 INFO - 'LANGUAGE': 'en_US:en', 09:14:34 INFO - 'LOGNAME': 'cltbld', 09:14:34 INFO - 'MAIL': '/var/mail/cltbld', 09:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:34 INFO - 'MOZ_NO_REMOTE': '1', 09:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:34 INFO - 'NO_EM_RESTART': '1', 09:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:34 INFO - 'PWD': '/builds/slave/test', 09:14:34 INFO - 'SHELL': '/bin/bash', 09:14:34 INFO - 'SHLVL': '1', 09:14:34 INFO - 'TERM': 'linux', 09:14:34 INFO - 'TMOUT': '86400', 09:14:34 INFO - 'USER': 'cltbld', 09:14:34 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', 09:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:34 INFO - '_': '/tools/buildbot/bin/python'} 09:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:35 INFO - Running setup.py (path:/tmp/pip-ebNJvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:35 INFO - Running setup.py (path:/tmp/pip-fofIeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:35 INFO - Running setup.py (path:/tmp/pip-5O_lY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:35 INFO - Running setup.py (path:/tmp/pip-mDOFwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:35 INFO - Running setup.py (path:/tmp/pip-1VtDli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:35 INFO - Running setup.py (path:/tmp/pip-EcMEAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:35 INFO - Running setup.py (path:/tmp/pip-YMSJp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:35 INFO - Running setup.py (path:/tmp/pip-97UmhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:35 INFO - Running setup.py (path:/tmp/pip-hXKds3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:35 INFO - Running setup.py (path:/tmp/pip-ldVAyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:35 INFO - Running setup.py (path:/tmp/pip-0g0bwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:35 INFO - Running setup.py (path:/tmp/pip-xhE_mT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:36 INFO - Running setup.py (path:/tmp/pip-BvClFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:36 INFO - Running setup.py (path:/tmp/pip-Ltn3FQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:36 INFO - Running setup.py (path:/tmp/pip-wYRhm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:36 INFO - Running setup.py (path:/tmp/pip-t1AOn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:36 INFO - Running setup.py (path:/tmp/pip-BmQGuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:14:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:38 INFO - Downloading blessings-1.6.tar.gz 09:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:14:38 INFO - Installing collected packages: blessings 09:14:38 INFO - Running setup.py install for blessings 09:14:38 INFO - Successfully installed blessings 09:14:38 INFO - Cleaning up... 09:14:38 INFO - Return code: 0 09:14:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:14:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:38 INFO - Reading from file tmpfile_stdout 09:14:38 INFO - Current package versions: 09:14:38 INFO - argparse == 1.2.1 09:14:38 INFO - blessings == 1.6 09:14:38 INFO - blobuploader == 1.2.4 09:14:38 INFO - docopt == 0.6.1 09:14:38 INFO - functools32 == 3.2.3-2 09:14:38 INFO - jsonschema == 2.5.1 09:14:38 INFO - manifestparser == 1.1 09:14:38 INFO - mozInstall == 1.12 09:14:38 INFO - mozcrash == 1.0 09:14:38 INFO - mozdebug == 0.1 09:14:38 INFO - mozdevice == 0.49 09:14:38 INFO - mozfile == 1.2 09:14:38 INFO - mozhttpd == 0.7 09:14:38 INFO - mozinfo == 0.9 09:14:38 INFO - mozleak == 0.1 09:14:38 INFO - mozlog == 3.4 09:14:38 INFO - moznetwork == 0.27 09:14:38 INFO - mozprocess == 0.23 09:14:38 INFO - mozprofile == 0.28 09:14:38 INFO - mozrunner == 6.13 09:14:38 INFO - mozscreenshot == 0.1 09:14:38 INFO - mozsystemmonitor == 0.3 09:14:38 INFO - moztest == 0.8 09:14:38 INFO - mozversion == 1.4 09:14:38 INFO - psutil == 3.1.1 09:14:38 INFO - requests == 1.2.3 09:14:38 INFO - wsgiref == 0.1.2 09:14:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf713f0>, '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 0xf71cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf721a0>, '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': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', '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 09:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:14:38 INFO - Using env: {'DISPLAY': ':0', 09:14:38 INFO - 'HOME': '/home/cltbld', 09:14:38 INFO - 'LANG': 'en_US.UTF-8', 09:14:38 INFO - 'LANGUAGE': 'en_US:en', 09:14:38 INFO - 'LOGNAME': 'cltbld', 09:14:38 INFO - 'MAIL': '/var/mail/cltbld', 09:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:38 INFO - 'MOZ_NO_REMOTE': '1', 09:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:38 INFO - 'NO_EM_RESTART': '1', 09:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:38 INFO - 'PWD': '/builds/slave/test', 09:14:38 INFO - 'SHELL': '/bin/bash', 09:14:38 INFO - 'SHLVL': '1', 09:14:38 INFO - 'TERM': 'linux', 09:14:38 INFO - 'TMOUT': '86400', 09:14:38 INFO - 'USER': 'cltbld', 09:14:38 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', 09:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:38 INFO - '_': '/tools/buildbot/bin/python'} 09:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:39 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)) 09:14:39 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)) 09:14:39 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)) 09:14:39 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)) 09:14:39 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)) 09:14:39 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)) 09:14:39 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)) 09:14:39 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)) 09:14:39 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)) 09:14:39 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)) 09:14:39 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)) 09:14:39 INFO - Cleaning up... 09:14:39 INFO - Return code: 0 09:14:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf73c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf713f0>, '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 0xf71cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf721a0>, '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': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', '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 09:14:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:14:39 INFO - Using env: {'DISPLAY': ':0', 09:14:39 INFO - 'HOME': '/home/cltbld', 09:14:39 INFO - 'LANG': 'en_US.UTF-8', 09:14:39 INFO - 'LANGUAGE': 'en_US:en', 09:14:39 INFO - 'LOGNAME': 'cltbld', 09:14:39 INFO - 'MAIL': '/var/mail/cltbld', 09:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:39 INFO - 'MOZ_NO_REMOTE': '1', 09:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:39 INFO - 'NO_EM_RESTART': '1', 09:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:39 INFO - 'PWD': '/builds/slave/test', 09:14:39 INFO - 'SHELL': '/bin/bash', 09:14:39 INFO - 'SHLVL': '1', 09:14:39 INFO - 'TERM': 'linux', 09:14:39 INFO - 'TMOUT': '86400', 09:14:39 INFO - 'USER': 'cltbld', 09:14:39 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', 09:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:39 INFO - '_': '/tools/buildbot/bin/python'} 09:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:14:39 INFO - Cleaning up... 09:14:39 INFO - Return code: 0 09:14:39 INFO - Running post-action listener: _resource_record_post_action 09:14:39 INFO - Running post-action listener: _start_resource_monitoring 09:14:39 INFO - Starting resource monitoring. 09:14:39 INFO - [mozharness: 2016-12-30 17:14:39.348392Z] Finished create-virtualenv step (success) 09:14:39 INFO - [mozharness: 2016-12-30 17:14:39.348854Z] Running install step. 09:14:39 INFO - Running pre-action listener: _resource_record_pre_action 09:14:39 INFO - Running main action method: install 09:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:39 INFO - Reading from file tmpfile_stdout 09:14:39 INFO - Detecting whether we're running mozinstall >=1.0... 09:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:14:39 INFO - Reading from file tmpfile_stdout 09:14:39 INFO - Output received: 09:14:39 INFO - Usage: mozinstall [options] installer 09:14:39 INFO - Options: 09:14:39 INFO - -h, --help show this help message and exit 09:14:39 INFO - -d DEST, --destination=DEST 09:14:39 INFO - Directory to install application into. [default: 09:14:39 INFO - "/builds/slave/test"] 09:14:39 INFO - --app=APP Application being installed. [default: firefox] 09:14:39 INFO - mkdir: /builds/slave/test/build/application 09:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:14:56 INFO - Reading from file tmpfile_stdout 09:14:56 INFO - Output received: 09:14:56 INFO - /builds/slave/test/build/application/firefox/firefox 09:14:56 INFO - Running post-action listener: _resource_record_post_action 09:14:56 INFO - [mozharness: 2016-12-30 17:14:56.966560Z] Finished install step (success) 09:14:56 INFO - [mozharness: 2016-12-30 17:14:56.966806Z] Running run-tests step. 09:14:56 INFO - Running pre-action listener: _resource_record_pre_action 09:14:56 INFO - Running main action method: run_tests 09:14:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:14:56 INFO - Python 2.7.3 09:14:56 INFO - Return code: 0 09:14:56 INFO - grabbing minidump binary from tooltool 09:14:56 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')]} 09:14:56 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 0xf713f0>, '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 0xf71cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf721a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:14:56 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 09:14:56 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 09:14:56 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 09:14:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:14:57 INFO - Return code: 0 09:14:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:14:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:14:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:14:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:14:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:14:57 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/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 09:14:57 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/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 09:14:57 INFO - Using env: {'DISPLAY': ':0', 09:14:57 INFO - 'HOME': '/home/cltbld', 09:14:57 INFO - 'LANG': 'en_US.UTF-8', 09:14:57 INFO - 'LANGUAGE': 'en_US:en', 09:14:57 INFO - 'LOGNAME': 'cltbld', 09:14:57 INFO - 'MAIL': '/var/mail/cltbld', 09:14:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:14:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:57 INFO - 'MOZ_NO_REMOTE': '1', 09:14:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:57 INFO - 'NO_EM_RESTART': '1', 09:14:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:57 INFO - 'PWD': '/builds/slave/test', 09:14:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:14:57 INFO - 'SHELL': '/bin/bash', 09:14:57 INFO - 'SHLVL': '1', 09:14:57 INFO - 'TERM': 'linux', 09:14:57 INFO - 'TMOUT': '86400', 09:14:57 INFO - 'USER': 'cltbld', 09:14:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669', 09:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:57 INFO - '_': '/tools/buildbot/bin/python'} 09:14:57 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/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 09:14:57 INFO - mozversion application_buildid: 20161230073208 09:14:57 INFO - mozversion application_changeset: 9104708cc3ac0ccfe4cf5d518e13736773c565d7 09:14:57 INFO - mozversion application_display_name: Nightly 09:14:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:14:57 INFO - mozversion application_name: Firefox 09:14:57 INFO - mozversion application_remotingname: firefox 09:14:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:14:57 INFO - mozversion application_vendor: Mozilla 09:14:57 INFO - mozversion application_version: 53.0a1 09:14:57 INFO - mozversion platform_buildid: 20161230073208 09:14:57 INFO - mozversion platform_changeset: 9104708cc3ac0ccfe4cf5d518e13736773c565d7 09:14:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:14:57 INFO - mozversion platform_version: 53.0a1 09:14:57 INFO - using testdate: 1483118097 09:14:57 INFO - actual date: 1483118097 09:14:57 INFO - starting webserver on 'localhost:57215' 09:14:57 INFO - SUITE-START | Running 2 tests 09:14:57 INFO - TEST-START | dromaeo_css 09:14:57 INFO - operating with platform_type : linux_ 09:14:57 INFO - Initialising browser for dromaeo_css test... 09:14:57 INFO - TEST-INFO | started process 27486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvNXOyR/profile http://localhost:57215/getInfo.html) 09:14:57 INFO - PROCESS | 27486 | 1483118097724 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 09:15:01 INFO - PROCESS | 27486 | __metrics Screen width/height:1600/1200 09:15:01 INFO - PROCESS | 27486 | colorDepth:24 09:15:01 INFO - PROCESS | 27486 | Browser inner width/height: 1024/697 09:15:01 INFO - PROCESS | 27486 | __metrics 09:15:02 ERROR - PROCESS | 27486 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 09:15:03 INFO - TEST-INFO | 27486: exit 0 09:15:03 INFO - Browser initialized. 09:15:03 INFO - Running cycle 1/1 for dromaeo_css test... 09:15:03 INFO - TEST-INFO | started process 27611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvNXOyR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:14 INFO - PROCESS | 27611 | RSS: Main: 154185728 09:15:14 INFO - PROCESS | 27611 | 09:16:04 INFO - PROCESS | 27611 | 1483118164555 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] 09:18:15 INFO - PROCESS | 27611 | Cycle 1(1): loaded http://localhost:57215/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57215/tests/dromaeo/cssquery-ext.html) 09:18:16 INFO - PROCESS | 27611 | RSS: Main: 164728832 09:18:16 INFO - PROCESS | 27611 | 09:20:03 INFO - PROCESS | 27611 | ************************* 09:20:03 INFO - PROCESS | 27611 | A coding exception was thrown and uncaught in a Task. 09:20:03 INFO - PROCESS | 27611 | 09:20:03 INFO - PROCESS | 27611 | Full message: ReferenceError: fetch is not defined 09:20:03 INFO - PROCESS | 27611 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 09:20:03 INFO - PROCESS | 27611 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 09:20:03 INFO - PROCESS | 27611 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 09:20:03 INFO - PROCESS | 27611 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 09:20:03 INFO - PROCESS | 27611 | TaskImpl@resource://gre/modules/Task.jsm:277:3 09:20:03 INFO - PROCESS | 27611 | asyncFunction@resource://gre/modules/Task.jsm:252:14 09:20:03 INFO - PROCESS | 27611 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 09:20:03 INFO - PROCESS | 27611 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 09:20:03 INFO - PROCESS | 27611 | TaskImpl@resource://gre/modules/Task.jsm:277:3 09:20:03 INFO - PROCESS | 27611 | asyncFunction@resource://gre/modules/Task.jsm:252:14 09:20:03 INFO - PROCESS | 27611 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 09:20:03 INFO - PROCESS | 27611 | 09:20:03 INFO - PROCESS | 27611 | ************************* 09:21:19 INFO - PROCESS | 27611 | Cycle 1(1): loaded http://localhost:57215/tests/dromaeo/cssquery-ext.html (next: http://localhost:57215/tests/dromaeo/cssquery-jquery.html) 09:21:19 INFO - PROCESS | 27611 | RSS: Main: 160276480 09:21:19 INFO - PROCESS | 27611 | 09:24:21 INFO - PROCESS | 27611 | Cycle 1(1): loaded http://localhost:57215/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57215/tests/dromaeo/cssquery-mootools.html) 09:24:22 INFO - PROCESS | 27611 | RSS: Main: 167309312 09:24:22 INFO - PROCESS | 27611 | 09:27:24 INFO - PROCESS | 27611 | Cycle 1(1): loaded http://localhost:57215/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57215/tests/dromaeo/cssquery-prototype.html) 09:27:24 INFO - PROCESS | 27611 | RSS: Main: 161124352 09:27:24 INFO - PROCESS | 27611 | 09:30:27 INFO - PROCESS | 27611 | Cycle 1(1): loaded http://localhost:57215/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57215/tests/dromaeo/cssquery-yui.html) 09:30:28 INFO - PROCESS | 27611 | RSS: Main: 166330368 09:30:28 INFO - PROCESS | 27611 | 09:33:30 INFO - PROCESS | 27611 | Cycle 1(1): loaded http://localhost:57215/tests/dromaeo/cssquery-yui.html (next: http://localhost:57215/tests/dromaeo/cssquery-dojo.html) 09:33:31 INFO - PROCESS | 27611 | RSS: Main: 165146624 09:33:31 INFO - PROCESS | 27611 | 09:33:31 INFO - PROCESS | 27611 | __start_tp_report 09:33:31 INFO - PROCESS | 27611 | _x_x_mozilla_page_load 09:33:31 INFO - PROCESS | 27611 | _x_x_mozilla_page_load_details 09:33:31 INFO - PROCESS | 27611 | |i|pagename|runs| 09:33:31 INFO - PROCESS | 27611 | |0;dojo.html;3183.2360233543955;3226.887058952937;3229.5640088588034;3247.967520324799;3252.0894149638093;5336.439673834249;5438.238646589481;5470.8085217017415;5476.205950137228;5533.391326954032;5377;5414.458554144584;5416;5488.121900495921;5497.147942068976;4879.170541008019;4908.877278068059;4963.4540200578085;4988.301637770715;5008.173651347523;4878.219484882419;5003.524665156804;5042.294078828967;5061;5061.519155680205;4877.463479017305;4898.559129678346;4997.42529609096;5036.269740887569;5037.697738135724;4890.315355850184;4897.461279259279;4902.411710594716;4955.776990035457;4986.950130498685;4911.975440122812;4914.606831453475;4914.803407863681;4932.136876046678;4961.355023846912;5334.146536554133;5389.487998640123;5428.267183930158;5473.616846820724;5495.670259784386;5790.826275211751;5804.622699524517;5805.767769289266;5837.474627283523;5926.051831706949;5839.240898683144;5878.911816322759;5899.882002359972;5901.3803550627;5911.763529458816;5499.312585926759;5504.504594586507;5508.697021663847;5510.476504732044;5511.944880551223;5919.881602367928;5982.910256346158;5998.550108741862;6009.579329446984;6018.969905150446;5765;5794.391588883106;5806.680632565165;5813.680247586339;5856.267966504187;5883.882322353529;5910.143029260819;5911.527077833763;5916.112583112567;5919.141724450017;5507.201455788968;5612.831615051555;5618.522425593788;5667.688277144796;5690.601657883908;5703.344115426779;5704.030314846486;5705.600607957404;5708.4862362387585;5710.3433105193435;4342.478902531717;4351.782410879443;4353.782310884443;4353.782310884443;4359.411479450297;3910.061585219527;3931.3906344516645;3934.09515811365;3935.153941902505;3936.0946982194255;5420.942916131396;5460.481254280837;5471.4528547145765;5474.42518535556;5478.58910581708;5842.182094506772;5861.765529378862;5862.413758624103;5869.090291004815;5885.352611212763;5533.557315414757;5566.165075238666;5590.91613625796;5618.353889302701;5634.098544232985;4966.354373931365;4966.553010229024;4973.030259099513;4973.875653108701;5014.573761230264;6010.248718910224;6017.518598512109;6136.631802091889;6245.843853903689;6257.186565746515;5785.132230165341;5858.209141765807;5897.5576831736935;5912.201852749824;5957.761689532544;6085.482733967662;6096.664683442454;6130;6133.294671112879;6138.478229350555;5597.63615365;5656.773729050792;5810.4189581041555;5834.38738932423;5837.737301821343;5867.20792692998;5906.940930590639;5909.3795151508475;5980.401959803985;6023.216981792339;5766.682832444256;5767.279090113736;5832.416758324133;5836.124581312837;5841.1530328101335;5611.354694210055;5803.970980145073;5810.709464526842;5813.302403711582;5816.3892791258;5602.2717046783655;5730.484256416942;5744.339400968942;5747.396523364986;5839.708014599338;5826;5852.268466441695;5856.180134781219;5868.911966320423;5877.4122587740885;5704.942950570441;5706.771729130788;5722.341930678025;5728.198052272602;5729.656220626775 09:33:31 INFO - PROCESS | 27611 | |1;ext.html;548.268062137047;559.5467671186337;569.4476357932804;588.0708480600651;595.8718875441781;40926;42427.36358954614;42747.14505709888;46099.76950115253;46382.53617463824;44085.559144408544;44784.3282350765;44817.7759111204;44826.103477930425;44847;8766.123387661231;9023.774405639879;9038.593263303133;10274.486275686224;10525.789484210349;10468.319559228665;10521.105706014998;10534.26260161789;10552.15582753378;10584.1532677386;10584.576616935314;10596.364218146897;10663.306885052485;10666.466676666174;10680.732981675443;10469.528871200815;10501.264911456201;10504.159667226642;10534;10561.73595660107;10387.792244155075;10401.063904248578;10452.111570516516;10452.32059916103;10460.895391046068;38702.419463708065;39294.410583841265;39299.41050884239;39383.21233575341;39536.20927581461;4102.815373308208;4141.233871733709;4180.498340199196;4214.346776249687;4214.704970652056;29748.256293592833;29956.400871982438;30489.542656859943;30762.53856192159;31357.52963705546;4328.4156638853665;4412.624926881219;4420.8452704155525;4423.336499525065;4453.621442177418;338527;341176;341673;341831.9999999975;343155;51742;51854.22218666723;51907;52223.73888130611;52237.21644175341;54688.17967730408;54961.450385496435;54972.17541736877;55228.447715523136;55360;14209.36057877398;14556.272186390637;14584.270786460635;14675.779863301845;14682.632934176518;10258.58965641381;10427.217958653131;10457.477126143662;10616.681499555025;10704.19718521114;17253.741193882102;17357.826421735874;17382.391616293367;17439.73840392395;17529.474115776546;6788.76239331621;7044.471664625174;7080.468964827659;7103.896103896104;7187.31720486553;909.949952752605;911.2072496927715;911.3620465674055;917.3165991336364;923.5151545438698;29704;29732.256693582833;30190.849045754632;30619.2345191372;30832.38335233283;1056.5456853553046;1072.7556034999363;1084.8535447714614;1093.6336327330275;1174.301290732013;15947.09296222433;16400.589985250226;16484.917575412284;16514.174291285388;16681;543774;546157;546373;546738;547745;59689.70155149196;60508.69745651243;60604.393956060754;60823;60969.695151523956;1325.6818363592668;1373.622253880191;1375.6354566040006;1381.3093453273364;1384.8892088632886;28661.570076449287;28922.132336029954;29225.415491689622;29678.40643187081;31081.689183108785;50420.49579504305;51066.744666276434;51214.231786523975;51228.74385628048;51370;490492;491994;496049;496769;497807;38408;39497.80251098726;39866.2026759469;40053.599464006154;40094.59905401025;41807;43708.34437483504;43983.340249895635;44294;44366;34022.48966265558;36845.81577092098;37041.44437833381;37173.25653486861;37556.06109847166;36602.81698591597;36622.45066323954;36766.816165919;37850;37946;36560.45159322559;36888.44667329938;37531;37769.62230377661;37878.431823522114;31256.68743312538;33268.50097248592;33715.3256934855;33934.151646208054;34034.14914627055;25504;25597.488050238517;25945.07043661698;25961.221163365128;26237.73762262353 09:33:31 INFO - PROCESS | 27611 | |2;jquery.html;400.3474336830967;412.8885200995731;413.79723935271727;416.51268016420795;433.09915376017887;15960.680786384266;18250.17874195661;18506.629867402644;19016.04919754012;19195.808041919576;18912.338068167617;19033.428997130108;19545.21819127233;19916.60166796663;19999.300024499145;5405.081136206844;5464.316960379952;5662.943370566303;5670.291213598301;5692.203091567184;5613.129964855433;5686.914696279559;5688.146777983315;5697.515711164556;5698.743556539945;5465.180222966547;5566.666000039991;5595.468430499096;5597.8600534986745;5605.27131472908;5462.371827239839;5568.582356323252;5580.944190558083;5621.353544342412;5629.408912064236;5062.7468626568525;5093.719845408501;5099.36257967754;5108.208227724708;5114.616403769732;20633.58732825335;20724;21138.471538211514;22714.77285227143;22826.65760013601;2713.4166154276927;2742.4103817679293;2750.4499100179846;2756.6140740296373;2757.352022274764;13729.519466818714;14299.356528956117;14384.64038399038;14753.11481311114;14947;1985.1364656374378;2014.5769388428448;2103.974561215808;2123.7363768557684;2174.097749433983;77912;77987.61006194932;79221.60389198133;80503.5974820128;80644;11048.834267485994;11159.330440173615;11223.71940701489;11518.193726439236;11811.173217874839;12244.204126731735;15660;15710.057396556243;15721.663658589148;15726.29231684577;5945.583809133319;6102.298235702862;6131.172291740647;6513;7448.776536703907;6953.79138625842;7005.54463959841;7008.544444611084;7242.601656908815;7273.27267273279;4069.1861627673993;4127.9174416511505;4175.728577642443;4189.371594260885;4259.637930775919;1974.3682021753189;2016.2539860251507;2034.9186032558532;2041.57127003328;2064.1846470644014;818.3289702443939;838.828040251747;844.3751623798468;846.754441212054;855.7261676263536;17578;17711;18220.271189152285;18424.631507370046;18684.159212835184;845.2139510255521;847.6694089305176;859.8925134358205;864.3042350907455;871.0462044061742;9782.510874456391;10268.43523606194;10598.364098154136;10651;10715;386336;389316;392226;394919;395532;81374;81964.59017704874;83194.16805831985;95312.52343738236;97903;1056.963006294776;1082.621082621092;1108.036008672444;1111.4331690837569;1121.1031175060082;16875.662486750443;16926.40757573479;17357.56606084858;17706.203220854833;17736.91131544334;38666;39803.2039359217;40275;40380.394294085025;40923;53563;55455.72272138613;55586.44413555813;55800;56448.15327770005;8422.663093476438;8632.568371581521;8693.782655433664;8730.56347182651;8789.91210087891;9340.206082483064;11464.828027579426;12334.444949977093;12454;13412.195268283544;11296.6046188383;11562.76874462523;11625.6512304631;11625.88374116282;11824.40877956116;11515.596954106566;11548.48031838586;11559.422028898352;11719.769424210335;11861.881381186078;11647.534098635959;11785.469653865424;11798.941005294919;11971.940140299592;12155.939220303842;8252.711155109542;8444.746657600283;8670.869936950825;8686.435381700168;8753.562321884008;9477.336586439158;11606;11736.413179341169;11830.645080647595;12131.150819442908 09:33:31 INFO - PROCESS | 27611 | |3;mootools.html;1391.7425276323881;1395.727833072551;1410.4005797536045;1411.6047506698121;1412.3714946848643;8107.310878575321;8341.62462689179;8540.060593334729;8555.144485551442;8629.870551941725;8406.705765298217;8639.352048596365;8669.263112635434;8672.826543469128;8685.652573897036;2347.694799676044;2356.823238257129;2363.243761996162;2376.310869847751;2377.9762202378015;2356.8114550835894;2408.0488207158164;2415.710114786228;2422.9394265143337;2422.9878850605724;2312.190733243368;2337.9766202338014;2352.4001379648166;2361.161787565415;2366.7869891709743;2327.464683122883;2347.94130146746;2372.229025566689;2379.238643634038;2390.820688448356;2294.7705229477087;2359.2214569192297;2360.362702070431;2411.0114852910397;2411.638254261857;8628;8637.870431943526;8705.7823554411;8719.389642725011;8728.170823771732;5265.76304066318;5370.5435038021815;5391.218273350342;5401;5412.810551630713;3534.151803567151;3541.3979623463815;3591.964080359189;3612.060864175307;3643.344198044351;1307.7123032932739;1361.7276544691101;1438.2449214162543;1470.6176394137494;1548.9457868974644;10966.287191332618;11288.492017859217;11375.772484550345;11491.138164637601;11681.123915706272;4527.7736113194205;4555.6083056395655;4716.9292460613115;4719.764011799396;4738.715677059318;9400.341976061747;9428.198603118812;9469.715908522756;9471.384360016576;9485.288603354638;5291.3385826771655;5317.468253174729;5357.303550538405;5394.352677678704;5398.946010539923;4812.879678008007;4949.1091603510995;4964.503549645006;5050.747462626854;5054.974725126424;3770.547534295902;3854.1520865409566;3862.6909847212155;3912.1002169501176;3949.328614135604;1195.5217912834935;1196.7606478704295;1204.753025629744;1207.0464333176867;1212.1333246728632;932.6735642525198;949.1362859797551;951.6383774165772;955.5890966884307;957.4494665567327;5565.359983601857;5749.453801888814;5756.971215143897;5902.734376953047;5999.01016332309;581.6713556840372;582.3594046548847;584.8742520358144;585.2041223935445;586.4106572894214;3650.872219472306;3779.527559055118;4081.10215752534;4089.6114869087983;4113.424120623115;10003.44981026036;10198;10222.13111885498;10239.334443261165;10239.539220735085;10121.240906931862;10136;10200.132988696045;10220.540075696463;10223.795524089477;7528.473006889465;7826.1391246962785;7870.527768333804;7917.247861453153;7967.920320796834;5632;5871.500922421642;5881.705914704162;5909;5957.851053723692;9022.458652480873;9047.638094476148;9055.094490550891;9070.954645226731;9164.725058248263;9136.360454768102;9136.406133601295;9137.497437640994;9208.769780755534;9258.629654814002;7343.082114735658;7503.8499230014;7537.095548534211;7622.885656715264;7713.344365728976;8385.32917366597;8403.70587029451;8406;8431.915680843113;8436.409451338593;7509.136449308181;7525.736599219001;7560.546367217985;7641;7813.843723125392;7270.9636451819515;7281.381082608038;7309.378702810108;7313.414926805949;7398;6399.520035997226;6488;6505.284418714033;6513.5114866384265;6518.185226846645;4935.728534930613;4941.209406494943;4970.409468969895;4976.869680150779;5153.252778347193;4903.485134060872;4923.729194894315;4946.530079642428;4991.226359914219;5036.647434679538 09:33:31 INFO - PROCESS | 27611 | |4;prototype.html;397.4316727080275;397.80109945027476;401.62046865711915;404.0726532607665;409.8217275485162;5400.864978375543;5412.729363531823;5444.455554444564;5515.641483303588;5530.644991976961;5222.973885130569;5334.279872217249;5377.193420986854;5391.433899440561;5409.377921539024;4265.445492086024;4271.124419493996;4282.635975942048;4303.321704535226;4324.6972711910175;4272.722273052257;4298.914021719564;4300.935485967713;4303.3544968254855;4316.719413238129;4132.8966775830695;4228.936565951513;4249.681273904454;4295.634871035965;4318.719283246579;4231.217224813404;4236.6187043165955;4248.874048377183;4273.188094262096;4275.230458517465;3825.483559719458;3854.383298672227;3877.3408520551575;3885.261800257942;3892.143728379752;5156.381234251876;5254.579633629339;5263.605229607795;5347.101778868485;5357.598180136505;4886.951130488721;4978.253262010691;4980.477049909744;4985.900281994376;4993.051320249141;5631.887362252773;5643.40744221859;5652.660840349592;5695.5191650171255;5708.600397972144;4060.3706425504092;4208.768517731523;4224.38746381776;4235.745855248695;4249.745015299092;5686.516646085046;5844.1818145459665;5860.326062502824;5876.854013467376;5928.61464004834;4074.5110586729784;4140.23405669946;4144.70987030911;4147.709660323749;4151.875443736692;4193.685473589493;4214.745111365466;4222.332178789361;4229.936550951738;4230.682698797603;4731.976340118277;4787.736674482867;4788.3056956741075;4814.855554333376;4830.106430310404;5662.5753068520025;5675.55273405279;5698.458646428583;5698.458646428583;5724.942750572524;1505.9247037648074;1506.3823832228734;1514.4775052606833;1515.0985513180888;1521.1253529220521;1028.6348346337093;1094.7372630568607;1108.3128460354633;1111.4942701070993;1113.2819331531116;5298.6290959633225;5323.40297910633;5331.44019877915;5353.447500224969;5382.865428364322;5582.358028826656;5584.748686309126;5587.966226248157;5600.831975040755;5658.519025882763;5229.947700522946;5273.235380869753;5286;5516.889662206733;5551.611387202938;2966.5229533339902;2998.445287621797;2999.7300242978235;3010.991317908525;3020.7432368248506;5712.314522257356;5938.584299099108;5942.296255203872;5965.791197308074;6025.698715064229;5770.480656740913;5779.682117483579;5794.681292528951;5813.854653633693;5834.299884013945;5849.6782676952325;5887.175795388649;5897.616654917417;5900.875684753485;5915.822525324247;5472.2338872557075;5638.4925356718095;5654.6324488908085;5771.5671324649975;5798.5651076168615;5726.599138060295;5752.9712351437975;5770.105633626795;5794.333651629948;5795.478406943395;5967.731452084753;6019.9465093609315;6022.969885150546;6070.514358851369;6158.969205154125;4149.751014939114;4167.187398457393;4172.791360431906;4179.644730197967;4181.540030596571;5733.913991290217;5887.146363777314;5889.352171261244;5910.4089591042275;5961.509622594352;5636.605437619327;5682.744276507485;5698.4016678249845;5707.942920570741;5724.940885936116;5678.801241956512;5740.167675687086;5751.367349591458;5782.450667186778;5796.739146738491;5498.3127109111365;5647.858803529944;5676.602637815313;5699.886002279848;5776.942230577641;5701.800436984686;5704.714764261687;5713.628614140068;5739.986507083814;5756.136579513107;5578.553715702653;5578.804741834017;5584.301962254718;5612.971935140462;5616.241807355955 09:33:31 INFO - PROCESS | 27611 | |5;yui.html;733.2996987876578;760.6310939194493;786.3551887452288;839.5466448118017;840.743573210171;14449.133052016887;15191.620209494768;15672.059676419394;15741.134237616941;16535.834641653593;12465.750684986295;13266.005049621268;13275.468981240763;13334.399952002159;13459.730805383886;805.7824387415394;824.4558591329724;824.579464473117;825.9587020648974;826.7230477789948;786.728578640371;786.7757689058619;788.7988562916448;789.2975252025702;789.5302295134386;862.7282406042108;863.2834747159874;865.6970060478814;865.9004214515317;867.557545651719;856.2037305306063;856.9528675922821;858.2490320969152;860.7503823891064;861.2593169873903;625.837282306599;626.1140486212005;627.4102343796862;634.3339493531773;635.1647583427824;13330.200187988752;13554.186748795104;13706.314684265746;13858.4456621735;13882.93058534711;12750.234985900875;12800.359982000862;13265.933670331684;13363.53227637028;13367;12101.93949030258;12222.938885305606;12285.201461904948;12463.937680311541;12559.497620095186;3743.5882052974152;3875.8255878485534;3882.145927895858;3892.630200130983;3908.374660054406;81226.59386703088;81837;82197.17802821955;83963;84220.57889710512;11566.768664626661;11657.300561966309;11698.88301116995;11832.734918966085;11881.22772019816;22611.493609665038;23301.650475242885;23321.183758568368;23323.533529329317;23461.7653823463;7598.696052157962;7659.157492675801;7776.883346749803;7844.646990885424;7933.167017463199;4383.473983122046;4411.823527058882;4497.752623605667;4502.257127573914;4515.63874890008;3572.160542272564;3631.94552081719;3635.94546081809;3706.1475860552223;3715.16408808016;640.0814830717935;644.8839208942342;647.0326861342323;655.1679367203625;655.7049327802508;725.300085417564;730.8684436801427;746.9477136600386;769.3844924060729;793.5199204481321;8850.468971861708;9346.719598412059;9430.62277508892;9600.231981441608;9634.807303853884;718.7664009196927;740.1192580828797;741.1735914455344;741.2032065529577;746.358132006474;4213.136307057046;4430.335449682509;4450.977745111319;4463.330500424962;4498.572635599613;79302;79931.60034199792;80223.59888200522;80552.19447805564;81155.5942220285;69796.30203697897;69867.3013269871;70320;71003.2899671007;72624.27375726281;53762.46237537575;61189;61878.38121618726;62148;62775;9833.950830245803;10006.949965250127;10101.898981010096;10277.383356998604;10300.433476158583;36581;36875.63124368722;37740;38978.61021389863;42544;44738.55261447344;45701.314480282155;52324.47675523196;53050;54126;12466.189697669623;12483.500659973499;12686.238825670489;12863.356832158543;13001.15492492985;14691.485797997018;14792.704145917236;14812.777808332668;14818.925905370405;14864.40542378336;13949.3722782473;13983.720325593635;14486.275686215859;14539.563813085624;14729.410823566937;13785.793213102012;13855;13894.722105558034;14525.346359413641;15051.623709407353;12624.936875315932;12844.935775321064;13265.80101298462;13770.518031868836;13780.517681881087;11110.833337500106;11613.070954323464;11801.468933897824;11924.165308428326;12283.754324913272;10481.842772358574;10830.67507974762;11080.722981925193;11082.833757493805;11087.501062452047 09:33:31 INFO - PROCESS | 27611 | __end_tp_report 09:33:31 INFO - PROCESS | 27611 | __start_cc_report 09:33:31 INFO - PROCESS | 27611 | _x_x_mozilla_cycle_collect,315 09:33:31 INFO - PROCESS | 27611 | __end_cc_report 09:33:31 INFO - PROCESS | 27611 | __startTimestamp1483119211035__endTimestamp 09:33:31 INFO - PROCESS | 27611 | 09:33:31 INFO - PROCESS | 27611 | ------- Summary: start ------- 09:33:31 INFO - PROCESS | 27611 | Number of tests: 6 09:33:31 INFO - PROCESS | 27611 | 09:33:31 INFO - PROCESS | 27611 | [#0] dojo.html Cycles:165 Average:5438.06 Median:5667.69 stddev:634.32 (11.2%) stddev-sans-first:611.10 09:33:31 INFO - PROCESS | 27611 | Values: 3183.2 3226.9 3229.6 3248.0 3252.1 5336.4 5438.2 5470.8 5476.2 5533.4 5377.0 5414.5 5416.0 5488.1 5497.1 4879.2 4908.9 4963.5 4988.3 5008.2 4878.2 5003.5 5042.3 5061.0 5061.5 4877.5 4898.6 4997.4 5036.3 5037.7 4890.3 4897.5 4902.4 4955.8 4987.0 4912.0 4914.6 4914.8 4932.1 4961.4 5334.1 5389.5 5428.3 5473.6 5495.7 5790.8 5804.6 5805.8 5837.5 5926.1 5839.2 5878.9 5899.9 5901.4 5911.8 5499.3 5504.5 5508.7 5510.5 5511.9 5919.9 5982.9 5998.6 6009.6 6019.0 5765.0 5794.4 5806.7 5813.7 5856.3 5883.9 5910.1 5911.5 5916.1 5919.1 5507.2 5612.8 5618.5 5667.7 5690.6 5703.3 5704.0 5705.6 5708.5 5710.3 4342.5 4351.8 4353.8 4353.8 4359.4 3910.1 3931.4 3934.1 3935.2 3936.1 5420.9 5460.5 5471.5 5474.4 5478.6 5842.2 5861.8 5862.4 5869.1 5885.4 5533.6 5566.2 5590.9 5618.4 5634.1 4966.4 4966.6 4973.0 4973.9 5014.6 6010.2 6017.5 6136.6 6245.8 6257.2 5785.1 5858.2 5897.6 5912.2 5957.8 6085.5 6096.7 6130.0 6133.3 6138.5 5597.6 5656.8 5810.4 5834.4 5837.7 5867.2 5906.9 5909.4 5980.4 6023.2 5766.7 5767.3 5832.4 5836.1 5841.2 5611.4 5804.0 5810.7 5813.3 5816.4 5602.3 5730.5 5744.3 5747.4 5839.7 5826.0 5852.3 5856.2 5868.9 5877.4 5704.9 5706.8 5722.3 5728.2 5729.7 09:33:31 INFO - PROCESS | 27611 | 09:33:31 INFO - PROCESS | 27611 | [#1] ext.html Cycles:180 Average:61162.58 Median:37352.13 stddev:124598.84 (333.6%) stddev-sans-first:124865.26 09:33:31 INFO - PROCESS | 27611 | Values: 548.3 559.5 569.4 588.1 595.9 40926.0 42427.4 42747.1 46099.8 46382.5 44085.6 44784.3 44817.8 44826.1 44847.0 8766.1 9023.8 9038.6 10274.5 10525.8 10468.3 10521.1 10534.3 10552.2 10584.2 10584.6 10596.4 10663.3 10666.5 10680.7 10469.5 10501.3 10504.2 10534.0 10561.7 10387.8 10401.1 10452.1 10452.3 10460.9 38702.4 39294.4 39299.4 39383.2 39536.2 4102.8 4141.2 4180.5 4214.3 4214.7 29748.3 29956.4 30489.5 30762.5 31357.5 4328.4 4412.6 4420.8 4423.3 4453.6 338527.0 341176.0 341673.0 341832.0 343155.0 51742.0 51854.2 51907.0 52223.7 52237.2 54688.2 54961.5 54972.2 55228.4 55360.0 14209.4 14556.3 14584.3 14675.8 14682.6 10258.6 10427.2 10457.5 10616.7 10704.2 17253.7 17357.8 17382.4 17439.7 17529.5 6788.8 7044.5 7080.5 7103.9 7187.3 909.9 911.2 911.4 917.3 923.5 29704.0 29732.3 30190.8 30619.2 30832.4 1056.5 1072.8 1084.9 1093.6 1174.3 15947.1 16400.6 16484.9 16514.2 16681.0 543774.0 546157.0 546373.0 546738.0 547745.0 59689.7 60508.7 60604.4 60823.0 60969.7 1325.7 1373.6 1375.6 1381.3 1384.9 28661.6 28922.1 29225.4 29678.4 31081.7 50420.5 51066.7 51214.2 51228.7 51370.0 490492.0 491994.0 496049.0 496769.0 497807.0 38408.0 39497.8 39866.2 40053.6 40094.6 41807.0 43708.3 43983.3 44294.0 44366.0 34022.5 36845.8 37041.4 37173.3 37556.1 36602.8 36622.5 36766.8 37850.0 37946.0 36560.5 36888.4 37531.0 37769.6 37878.4 31256.7 33268.5 33715.3 33934.2 34034.1 25504.0 25597.5 25945.1 25961.2 26237.7 09:33:31 INFO - PROCESS | 27611 | 09:33:31 INFO - PROCESS | 27611 | [#2] jquery.html Cycles:180 Average:25857.55 Median:393572.50 stddev:65089.45 (16.5%) stddev-sans-first:65243.98 09:33:31 INFO - PROCESS | 27611 | Values: 400.3 412.9 413.8 416.5 433.1 15960.7 18250.2 18506.6 19016.0 19195.8 18912.3 19033.4 19545.2 19916.6 19999.3 5405.1 5464.3 5662.9 5670.3 5692.2 5613.1 5686.9 5688.1 5697.5 5698.7 5465.2 5566.7 5595.5 5597.9 5605.3 5462.4 5568.6 5580.9 5621.4 5629.4 5062.7 5093.7 5099.4 5108.2 5114.6 20633.6 20724.0 21138.5 22714.8 22826.7 2713.4 2742.4 2750.4 2756.6 2757.4 13729.5 14299.4 14384.6 14753.1 14947.0 1985.1 2014.6 2104.0 2123.7 2174.1 77912.0 77987.6 79221.6 80503.6 80644.0 11048.8 11159.3 11223.7 11518.2 11811.2 12244.2 15660.0 15710.1 15721.7 15726.3 5945.6 6102.3 6131.2 6513.0 7448.8 6953.8 7005.5 7008.5 7242.6 7273.3 4069.2 4127.9 4175.7 4189.4 4259.6 1974.4 2016.3 2034.9 2041.6 2064.2 818.3 838.8 844.4 846.8 855.7 17578.0 17711.0 18220.3 18424.6 18684.2 845.2 847.7 859.9 864.3 871.0 9782.5 10268.4 10598.4 10651.0 10715.0 386336.0 389316.0 392226.0 394919.0 395532.0 81374.0 81964.6 83194.2 95312.5 97903.0 1057.0 1082.6 1108.0 1111.4 1121.1 16875.7 16926.4 17357.6 17706.2 17736.9 38666.0 39803.2 40275.0 40380.4 40923.0 53563.0 55455.7 55586.4 55800.0 56448.2 8422.7 8632.6 8693.8 8730.6 8789.9 9340.2 11464.8 12334.4 12454.0 13412.2 11296.6 11562.8 11625.7 11625.9 11824.4 11515.6 11548.5 11559.4 11719.8 11861.9 11647.5 11785.5 11798.9 11971.9 12155.9 8252.7 8444.7 8670.9 8686.4 8753.6 9477.3 11606.0 11736.4 11830.6 12131.2 09:33:31 INFO - PROCESS | 27611 | 09:33:31 INFO - PROCESS | 27611 | [#3] mootools.html Cycles:180 Average:5585.88 Median:5278.55 stddev:3043.25 (57.7%) stddev-sans-first:3035.46 09:33:31 INFO - PROCESS | 27611 | Values: 1391.7 1395.7 1410.4 1411.6 1412.4 8107.3 8341.6 8540.1 8555.1 8629.9 8406.7 8639.4 8669.3 8672.8 8685.7 2347.7 2356.8 2363.2 2376.3 2378.0 2356.8 2408.0 2415.7 2422.9 2423.0 2312.2 2338.0 2352.4 2361.2 2366.8 2327.5 2347.9 2372.2 2379.2 2390.8 2294.8 2359.2 2360.4 2411.0 2411.6 8628.0 8637.9 8705.8 8719.4 8728.2 5265.8 5370.5 5391.2 5401.0 5412.8 3534.2 3541.4 3592.0 3612.1 3643.3 1307.7 1361.7 1438.2 1470.6 1548.9 10966.3 11288.5 11375.8 11491.1 11681.1 4527.8 4555.6 4716.9 4719.8 4738.7 9400.3 9428.2 9469.7 9471.4 9485.3 5291.3 5317.5 5357.3 5394.4 5398.9 4812.9 4949.1 4964.5 5050.7 5055.0 3770.5 3854.2 3862.7 3912.1 3949.3 1195.5 1196.8 1204.8 1207.0 1212.1 932.7 949.1 951.6 955.6 957.4 5565.4 5749.5 5757.0 5902.7 5999.0 581.7 582.4 584.9 585.2 586.4 3650.9 3779.5 4081.1 4089.6 4113.4 10003.4 10198.0 10222.1 10239.3 10239.5 10121.2 10136.0 10200.1 10220.5 10223.8 7528.5 7826.1 7870.5 7917.2 7967.9 5632.0 5871.5 5881.7 5909.0 5957.9 9022.5 9047.6 9055.1 9071.0 9164.7 9136.4 9136.4 9137.5 9208.8 9258.6 7343.1 7503.8 7537.1 7622.9 7713.3 8385.3 8403.7 8406.0 8431.9 8436.4 7509.1 7525.7 7560.5 7641.0 7813.8 7271.0 7281.4 7309.4 7313.4 7398.0 6399.5 6488.0 6505.3 6513.5 6518.2 4935.7 4941.2 4970.4 4976.9 5153.3 4903.5 4923.7 4946.5 4991.2 5036.6 09:33:31 INFO - PROCESS | 27611 | 09:33:31 INFO - PROCESS | 27611 | [#4] prototype.html Cycles:180 Average:4789.07 Median:5387.15 stddev:1372.25 (25.5%) stddev-sans-first:1335.93 09:33:31 INFO - PROCESS | 27611 | Values: 397.4 397.8 401.6 404.1 409.8 5400.9 5412.7 5444.5 5515.6 5530.6 5223.0 5334.3 5377.2 5391.4 5409.4 4265.4 4271.1 4282.6 4303.3 4324.7 4272.7 4298.9 4300.9 4303.4 4316.7 4132.9 4228.9 4249.7 4295.6 4318.7 4231.2 4236.6 4248.9 4273.2 4275.2 3825.5 3854.4 3877.3 3885.3 3892.1 5156.4 5254.6 5263.6 5347.1 5357.6 4887.0 4978.3 4980.5 4985.9 4993.1 5631.9 5643.4 5652.7 5695.5 5708.6 4060.4 4208.8 4224.4 4235.7 4249.7 5686.5 5844.2 5860.3 5876.9 5928.6 4074.5 4140.2 4144.7 4147.7 4151.9 4193.7 4214.7 4222.3 4229.9 4230.7 4732.0 4787.7 4788.3 4814.9 4830.1 5662.6 5675.6 5698.5 5698.5 5724.9 1505.9 1506.4 1514.5 1515.1 1521.1 1028.6 1094.7 1108.3 1111.5 1113.3 5298.6 5323.4 5331.4 5353.4 5382.9 5582.4 5584.7 5588.0 5600.8 5658.5 5229.9 5273.2 5286.0 5516.9 5551.6 2966.5 2998.4 2999.7 3011.0 3020.7 5712.3 5938.6 5942.3 5965.8 6025.7 5770.5 5779.7 5794.7 5813.9 5834.3 5849.7 5887.2 5897.6 5900.9 5915.8 5472.2 5638.5 5654.6 5771.6 5798.6 5726.6 5753.0 5770.1 5794.3 5795.5 5967.7 6019.9 6023.0 6070.5 6159.0 4149.8 4167.2 4172.8 4179.6 4181.5 5733.9 5887.1 5889.4 5910.4 5961.5 5636.6 5682.7 5698.4 5707.9 5724.9 5678.8 5740.2 5751.4 5782.5 5796.7 5498.3 5647.9 5676.6 5699.9 5776.9 5701.8 5704.7 5713.6 5740.0 5756.1 5578.6 5578.8 5584.3 5613.0 5616.2 09:33:31 INFO - PROCESS | 27611 | 09:33:31 INFO - PROCESS | 27611 | [#5] yui.html Cycles:180 Average:17436.99 Median:4397.65 stddev:22508.80 (511.8%) stddev-sans-first:22537.00 09:33:31 INFO - PROCESS | 27611 | Values: 733.3 760.6 786.4 839.5 840.7 14449.1 15191.6 15672.1 15741.1 16535.8 12465.8 13266.0 13275.5 13334.4 13459.7 805.8 824.5 824.6 826.0 826.7 786.7 786.8 788.8 789.3 789.5 862.7 863.3 865.7 865.9 867.6 856.2 857.0 858.2 860.8 861.3 625.8 626.1 627.4 634.3 635.2 13330.2 13554.2 13706.3 13858.4 13882.9 12750.2 12800.4 13265.9 13363.5 13367.0 12101.9 12222.9 12285.2 12463.9 12559.5 3743.6 3875.8 3882.1 3892.6 3908.4 81226.6 81837.0 82197.2 83963.0 84220.6 11566.8 11657.3 11698.9 11832.7 11881.2 22611.5 23301.7 23321.2 23323.5 23461.8 7598.7 7659.2 7776.9 7844.6 7933.2 4383.5 4411.8 4497.8 4502.3 4515.6 3572.2 3631.9 3635.9 3706.1 3715.2 640.1 644.9 647.0 655.2 655.7 725.3 730.9 746.9 769.4 793.5 8850.5 9346.7 9430.6 9600.2 9634.8 718.8 740.1 741.2 741.2 746.4 4213.1 4430.3 4451.0 4463.3 4498.6 79302.0 79931.6 80223.6 80552.2 81155.6 69796.3 69867.3 70320.0 71003.3 72624.3 53762.5 61189.0 61878.4 62148.0 62775.0 9834.0 10006.9 10101.9 10277.4 10300.4 36581.0 36875.6 37740.0 38978.6 42544.0 44738.6 45701.3 52324.5 53050.0 54126.0 12466.2 12483.5 12686.2 12863.4 13001.2 14691.5 14792.7 14812.8 14818.9 14864.4 13949.4 13983.7 14486.3 14539.6 14729.4 13785.8 13855.0 13894.7 14525.3 15051.6 12624.9 12844.9 13265.8 13770.5 13780.5 11110.8 11613.1 11801.5 11924.2 12283.8 10481.8 10830.7 11080.7 11082.8 11087.5 09:33:31 INFO - PROCESS | 27611 | -------- Summary: end -------- 09:33:31 INFO - PROCESS | 27611 | 09:33:31 INFO - TEST-INFO | 27611: exit 0 09:33:31 INFO - TEST-OK | dromaeo_css | took 1114620ms 09:33:31 INFO - TEST-START | kraken 09:33:31 INFO - operating with platform_type : linux_ 09:33:31 INFO - Initialising browser for kraken test... 09:33:31 INFO - TEST-INFO | started process 27969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2dehQ9/profile http://localhost:57215/getInfo.html) 09:33:32 INFO - PROCESS | 27969 | 1483119212332 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 09:33:36 INFO - PROCESS | 27969 | __metrics Screen width/height:1600/1200 09:33:36 INFO - PROCESS | 27969 | colorDepth:24 09:33:36 INFO - PROCESS | 27969 | Browser inner width/height: 1024/697 09:33:36 INFO - PROCESS | 27969 | __metrics 09:33:36 ERROR - PROCESS | 27969 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 09:33:37 INFO - TEST-INFO | 27969: exit 0 09:33:37 INFO - Browser initialized. 09:33:37 INFO - Running cycle 1/1 for kraken test... 09:33:37 INFO - TEST-INFO | started process 28092 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2dehQ9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:49 INFO - PROCESS | 28092 | RSS: Main: 154402816 09:33:49 INFO - PROCESS | 28092 | 09:33:52 INFO - PROCESS | 28092 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57215/tests/kraken/driver.html?testName=audio-beat-detection) 09:33:53 INFO - PROCESS | 28092 | RSS: Main: 160526336 09:33:53 INFO - PROCESS | 28092 | 09:33:55 INFO - PROCESS | 28092 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57215/tests/kraken/driver.html?testName=audio-dft) 09:33:56 INFO - PROCESS | 28092 | RSS: Main: 160317440 09:33:56 INFO - PROCESS | 28092 | 09:33:59 INFO - PROCESS | 28092 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57215/tests/kraken/driver.html?testName=audio-fft) 09:33:59 INFO - PROCESS | 28092 | RSS: Main: 156344320 09:33:59 INFO - PROCESS | 28092 | 09:34:02 INFO - PROCESS | 28092 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57215/tests/kraken/driver.html?testName=audio-oscillator) 09:34:02 INFO - PROCESS | 28092 | RSS: Main: 156913664 09:34:02 INFO - PROCESS | 28092 | 09:34:04 INFO - PROCESS | 28092 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57215/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:34:05 INFO - PROCESS | 28092 | RSS: Main: 157401088 09:34:05 INFO - PROCESS | 28092 | 09:34:08 INFO - PROCESS | 28092 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57215/tests/kraken/driver.html?testName=imaging-darkroom) 09:34:09 INFO - PROCESS | 28092 | RSS: Main: 161378304 09:34:09 INFO - PROCESS | 28092 | 09:34:12 INFO - PROCESS | 28092 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57215/tests/kraken/driver.html?testName=imaging-desaturate) 09:34:13 INFO - PROCESS | 28092 | RSS: Main: 159727616 09:34:13 INFO - PROCESS | 28092 | 09:34:15 INFO - PROCESS | 28092 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57215/tests/kraken/driver.html?testName=json-parse-financial) 09:34:16 INFO - PROCESS | 28092 | RSS: Main: 160706560 09:34:16 INFO - PROCESS | 28092 | 09:34:18 INFO - PROCESS | 28092 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57215/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:34:18 INFO - PROCESS | 28092 | RSS: Main: 159612928 09:34:18 INFO - PROCESS | 28092 | 09:34:20 INFO - PROCESS | 28092 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57215/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:34:21 INFO - PROCESS | 28092 | RSS: Main: 160149504 09:34:21 INFO - PROCESS | 28092 | 09:34:23 INFO - PROCESS | 28092 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57215/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:34:24 INFO - PROCESS | 28092 | RSS: Main: 160423936 09:34:24 INFO - PROCESS | 28092 | 09:34:26 INFO - PROCESS | 28092 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:34:27 INFO - PROCESS | 28092 | RSS: Main: 160354304 09:34:27 INFO - PROCESS | 28092 | 09:34:30 INFO - PROCESS | 28092 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:34:30 INFO - PROCESS | 28092 | RSS: Main: 160636928 09:34:30 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | Cycle 1(1): loaded http://localhost:57215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57215/tests/kraken/driver.html?testName=ai-astar) 09:34:32 INFO - PROCESS | 28092 | RSS: Main: 161931264 09:34:32 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | __start_tp_report 09:34:32 INFO - PROCESS | 28092 | _x_x_mozilla_page_load 09:34:32 INFO - PROCESS | 28092 | _x_x_mozilla_page_load_details 09:34:32 INFO - PROCESS | 28092 | |i|pagename|runs| 09:34:32 INFO - PROCESS | 28092 | |0;ai-astar;104;110;110;111;111;111;110;110;111;109 09:34:32 INFO - PROCESS | 28092 | |1;audio-beat-detection;149;124;126;159;121;123;123;126;142;130 09:34:32 INFO - PROCESS | 28092 | |2;audio-dft;162;164;164;164;164;163;168;162;164;163 09:34:32 INFO - PROCESS | 28092 | |3;audio-fft;76;76;77;114;78;76;79;76;93;79 09:34:32 INFO - PROCESS | 28092 | |4;audio-oscillator;83;83;104;82;84;83;94;84;83;105 09:34:32 INFO - PROCESS | 28092 | |5;imaging-gaussian-blur;118;118;118;119;117;117;118;118;117;122 09:34:32 INFO - PROCESS | 28092 | |6;imaging-darkroom;148;147;147;148;148;148;147;147;151;150 09:34:32 INFO - PROCESS | 28092 | |7;imaging-desaturate;100;98;96;96;96;96;96;97;96;96 09:34:32 INFO - PROCESS | 28092 | |8;json-parse-financial;58;58;57;56;59;57;59;58;58;61 09:34:32 INFO - PROCESS | 28092 | |9;json-stringify-tinderbox;68;69;70;68;68;66;69;67;67;68 09:34:32 INFO - PROCESS | 28092 | |10;stanford-crypto-aes;86;93;85;83;83;88;85;81;82;81 09:34:32 INFO - PROCESS | 28092 | |11;stanford-crypto-ccm;130;131;126;136;126;127;132;125;172;129 09:34:32 INFO - PROCESS | 28092 | |12;stanford-crypto-pbkdf2;175;166;167;166;171;168;167;168;164;163 09:34:32 INFO - PROCESS | 28092 | |13;stanford-crypto-sha256-iterative;64;63;64;63;62;62;64;63;63;62 09:34:32 INFO - PROCESS | 28092 | __end_tp_report 09:34:32 INFO - PROCESS | 28092 | __start_cc_report 09:34:32 INFO - PROCESS | 28092 | _x_x_mozilla_cycle_collect,740 09:34:32 INFO - PROCESS | 28092 | __end_cc_report 09:34:32 INFO - PROCESS | 28092 | __startTimestamp1483119272757__endTimestamp 09:34:32 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | ------- Summary: start ------- 09:34:32 INFO - PROCESS | 28092 | Number of tests: 14 09:34:32 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.11 (1.9%) stddev-sans-first:0.71 09:34:32 INFO - PROCESS | 28092 | Values: 104.0 110.0 110.0 111.0 111.0 111.0 110.0 110.0 111.0 109.0 09:34:32 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:128.00 stddev:13.08 (10.2%) stddev-sans-first:12.40 09:34:32 INFO - PROCESS | 28092 | Values: 149.0 124.0 126.0 159.0 121.0 123.0 123.0 126.0 142.0 130.0 09:34:32 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.69 (1.0%) stddev-sans-first:1.66 09:34:32 INFO - PROCESS | 28092 | Values: 162.0 164.0 164.0 164.0 164.0 163.0 168.0 162.0 164.0 163.0 09:34:32 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | [#3] audio-fft Cycles:10 Average:82.40 Median:77.50 stddev:12.23 (15.8%) stddev-sans-first:12.75 09:34:32 INFO - PROCESS | 28092 | Values: 76.0 76.0 77.0 114.0 78.0 76.0 79.0 76.0 93.0 79.0 09:34:32 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | [#4] audio-oscillator Cycles:10 Average:88.50 Median:83.00 stddev:9.11 (11.0%) stddev-sans-first:9.44 09:34:32 INFO - PROCESS | 28092 | Values: 83.0 83.0 104.0 82.0 84.0 83.0 94.0 84.0 83.0 105.0 09:34:32 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.48 (1.3%) stddev-sans-first:1.56 09:34:32 INFO - PROCESS | 28092 | Values: 118.0 118.0 118.0 119.0 117.0 117.0 118.0 118.0 117.0 122.0 09:34:32 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.37 (0.9%) stddev-sans-first:1.45 09:34:32 INFO - PROCESS | 28092 | Values: 148.0 147.0 147.0 148.0 148.0 148.0 147.0 147.0 151.0 150.0 09:34:32 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.34 (1.4%) stddev-sans-first:0.71 09:34:32 INFO - PROCESS | 28092 | Values: 100.0 98.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 09:34:32 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:1.37 (2.4%) stddev-sans-first:1.45 09:34:32 INFO - PROCESS | 28092 | Values: 58.0 58.0 57.0 56.0 59.0 57.0 59.0 58.0 58.0 61.0 09:34:32 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:1.15 (1.7%) stddev-sans-first:1.22 09:34:32 INFO - PROCESS | 28092 | Values: 68.0 69.0 70.0 68.0 68.0 66.0 69.0 67.0 67.0 68.0 09:34:32 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.00 stddev:3.68 (4.3%) stddev-sans-first:3.88 09:34:32 INFO - PROCESS | 28092 | Values: 86.0 93.0 85.0 83.0 83.0 88.0 85.0 81.0 82.0 81.0 09:34:32 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:130.50 stddev:13.97 (10.7%) stddev-sans-first:14.76 09:34:32 INFO - PROCESS | 28092 | Values: 130.0 131.0 126.0 136.0 126.0 127.0 132.0 125.0 172.0 129.0 09:34:32 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:167.50 stddev:3.44 (2.1%) stddev-sans-first:2.35 09:34:32 INFO - PROCESS | 28092 | Values: 175.0 166.0 167.0 166.0 171.0 168.0 167.0 168.0 164.0 163.0 09:34:32 INFO - PROCESS | 28092 | 09:34:32 INFO - PROCESS | 28092 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 09:34:32 INFO - PROCESS | 28092 | Values: 64.0 63.0 64.0 63.0 62.0 62.0 64.0 63.0 63.0 62.0 09:34:32 INFO - PROCESS | 28092 | -------- Summary: end -------- 09:34:32 INFO - PROCESS | 28092 | 09:34:33 INFO - TEST-INFO | 28092: exit 0 09:34:33 INFO - TEST-OK | kraken | took 61981ms 09:34:33 INFO - SUITE-END | took 1176s 09:34:33 INFO - Completed test suite (00:19:36) 09:34:33 INFO - javascript benchmark 09:34:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7184.595997255424, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3183.2360233543955, 3226.887058952937, 3229.5640088588034, 3247.967520324799, 3252.0894149638093, 5336.439673834249, 5438.238646589481, 5470.8085217017415, 5476.205950137228, 5533.391326954032, 5377.0, 5414.458554144584, 5416.0, 5488.121900495921, 5497.147942068976, 4879.170541008019, 4908.877278068059, 4963.4540200578085, 4988.301637770715, 5008.173651347523, 4878.219484882419, 5003.524665156804, 5042.294078828967, 5061.0, 5061.519155680205, 4877.463479017305, 4898.559129678346, 4997.42529609096, 5036.269740887569, 5037.697738135724, 4890.315355850184, 4897.461279259279, 4902.411710594716, 4955.776990035457, 4986.950130498685, 4911.975440122812, 4914.606831453475, 4914.803407863681, 4932.136876046678, 4961.355023846912, 5334.146536554133, 5389.487998640123, 5428.267183930158, 5473.616846820724, 5495.670259784386, 5790.826275211751, 5804.622699524517, 5805.767769289266, 5837.474627283523, 5926.051831706949, 5839.240898683144, 5878.911816322759, 5899.882002359972, 5901.3803550627, 5911.763529458816, 5499.312585926759, 5504.504594586507, 5508.697021663847, 5510.476504732044, 5511.944880551223, 5919.881602367928, 5982.910256346158, 5998.550108741862, 6009.579329446984, 6018.969905150446, 5765.0, 5794.391588883106, 5806.680632565165, 5813.680247586339, 5856.267966504187, 5883.882322353529, 5910.143029260819, 5911.527077833763, 5916.112583112567, 5919.141724450017, 5507.201455788968, 5612.831615051555, 5618.522425593788, 5667.688277144796, 5690.601657883908, 5703.344115426779, 5704.030314846486, 5705.600607957404, 5708.4862362387585, 5710.3433105193435, 4342.478902531717, 4351.782410879443, 4353.782310884443, 4353.782310884443, 4359.411479450297, 3910.061585219527, 3931.3906344516645, 3934.09515811365, 3935.153941902505, 3936.0946982194255, 5420.942916131396, 5460.481254280837, 5471.4528547145765, 5474.42518535556, 5478.58910581708, 5842.182094506772, 5861.765529378862, 5862.413758624103, 5869.090291004815, 5885.352611212763, 5533.557315414757, 5566.165075238666, 5590.91613625796, 5618.353889302701, 5634.098544232985, 4966.354373931365, 4966.553010229024, 4973.030259099513, 4973.875653108701, 5014.573761230264, 6010.248718910224, 6017.518598512109, 6136.631802091889, 6245.843853903689, 6257.186565746515, 5785.132230165341, 5858.209141765807, 5897.5576831736935, 5912.201852749824, 5957.761689532544, 6085.482733967662, 6096.664683442454, 6130.0, 6133.294671112879, 6138.478229350555, 5597.63615365, 5656.773729050792, 5810.4189581041555, 5834.38738932423, 5837.737301821343, 5867.20792692998, 5906.940930590639, 5909.3795151508475, 5980.401959803985, 6023.216981792339, 5766.682832444256, 5767.279090113736, 5832.416758324133, 5836.124581312837, 5841.1530328101335, 5611.354694210055, 5803.970980145073, 5810.709464526842, 5813.302403711582, 5816.3892791258, 5602.2717046783655, 5730.484256416942, 5744.339400968942, 5747.396523364986, 5839.708014599338, 5826.0, 5852.268466441695, 5856.180134781219, 5868.911966320423, 5877.4122587740885, 5704.942950570441, 5706.771729130788, 5722.341930678025, 5728.198052272602, 5729.656220626775], "value": 5394.60849105109, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.268062137047, 559.5467671186337, 569.4476357932804, 588.0708480600651, 595.8718875441781, 40926.0, 42427.36358954614, 42747.14505709888, 46099.76950115253, 46382.53617463824, 44085.559144408544, 44784.3282350765, 44817.7759111204, 44826.103477930425, 44847.0, 8766.123387661231, 9023.774405639879, 9038.593263303133, 10274.486275686224, 10525.789484210349, 10468.319559228665, 10521.105706014998, 10534.26260161789, 10552.15582753378, 10584.1532677386, 10584.576616935314, 10596.364218146897, 10663.306885052485, 10666.466676666174, 10680.732981675443, 10469.528871200815, 10501.264911456201, 10504.159667226642, 10534.0, 10561.73595660107, 10387.792244155075, 10401.063904248578, 10452.111570516516, 10452.32059916103, 10460.895391046068, 38702.419463708065, 39294.410583841265, 39299.41050884239, 39383.21233575341, 39536.20927581461, 4102.815373308208, 4141.233871733709, 4180.498340199196, 4214.346776249687, 4214.704970652056, 29748.256293592833, 29956.400871982438, 30489.542656859943, 30762.53856192159, 31357.52963705546, 4328.4156638853665, 4412.624926881219, 4420.8452704155525, 4423.336499525065, 4453.621442177418, 338527.0, 341176.0, 341673.0, 341831.9999999975, 343155.0, 51742.0, 51854.22218666723, 51907.0, 52223.73888130611, 52237.21644175341, 54688.17967730408, 54961.450385496435, 54972.17541736877, 55228.447715523136, 55360.0, 14209.36057877398, 14556.272186390637, 14584.270786460635, 14675.779863301845, 14682.632934176518, 10258.58965641381, 10427.217958653131, 10457.477126143662, 10616.681499555025, 10704.19718521114, 17253.741193882102, 17357.826421735874, 17382.391616293367, 17439.73840392395, 17529.474115776546, 6788.76239331621, 7044.471664625174, 7080.468964827659, 7103.896103896104, 7187.31720486553, 909.949952752605, 911.2072496927715, 911.3620465674055, 917.3165991336364, 923.5151545438698, 29704.0, 29732.256693582833, 30190.849045754632, 30619.2345191372, 30832.38335233283, 1056.5456853553046, 1072.7556034999363, 1084.8535447714614, 1093.6336327330275, 1174.301290732013, 15947.09296222433, 16400.589985250226, 16484.917575412284, 16514.174291285388, 16681.0, 543774.0, 546157.0, 546373.0, 546738.0, 547745.0, 59689.70155149196, 60508.69745651243, 60604.393956060754, 60823.0, 60969.695151523956, 1325.6818363592668, 1373.622253880191, 1375.6354566040006, 1381.3093453273364, 1384.8892088632886, 28661.570076449287, 28922.132336029954, 29225.415491689622, 29678.40643187081, 31081.689183108785, 50420.49579504305, 51066.744666276434, 51214.231786523975, 51228.74385628048, 51370.0, 490492.0, 491994.0, 496049.0, 496769.0, 497807.0, 38408.0, 39497.80251098726, 39866.2026759469, 40053.599464006154, 40094.59905401025, 41807.0, 43708.34437483504, 43983.340249895635, 44294.0, 44366.0, 34022.48966265558, 36845.81577092098, 37041.44437833381, 37173.25653486861, 37556.06109847166, 36602.81698591597, 36622.45066323954, 36766.816165919, 37850.0, 37946.0, 36560.45159322559, 36888.44667329938, 37531.0, 37769.62230377661, 37878.431823522114, 31256.68743312538, 33268.50097248592, 33715.3256934855, 33934.151646208054, 34034.14914627055, 25504.0, 25597.488050238517, 25945.07043661698, 25961.221163365128, 26237.73762262353], "value": 19980.905966665072, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.3474336830967, 412.8885200995731, 413.79723935271727, 416.51268016420795, 433.09915376017887, 15960.680786384266, 18250.17874195661, 18506.629867402644, 19016.04919754012, 19195.808041919576, 18912.338068167617, 19033.428997130108, 19545.21819127233, 19916.60166796663, 19999.300024499145, 5405.081136206844, 5464.316960379952, 5662.943370566303, 5670.291213598301, 5692.203091567184, 5613.129964855433, 5686.914696279559, 5688.146777983315, 5697.515711164556, 5698.743556539945, 5465.180222966547, 5566.666000039991, 5595.468430499096, 5597.8600534986745, 5605.27131472908, 5462.371827239839, 5568.582356323252, 5580.944190558083, 5621.353544342412, 5629.408912064236, 5062.7468626568525, 5093.719845408501, 5099.36257967754, 5108.208227724708, 5114.616403769732, 20633.58732825335, 20724.0, 21138.471538211514, 22714.77285227143, 22826.65760013601, 2713.4166154276927, 2742.4103817679293, 2750.4499100179846, 2756.6140740296373, 2757.352022274764, 13729.519466818714, 14299.356528956117, 14384.64038399038, 14753.11481311114, 14947.0, 1985.1364656374378, 2014.5769388428448, 2103.974561215808, 2123.7363768557684, 2174.097749433983, 77912.0, 77987.61006194932, 79221.60389198133, 80503.5974820128, 80644.0, 11048.834267485994, 11159.330440173615, 11223.71940701489, 11518.193726439236, 11811.173217874839, 12244.204126731735, 15660.0, 15710.057396556243, 15721.663658589148, 15726.29231684577, 5945.583809133319, 6102.298235702862, 6131.172291740647, 6513.0, 7448.776536703907, 6953.79138625842, 7005.54463959841, 7008.544444611084, 7242.601656908815, 7273.27267273279, 4069.1861627673993, 4127.9174416511505, 4175.728577642443, 4189.371594260885, 4259.637930775919, 1974.3682021753189, 2016.2539860251507, 2034.9186032558532, 2041.57127003328, 2064.1846470644014, 818.3289702443939, 838.828040251747, 844.3751623798468, 846.754441212054, 855.7261676263536, 17578.0, 17711.0, 18220.271189152285, 18424.631507370046, 18684.159212835184, 845.2139510255521, 847.6694089305176, 859.8925134358205, 864.3042350907455, 871.0462044061742, 9782.510874456391, 10268.43523606194, 10598.364098154136, 10651.0, 10715.0, 386336.0, 389316.0, 392226.0, 394919.0, 395532.0, 81374.0, 81964.59017704874, 83194.16805831985, 95312.52343738236, 97903.0, 1056.963006294776, 1082.621082621092, 1108.036008672444, 1111.4331690837569, 1121.1031175060082, 16875.662486750443, 16926.40757573479, 17357.56606084858, 17706.203220854833, 17736.91131544334, 38666.0, 39803.2039359217, 40275.0, 40380.394294085025, 40923.0, 53563.0, 55455.72272138613, 55586.44413555813, 55800.0, 56448.15327770005, 8422.663093476438, 8632.568371581521, 8693.782655433664, 8730.56347182651, 8789.91210087891, 9340.206082483064, 11464.828027579426, 12334.444949977093, 12454.0, 13412.195268283544, 11296.6046188383, 11562.76874462523, 11625.6512304631, 11625.88374116282, 11824.40877956116, 11515.596954106566, 11548.48031838586, 11559.422028898352, 11719.769424210335, 11861.881381186078, 11647.534098635959, 11785.469653865424, 11798.941005294919, 11971.940140299592, 12155.939220303842, 8252.711155109542, 8444.746657600283, 8670.869936950825, 8686.435381700168, 8753.562321884008, 9477.336586439158, 11606.0, 11736.413179341169, 11830.645080647595, 12131.150819442908], "value": 8987.86329559327, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.7425276323881, 1395.727833072551, 1410.4005797536045, 1411.6047506698121, 1412.3714946848643, 8107.310878575321, 8341.62462689179, 8540.060593334729, 8555.144485551442, 8629.870551941725, 8406.705765298217, 8639.352048596365, 8669.263112635434, 8672.826543469128, 8685.652573897036, 2347.694799676044, 2356.823238257129, 2363.243761996162, 2376.310869847751, 2377.9762202378015, 2356.8114550835894, 2408.0488207158164, 2415.710114786228, 2422.9394265143337, 2422.9878850605724, 2312.190733243368, 2337.9766202338014, 2352.4001379648166, 2361.161787565415, 2366.7869891709743, 2327.464683122883, 2347.94130146746, 2372.229025566689, 2379.238643634038, 2390.820688448356, 2294.7705229477087, 2359.2214569192297, 2360.362702070431, 2411.0114852910397, 2411.638254261857, 8628.0, 8637.870431943526, 8705.7823554411, 8719.389642725011, 8728.170823771732, 5265.76304066318, 5370.5435038021815, 5391.218273350342, 5401.0, 5412.810551630713, 3534.151803567151, 3541.3979623463815, 3591.964080359189, 3612.060864175307, 3643.344198044351, 1307.7123032932739, 1361.7276544691101, 1438.2449214162543, 1470.6176394137494, 1548.9457868974644, 10966.287191332618, 11288.492017859217, 11375.772484550345, 11491.138164637601, 11681.123915706272, 4527.7736113194205, 4555.6083056395655, 4716.9292460613115, 4719.764011799396, 4738.715677059318, 9400.341976061747, 9428.198603118812, 9469.715908522756, 9471.384360016576, 9485.288603354638, 5291.3385826771655, 5317.468253174729, 5357.303550538405, 5394.352677678704, 5398.946010539923, 4812.879678008007, 4949.1091603510995, 4964.503549645006, 5050.747462626854, 5054.974725126424, 3770.547534295902, 3854.1520865409566, 3862.6909847212155, 3912.1002169501176, 3949.328614135604, 1195.5217912834935, 1196.7606478704295, 1204.753025629744, 1207.0464333176867, 1212.1333246728632, 932.6735642525198, 949.1362859797551, 951.6383774165772, 955.5890966884307, 957.4494665567327, 5565.359983601857, 5749.453801888814, 5756.971215143897, 5902.734376953047, 5999.01016332309, 581.6713556840372, 582.3594046548847, 584.8742520358144, 585.2041223935445, 586.4106572894214, 3650.872219472306, 3779.527559055118, 4081.10215752534, 4089.6114869087983, 4113.424120623115, 10003.44981026036, 10198.0, 10222.13111885498, 10239.334443261165, 10239.539220735085, 10121.240906931862, 10136.0, 10200.132988696045, 10220.540075696463, 10223.795524089477, 7528.473006889465, 7826.1391246962785, 7870.527768333804, 7917.247861453153, 7967.920320796834, 5632.0, 5871.500922421642, 5881.705914704162, 5909.0, 5957.851053723692, 9022.458652480873, 9047.638094476148, 9055.094490550891, 9070.954645226731, 9164.725058248263, 9136.360454768102, 9136.406133601295, 9137.497437640994, 9208.769780755534, 9258.629654814002, 7343.082114735658, 7503.8499230014, 7537.095548534211, 7622.885656715264, 7713.344365728976, 8385.32917366597, 8403.70587029451, 8406.0, 8431.915680843113, 8436.409451338593, 7509.136449308181, 7525.736599219001, 7560.546367217985, 7641.0, 7813.843723125392, 7270.9636451819515, 7281.381082608038, 7309.378702810108, 7313.414926805949, 7398.0, 6399.520035997226, 6488.0, 6505.284418714033, 6513.5114866384265, 6518.185226846645, 4935.728534930613, 4941.209406494943, 4970.409468969895, 4976.869680150779, 5153.252778347193, 4903.485134060872, 4923.729194894315, 4946.530079642428, 4991.226359914219, 5036.647434679538], "value": 4496.796040439929, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.4316727080275, 397.80109945027476, 401.62046865711915, 404.0726532607665, 409.8217275485162, 5400.864978375543, 5412.729363531823, 5444.455554444564, 5515.641483303588, 5530.644991976961, 5222.973885130569, 5334.279872217249, 5377.193420986854, 5391.433899440561, 5409.377921539024, 4265.445492086024, 4271.124419493996, 4282.635975942048, 4303.321704535226, 4324.6972711910175, 4272.722273052257, 4298.914021719564, 4300.935485967713, 4303.3544968254855, 4316.719413238129, 4132.8966775830695, 4228.936565951513, 4249.681273904454, 4295.634871035965, 4318.719283246579, 4231.217224813404, 4236.6187043165955, 4248.874048377183, 4273.188094262096, 4275.230458517465, 3825.483559719458, 3854.383298672227, 3877.3408520551575, 3885.261800257942, 3892.143728379752, 5156.381234251876, 5254.579633629339, 5263.605229607795, 5347.101778868485, 5357.598180136505, 4886.951130488721, 4978.253262010691, 4980.477049909744, 4985.900281994376, 4993.051320249141, 5631.887362252773, 5643.40744221859, 5652.660840349592, 5695.5191650171255, 5708.600397972144, 4060.3706425504092, 4208.768517731523, 4224.38746381776, 4235.745855248695, 4249.745015299092, 5686.516646085046, 5844.1818145459665, 5860.326062502824, 5876.854013467376, 5928.61464004834, 4074.5110586729784, 4140.23405669946, 4144.70987030911, 4147.709660323749, 4151.875443736692, 4193.685473589493, 4214.745111365466, 4222.332178789361, 4229.936550951738, 4230.682698797603, 4731.976340118277, 4787.736674482867, 4788.3056956741075, 4814.855554333376, 4830.106430310404, 5662.5753068520025, 5675.55273405279, 5698.458646428583, 5698.458646428583, 5724.942750572524, 1505.9247037648074, 1506.3823832228734, 1514.4775052606833, 1515.0985513180888, 1521.1253529220521, 1028.6348346337093, 1094.7372630568607, 1108.3128460354633, 1111.4942701070993, 1113.2819331531116, 5298.6290959633225, 5323.40297910633, 5331.44019877915, 5353.447500224969, 5382.865428364322, 5582.358028826656, 5584.748686309126, 5587.966226248157, 5600.831975040755, 5658.519025882763, 5229.947700522946, 5273.235380869753, 5286.0, 5516.889662206733, 5551.611387202938, 2966.5229533339902, 2998.445287621797, 2999.7300242978235, 3010.991317908525, 3020.7432368248506, 5712.314522257356, 5938.584299099108, 5942.296255203872, 5965.791197308074, 6025.698715064229, 5770.480656740913, 5779.682117483579, 5794.681292528951, 5813.854653633693, 5834.299884013945, 5849.6782676952325, 5887.175795388649, 5897.616654917417, 5900.875684753485, 5915.822525324247, 5472.2338872557075, 5638.4925356718095, 5654.6324488908085, 5771.5671324649975, 5798.5651076168615, 5726.599138060295, 5752.9712351437975, 5770.105633626795, 5794.333651629948, 5795.478406943395, 5967.731452084753, 6019.9465093609315, 6022.969885150546, 6070.514358851369, 6158.969205154125, 4149.751014939114, 4167.187398457393, 4172.791360431906, 4179.644730197967, 4181.540030596571, 5733.913991290217, 5887.146363777314, 5889.352171261244, 5910.4089591042275, 5961.509622594352, 5636.605437619327, 5682.744276507485, 5698.4016678249845, 5707.942920570741, 5724.940885936116, 5678.801241956512, 5740.167675687086, 5751.367349591458, 5782.450667186778, 5796.739146738491, 5498.3127109111365, 5647.858803529944, 5676.602637815313, 5699.886002279848, 5776.942230577641, 5701.800436984686, 5704.714764261687, 5713.628614140068, 5739.986507083814, 5756.136579513107, 5578.553715702653, 5578.804741834017, 5584.301962254718, 5612.971935140462, 5616.241807355955], "value": 4377.034970636217, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.2996987876578, 760.6310939194493, 786.3551887452288, 839.5466448118017, 840.743573210171, 14449.133052016887, 15191.620209494768, 15672.059676419394, 15741.134237616941, 16535.834641653593, 12465.750684986295, 13266.005049621268, 13275.468981240763, 13334.399952002159, 13459.730805383886, 805.7824387415394, 824.4558591329724, 824.579464473117, 825.9587020648974, 826.7230477789948, 786.728578640371, 786.7757689058619, 788.7988562916448, 789.2975252025702, 789.5302295134386, 862.7282406042108, 863.2834747159874, 865.6970060478814, 865.9004214515317, 867.557545651719, 856.2037305306063, 856.9528675922821, 858.2490320969152, 860.7503823891064, 861.2593169873903, 625.837282306599, 626.1140486212005, 627.4102343796862, 634.3339493531773, 635.1647583427824, 13330.200187988752, 13554.186748795104, 13706.314684265746, 13858.4456621735, 13882.93058534711, 12750.234985900875, 12800.359982000862, 13265.933670331684, 13363.53227637028, 13367.0, 12101.93949030258, 12222.938885305606, 12285.201461904948, 12463.937680311541, 12559.497620095186, 3743.5882052974152, 3875.8255878485534, 3882.145927895858, 3892.630200130983, 3908.374660054406, 81226.59386703088, 81837.0, 82197.17802821955, 83963.0, 84220.57889710512, 11566.768664626661, 11657.300561966309, 11698.88301116995, 11832.734918966085, 11881.22772019816, 22611.493609665038, 23301.650475242885, 23321.183758568368, 23323.533529329317, 23461.7653823463, 7598.696052157962, 7659.157492675801, 7776.883346749803, 7844.646990885424, 7933.167017463199, 4383.473983122046, 4411.823527058882, 4497.752623605667, 4502.257127573914, 4515.63874890008, 3572.160542272564, 3631.94552081719, 3635.94546081809, 3706.1475860552223, 3715.16408808016, 640.0814830717935, 644.8839208942342, 647.0326861342323, 655.1679367203625, 655.7049327802508, 725.300085417564, 730.8684436801427, 746.9477136600386, 769.3844924060729, 793.5199204481321, 8850.468971861708, 9346.719598412059, 9430.62277508892, 9600.231981441608, 9634.807303853884, 718.7664009196927, 740.1192580828797, 741.1735914455344, 741.2032065529577, 746.358132006474, 4213.136307057046, 4430.335449682509, 4450.977745111319, 4463.330500424962, 4498.572635599613, 79302.0, 79931.60034199792, 80223.59888200522, 80552.19447805564, 81155.5942220285, 69796.30203697897, 69867.3013269871, 70320.0, 71003.2899671007, 72624.27375726281, 53762.46237537575, 61189.0, 61878.38121618726, 62148.0, 62775.0, 9833.950830245803, 10006.949965250127, 10101.898981010096, 10277.383356998604, 10300.433476158583, 36581.0, 36875.63124368722, 37740.0, 38978.61021389863, 42544.0, 44738.55261447344, 45701.314480282155, 52324.47675523196, 53050.0, 54126.0, 12466.189697669623, 12483.500659973499, 12686.238825670489, 12863.356832158543, 13001.15492492985, 14691.485797997018, 14792.704145917236, 14812.777808332668, 14818.925905370405, 14864.40542378336, 13949.3722782473, 13983.720325593635, 14486.275686215859, 14539.563813085624, 14729.410823566937, 13785.793213102012, 13855.0, 13894.722105558034, 14525.346359413641, 15051.623709407353, 12624.936875315932, 12844.935775321064, 13265.80101298462, 13770.518031868836, 13780.517681881087, 11110.833337500106, 11613.070954323464, 11801.468933897824, 11924.165308428326, 12283.754324913272, 10481.842772358574, 10830.67507974762, 11080.722981925193, 11082.833757493805, 11087.501062452047], "value": 7211.99572393994, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 110.0, 111.0, 111.0, 111.0, 110.0, 110.0, 111.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 126.0, 159.0, 121.0, 123.0, 123.0, 126.0, 142.0, 130.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 164.0, 164.0, 163.0, 168.0, 162.0, 164.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 114.0, 78.0, 76.0, 79.0, 76.0, 93.0, 79.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 104.0, 82.0, 84.0, 83.0, 94.0, 84.0, 83.0, 105.0], "value": 88.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 117.0, 117.0, 118.0, 118.0, 117.0, 122.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 151.0, 150.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 56.0, 59.0, 57.0, 59.0, 58.0, 58.0, 61.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 68.0, 68.0, 66.0, 69.0, 67.0, 67.0, 68.0], "value": 68.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 93.0, 85.0, 83.0, 83.0, 88.0, 85.0, 81.0, 82.0, 81.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 131.0, 126.0, 136.0, 126.0, 127.0, 132.0, 125.0, 172.0, 129.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 166.0, 167.0, 166.0, 171.0, 168.0, 167.0, 168.0, 164.0, 163.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 62.0, 62.0, 64.0, 63.0, 63.0, 62.0], "value": 63.0, "unit": "score"}]}]} 09:34:33 INFO - Return code: 0 09:34:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:34:34 ERROR - # TBPL SUCCESS # 09:34:34 INFO - Running post-action listener: _resource_record_post_action 09:34:34 INFO - [mozharness: 2016-12-30 17:34:34.045050Z] Finished run-tests step (success) 09:34:34 INFO - Running post-run listener: _resource_record_post_run 09:34:34 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400310272; Read time: 20; Write time: 281600 09:34:34 INFO - TinderboxPrint: CPU usage
13.4% 09:34:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 09:34:34 INFO - TinderboxPrint: I/O write bytes / time
400,310,272 / 281,600 09:34:34 INFO - TinderboxPrint: CPU idle
8,247.5 (86.6%) 09:34:34 INFO - TinderboxPrint: CPU user
1,218.1 (12.8%) 09:34:34 INFO - TinderboxPrint: Swap in / out
0 / 0 09:34:34 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106786816; Read time: 0; Write time: 71888 09:34:34 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 292691968; Read time: 0; Write time: 209692 09:34:34 INFO - Running post-run listener: _upload_blobber_files 09:34:34 INFO - Blob upload gear active. 09:34:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:34:34 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 09:34:34 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'] 09:34:34 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 09:34:35 INFO - (blobuploader) - INFO - Open directory for files ... 09:34:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:34:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:34:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:35 INFO - (blobuploader) - INFO - Done attempting. 09:34:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:34:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:34:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:36 INFO - (blobuploader) - INFO - Done attempting. 09:34:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:34:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:34:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:37 INFO - (blobuploader) - INFO - Done attempting. 09:34:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:34:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:34:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:41 INFO - (blobuploader) - INFO - Done attempting. 09:34:41 INFO - (blobuploader) - INFO - Iteration through files over. 09:34:41 INFO - Return code: 0 09:34:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:34:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:34:41 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92ddf709d087e0586787b054e43f8929a447dc849b4f9f301f7c763bf0e05f8f781e8b975657cd14c33a30db688b6210421f29561238a2f8507b909457bfa752", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b607982ed3a5e0a700814b3c2e4a075c24f0a7fa9e08b85993a59677b0132213edf71f07e85f42c918cb81de896a503bfbf090ecbca6b8df52cd55ba71f81f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0383b8b20ef94c7970c64550f45ede24e3105b4116f3aa82f2987344007e131a332756b9b4678c16b9dc6f5b5b5a380c4fd9e595370935da778943b2e891d45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12a2153a63cafcc23fc5ffb28f9bb7a5bd20b1521d31fb787ca8249c49ae6bb8f281c50adec8f3dac96cadd52c59165c112cf348291ffe7ec72950f67f2ec4e1"} 09:34:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:34:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:34:41 INFO - Contents: 09:34:41 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92ddf709d087e0586787b054e43f8929a447dc849b4f9f301f7c763bf0e05f8f781e8b975657cd14c33a30db688b6210421f29561238a2f8507b909457bfa752", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b607982ed3a5e0a700814b3c2e4a075c24f0a7fa9e08b85993a59677b0132213edf71f07e85f42c918cb81de896a503bfbf090ecbca6b8df52cd55ba71f81f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0383b8b20ef94c7970c64550f45ede24e3105b4116f3aa82f2987344007e131a332756b9b4678c16b9dc6f5b5b5a380c4fd9e595370935da778943b2e891d45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12a2153a63cafcc23fc5ffb28f9bb7a5bd20b1521d31fb787ca8249c49ae6bb8f281c50adec8f3dac96cadd52c59165c112cf348291ffe7ec72950f67f2ec4e1"} 09:34:41 INFO - Running post-run listener: copy_logs_to_upload_dir 09:34:41 INFO - Copying logs to upload dir... 09:34:41 INFO - mkdir: /builds/slave/test/build/upload/logs 09:34:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.483558 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-30 09:34:40.548123) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 09:34:40.551846) ========= 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=920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92ddf709d087e0586787b054e43f8929a447dc849b4f9f301f7c763bf0e05f8f781e8b975657cd14c33a30db688b6210421f29561238a2f8507b909457bfa752", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b607982ed3a5e0a700814b3c2e4a075c24f0a7fa9e08b85993a59677b0132213edf71f07e85f42c918cb81de896a503bfbf090ecbca6b8df52cd55ba71f81f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0383b8b20ef94c7970c64550f45ede24e3105b4116f3aa82f2987344007e131a332756b9b4678c16b9dc6f5b5b5a380c4fd9e595370935da778943b2e891d45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12a2153a63cafcc23fc5ffb28f9bb7a5bd20b1521d31fb787ca8249c49ae6bb8f281c50adec8f3dac96cadd52c59165c112cf348291ffe7ec72950f67f2ec4e1"} build_url:https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/IwtxFyvETtqqa9CCxGjHDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92ddf709d087e0586787b054e43f8929a447dc849b4f9f301f7c763bf0e05f8f781e8b975657cd14c33a30db688b6210421f29561238a2f8507b909457bfa752", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b607982ed3a5e0a700814b3c2e4a075c24f0a7fa9e08b85993a59677b0132213edf71f07e85f42c918cb81de896a503bfbf090ecbca6b8df52cd55ba71f81f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0383b8b20ef94c7970c64550f45ede24e3105b4116f3aa82f2987344007e131a332756b9b4678c16b9dc6f5b5b5a380c4fd9e595370935da778943b2e891d45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12a2153a63cafcc23fc5ffb28f9bb7a5bd20b1521d31fb787ca8249c49ae6bb8f281c50adec8f3dac96cadd52c59165c112cf348291ffe7ec72950f67f2ec4e1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-30 09:34:40.577731) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 09:34:40.578078) ========= 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=920470bf432669ad7e3a5387000001ca-1483118041.219553-1580977669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-30 09:34:40.664476) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 09:34:40.665155) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-30 09:34:40.665720) ========= ========= Total master_lag: 0.17 =========