builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1469450940.99 results: success (0) buildid: 20160725030248 builduid: 2cde3c34bb464a82a735ecc4c474aba6 revision: 7c669d5d63efceb12696cd65cfa72c296013dafb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 05:49:00.985762) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 05:49:00.986240) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 05:49:00.986530) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 05:49:01.004516) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 05:49:01.004836) ========= 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=03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 05:49: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.5M=0s 2016-07-25 05:49:01 (50.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101189 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 05:49:01.120383) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 05:49:01.120735) ========= 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=03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023045 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 05:49:01.174224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 05:49:01.174592) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7c669d5d63efceb12696cd65cfa72c296013dafb --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 7c669d5d63efceb12696cd65cfa72c296013dafb --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=03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 05:49:01,385 truncating revision to first 12 chars 2016-07-25 05:49:01,386 Setting DEBUG logging. 2016-07-25 05:49:01,386 attempt 1/10 2016-07-25 05:49:01,386 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7c669d5d63ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 05:49:01,703 unpacking tar archive at: mozilla-central-7c669d5d63ef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659806 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 05:49:01.849722) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 05:49:01.850043) ========= script_repo_revision: 7c669d5d63efceb12696cd65cfa72c296013dafb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 05:49:01.850486) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 05:49:01.850764) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 05:49:01.860293) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-25 05:49:01.860838) ========= /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=03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:49:02 INFO - MultiFileLogger online at 20160725 05:49:02 in /builds/slave/test 05:49: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 05:49:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:49:02 INFO - {'append_to_log': False, 05:49:02 INFO - 'base_work_dir': '/builds/slave/test', 05:49:02 INFO - 'blob_upload_branch': 'Firefox', 05:49:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:49:02 INFO - 'branch': 'Firefox', 05:49:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:49:02 INFO - 'config_files': ('talos/linux_config.py',), 05:49:02 INFO - 'default_actions': ('clobber', 05:49:02 INFO - 'read-buildbot-config', 05:49:02 INFO - 'download-and-extract', 05:49:02 INFO - 'populate-webroot', 05:49:02 INFO - 'create-virtualenv', 05:49:02 INFO - 'install', 05:49:02 INFO - 'run-tests'), 05:49:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:49:02 INFO - 'download_minidump_stackwalk': True, 05:49:02 INFO - 'download_symbols': 'ondemand', 05:49:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:49:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:49:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:49:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:49:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:49:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:49:02 INFO - 'installer_path': 'installer.exe', 05:49:02 INFO - 'log_level': 'info', 05:49:02 INFO - 'log_name': 'talos', 05:49:02 INFO - 'log_to_console': True, 05:49:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:49:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:49:02 INFO - 'opt_config_files': (), 05:49:02 INFO - 'pip_index': False, 05:49:02 INFO - 'sps_profile': False, 05:49:02 INFO - 'sps_profile_interval': 0, 05:49:02 INFO - 'suite': 'dromaeojs-e10s', 05:49:02 INFO - 'system_bits': '32', 05:49:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:49:02 INFO - 'title': 'talos-linux64-ix-047', 05:49:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:49:02 INFO - 'use_talos_json': True, 05:49:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:49:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:49:02 INFO - 'work_dir': 'build'} 05:49:02 INFO - [mozharness: 2016-07-25 12:49:02.167924Z] Running clobber step. 05:49:02 INFO - Running pre-action listener: _resource_record_pre_action 05:49:02 INFO - Running main action method: clobber 05:49:02 INFO - rmtree: /builds/slave/test/build 05:49:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:49:03 INFO - Running post-action listener: _resource_record_post_action 05:49:03 INFO - [mozharness: 2016-07-25 12:49:03.141016Z] Finished clobber step (success) 05:49:03 INFO - [mozharness: 2016-07-25 12:49:03.141119Z] Running read-buildbot-config step. 05:49:03 INFO - Running pre-action listener: _resource_record_pre_action 05:49:03 INFO - Running main action method: read_buildbot_config 05:49:03 INFO - Using buildbot properties: 05:49:03 INFO - { 05:49:03 INFO - "project": "", 05:49:03 INFO - "product": "firefox", 05:49:03 INFO - "script_repo_revision": "production", 05:49:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:49:03 INFO - "repository": "", 05:49:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:49:03 INFO - "buildid": "20160725030248", 05:49:03 INFO - "stage_platform": "linux64-pgo", 05:49:03 INFO - "basedir": "/builds/slave/test", 05:49:03 INFO - "nightly_build": "True", 05:49:03 INFO - "buildnumber": 300, 05:49:03 INFO - "slavename": "talos-linux64-ix-047", 05:49:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:49:03 INFO - "platform": "ubuntu64_hw", 05:49:03 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:49:03 INFO - "branch": "mozilla-central", 05:49:03 INFO - "repo_path": "mozilla-central", 05:49:03 INFO - "revision": "7c669d5d63efceb12696cd65cfa72c296013dafb", 05:49:03 INFO - "pgo_build": "True", 05:49:03 INFO - "builduid": "2cde3c34bb464a82a735ecc4c474aba6", 05:49:03 INFO - "slavebuilddir": "test" 05:49:03 INFO - } 05:49:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:49:03 INFO - Running post-action listener: _resource_record_post_action 05:49:03 INFO - [mozharness: 2016-07-25 12:49:03.143708Z] Finished read-buildbot-config step (success) 05:49:03 INFO - [mozharness: 2016-07-25 12:49:03.143797Z] Running download-and-extract step. 05:49:03 INFO - Running pre-action listener: _resource_record_pre_action 05:49:03 INFO - Running main action method: download_and_extract 05:49:03 INFO - mkdir: /builds/slave/test/build/tests 05:49: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:03 INFO - https://queue.taskcluster.net/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:49:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:49:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:49:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:49:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:49:04 INFO - Downloaded 1361 bytes. 05:49:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:49:04 INFO - Using the following test package requirements: 05:49:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:49:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:49:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:04 INFO - u'jsshell-linux-x86_64.zip'], 05:49:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:49:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:49:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:49:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:49:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:49:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:49:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:04 INFO - https://queue.taskcluster.net/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:49:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:49:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:49:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:49:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:49:06 INFO - Downloaded 24308687 bytes. 05:49:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:49:07 INFO - Return code: 0 05:49:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:49:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:07 INFO - https://queue.taskcluster.net/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:49:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:49:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:49:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:49:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:49:09 INFO - Downloaded 24308687 bytes. 05:49:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:49:10 INFO - Return code: 0 05:49:10 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:10 INFO - https://queue.taskcluster.net/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:49:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:49:11 INFO - Downloaded 14403289 bytes. 05:49:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:49:12 INFO - Return code: 0 05:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:12 INFO - https://queue.taskcluster.net/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:49:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:49:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:49:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:49:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:49:13 INFO - Downloaded 60848118 bytes. 05:49:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:49:13 INFO - mkdir: /builds/slave/test/properties 05:49:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:49:13 INFO - Writing to file /builds/slave/test/properties/build_url 05:49:13 INFO - Contents: 05:49:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:49:14 INFO - Running post-action listener: _resource_record_post_action 05:49:14 INFO - Running post-action listener: set_extra_try_arguments 05:49:14 INFO - [mozharness: 2016-07-25 12:49:14.717829Z] Finished download-and-extract step (success) 05:49:14 INFO - [mozharness: 2016-07-25 12:49:14.718065Z] Running populate-webroot step. 05:49:14 INFO - Running pre-action listener: _resource_record_pre_action 05:49:14 INFO - Running main action method: populate_webroot 05:49:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:49:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:49:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:49:14 INFO - '--tppagecycles', 05:49:14 INFO - '7'], 05:49:14 INFO - 'tests': ['tsvgm']}}, 05:49:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:49:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:49:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:49:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:49:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:49:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:49:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:14 INFO - 'talos_options': ['--disable-e10s'], 05:49:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:14 INFO - 'talos_options': ['--disable-e10s'], 05:49:14 INFO - 'tests': ['damp', 'tps']}, 05:49:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:14 INFO - 'tests': ['damp', 'tps']}, 05:49:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:49:14 INFO - 'tests': ['dromaeo_dom']}, 05:49:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:49:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:49:14 INFO - 'tests': ['basic_compositor_video']}, 05:49:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:49:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:49:14 INFO - 'tests': ['a11yr', 05:49:14 INFO - 'ts_paint', 05:49:14 INFO - 'tpaint', 05:49:14 INFO - 'sessionrestore', 05:49:14 INFO - 'sessionrestore_no_auto_restore', 05:49:14 INFO - 'tabpaint']}, 05:49:14 INFO - 'other-e10s': {'tests': ['a11yr', 05:49:14 INFO - 'ts_paint', 05:49:14 INFO - 'tpaint', 05:49:14 INFO - 'sessionrestore', 05:49:14 INFO - 'sessionrestore_no_auto_restore', 05:49:14 INFO - 'tabpaint']}, 05:49:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:49:14 INFO - 'ts_paint', 05:49:14 INFO - 'tpaint', 05:49:14 INFO - 'sessionrestore', 05:49:14 INFO - 'sessionrestore_no_auto_restore', 05:49:14 INFO - 'tabpaint']}, 05:49:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:49:14 INFO - 'ts_paint', 05:49:14 INFO - 'tpaint', 05:49:14 INFO - 'sessionrestore', 05:49:14 INFO - 'sessionrestore_no_auto_restore', 05:49:14 INFO - 'tabpaint']}, 05:49:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:49:14 INFO - 'tests': ['a11yr', 05:49:14 INFO - 'ts_paint', 05:49:14 INFO - 'tpaint', 05:49:14 INFO - 'sessionrestore', 05:49:14 INFO - 'sessionrestore_no_auto_restore', 05:49:14 INFO - 'tabpaint']}, 05:49:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:49:14 INFO - 'tests': ['a11yr', 05:49:14 INFO - 'ts_paint', 05:49:14 INFO - 'tpaint', 05:49:14 INFO - 'sessionrestore', 05:49:14 INFO - 'sessionrestore_no_auto_restore', 05:49:14 INFO - 'tabpaint']}, 05:49:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:49:14 INFO - 'tests': ['tsvgx', 05:49:14 INFO - 'tsvgr_opacity', 05:49:14 INFO - 'tart', 05:49:14 INFO - 'tscrollx', 05:49:14 INFO - 'cart']}, 05:49:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:49:14 INFO - 'tsvgr_opacity', 05:49:14 INFO - 'tart', 05:49:14 INFO - 'tscrollx', 05:49:14 INFO - 'cart']}, 05:49:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:14 INFO - 'talos_options': ['--disable-e10s'], 05:49:14 INFO - 'tests': ['tp5o']}, 05:49:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:14 INFO - 'tests': ['tp5o']}, 05:49:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:14 INFO - 'talos_options': ['--disable-e10s', 05:49:14 INFO - '--xperf_path', 05:49:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:14 INFO - 'tests': ['tp5n']}, 05:49:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:14 INFO - 'talos_options': ['--xperf_path', 05:49:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:14 INFO - 'tests': ['tp5n']}}, 05:49:14 INFO - 'talos.zip': {'path': '', 05:49:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:49:14 INFO - Running post-action listener: _resource_record_post_action 05:49:14 INFO - [mozharness: 2016-07-25 12:49:14.739969Z] Finished populate-webroot step (success) 05:49:14 INFO - [mozharness: 2016-07-25 12:49:14.740059Z] Running create-virtualenv step. 05:49:14 INFO - Running pre-action listener: _resource_record_pre_action 05:49:14 INFO - Running main action method: create_virtualenv 05:49:14 INFO - Creating virtualenv /builds/slave/test/build/venv 05:49:14 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 05:49:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:49:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:49:14 INFO - Using real prefix '/usr' 05:49:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:49:15 INFO - Installing distribute.............................................................................................................................................................................................done. 05:49:17 INFO - Installing pip.................done. 05:49:17 INFO - Return code: 0 05:49:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:49:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:17 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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', '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 05:49:17 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 05:49:17 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 05:49:17 INFO - Using env: {'DISPLAY': ':0', 05:49:17 INFO - 'HOME': '/home/cltbld', 05:49:17 INFO - 'LANG': 'en_US.UTF-8', 05:49:17 INFO - 'LANGUAGE': 'en_US:en', 05:49:17 INFO - 'LOGNAME': 'cltbld', 05:49:17 INFO - 'MAIL': '/var/mail/cltbld', 05:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:17 INFO - 'MOZ_NO_REMOTE': '1', 05:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:17 INFO - 'NO_EM_RESTART': '1', 05:49:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:17 INFO - 'PWD': '/builds/slave/test', 05:49:17 INFO - 'SHELL': '/bin/bash', 05:49:17 INFO - 'SHLVL': '1', 05:49:17 INFO - 'TERM': 'linux', 05:49:17 INFO - 'TMOUT': '86400', 05:49:17 INFO - 'USER': 'cltbld', 05:49:17 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', 05:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:17 INFO - '_': '/tools/buildbot/bin/python'} 05:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:17 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 05:49:17 INFO - Cleaning up... 05:49:17 INFO - Return code: 0 05:49:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:49:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:17 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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', '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 05:49:17 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 05:49:17 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 05:49:17 INFO - Using env: {'DISPLAY': ':0', 05:49:17 INFO - 'HOME': '/home/cltbld', 05:49:17 INFO - 'LANG': 'en_US.UTF-8', 05:49:17 INFO - 'LANGUAGE': 'en_US:en', 05:49:17 INFO - 'LOGNAME': 'cltbld', 05:49:17 INFO - 'MAIL': '/var/mail/cltbld', 05:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:17 INFO - 'MOZ_NO_REMOTE': '1', 05:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:17 INFO - 'NO_EM_RESTART': '1', 05:49:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:17 INFO - 'PWD': '/builds/slave/test', 05:49:17 INFO - 'SHELL': '/bin/bash', 05:49:17 INFO - 'SHLVL': '1', 05:49:17 INFO - 'TERM': 'linux', 05:49:17 INFO - 'TMOUT': '86400', 05:49:17 INFO - 'USER': 'cltbld', 05:49:17 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', 05:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:17 INFO - '_': '/tools/buildbot/bin/python'} 05:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:17 INFO - Downloading/unpacking psutil>=3.1.1 05:49:17 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 05:49:17 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 05:49:17 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 05:49:17 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 05:49:17 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 05:49:17 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 05:49:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:49:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:19 INFO - Installing collected packages: psutil 05:49:19 INFO - Running setup.py install for psutil 05:49:19 INFO - building 'psutil._psutil_linux' extension 05:49:19 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 05:49:19 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 05:49:19 INFO - building 'psutil._psutil_posix' extension 05:49:19 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 05:49:20 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 05:49:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:20 INFO - Successfully installed psutil 05:49:20 INFO - Cleaning up... 05:49:20 INFO - Return code: 0 05:49:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:20 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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', '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 05:49:20 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 05:49:20 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 05:49:20 INFO - Using env: {'DISPLAY': ':0', 05:49:20 INFO - 'HOME': '/home/cltbld', 05:49:20 INFO - 'LANG': 'en_US.UTF-8', 05:49:20 INFO - 'LANGUAGE': 'en_US:en', 05:49:20 INFO - 'LOGNAME': 'cltbld', 05:49:20 INFO - 'MAIL': '/var/mail/cltbld', 05:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:20 INFO - 'MOZ_NO_REMOTE': '1', 05:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:20 INFO - 'NO_EM_RESTART': '1', 05:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:20 INFO - 'PWD': '/builds/slave/test', 05:49:20 INFO - 'SHELL': '/bin/bash', 05:49:20 INFO - 'SHLVL': '1', 05:49:20 INFO - 'TERM': 'linux', 05:49:20 INFO - 'TMOUT': '86400', 05:49:20 INFO - 'USER': 'cltbld', 05:49:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', 05:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:20 INFO - '_': '/tools/buildbot/bin/python'} 05:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:49:20 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 05:49:20 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 05:49:20 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 05:49:20 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 05:49:20 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 05:49:20 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 05:49:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:49:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:49:22 INFO - Installing collected packages: mozsystemmonitor 05:49:22 INFO - Running setup.py install for mozsystemmonitor 05:49:22 INFO - Successfully installed mozsystemmonitor 05:49:22 INFO - Cleaning up... 05:49:22 INFO - Return code: 0 05:49:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:49: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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', '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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', '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 05:49: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:49: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 jsonschema==2.5.1 05:49:22 INFO - Using env: {'DISPLAY': ':0', 05:49:22 INFO - 'HOME': '/home/cltbld', 05:49:22 INFO - 'LANG': 'en_US.UTF-8', 05:49:22 INFO - 'LANGUAGE': 'en_US:en', 05:49:22 INFO - 'LOGNAME': 'cltbld', 05:49:22 INFO - 'MAIL': '/var/mail/cltbld', 05:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:22 INFO - 'MOZ_NO_REMOTE': '1', 05:49:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:22 INFO - 'NO_EM_RESTART': '1', 05:49:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:22 INFO - 'PWD': '/builds/slave/test', 05:49:22 INFO - 'SHELL': '/bin/bash', 05:49:22 INFO - 'SHLVL': '1', 05:49:22 INFO - 'TERM': 'linux', 05:49:22 INFO - 'TMOUT': '86400', 05:49:22 INFO - 'USER': 'cltbld', 05:49:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', 05:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:22 INFO - '_': '/tools/buildbot/bin/python'} 05:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:22 INFO - Downloading/unpacking jsonschema==2.5.1 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:49:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:24 INFO - Downloading functools32-3.2.3-2.tar.gz 05:49:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:49:24 INFO - warning: no files found matching '*.txt' 05:49:24 INFO - no previously-included directories found matching 'build' 05:49:24 INFO - no previously-included directories found matching 'dist' 05:49:24 INFO - no previously-included directories found matching '.git*' 05:49:24 INFO - Installing collected packages: jsonschema, functools32 05:49:25 INFO - Running setup.py install for functools32 05:49:25 INFO - warning: no files found matching '*.txt' 05:49:25 INFO - no previously-included directories found matching 'build' 05:49:25 INFO - no previously-included directories found matching 'dist' 05:49:25 INFO - no previously-included directories found matching '.git*' 05:49:25 INFO - Successfully installed jsonschema functools32 05:49:25 INFO - Cleaning up... 05:49:25 INFO - Return code: 0 05:49:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:49: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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', '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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', '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 05:49: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:49: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 blobuploader==1.2.4 05:49:25 INFO - Using env: {'DISPLAY': ':0', 05:49:25 INFO - 'HOME': '/home/cltbld', 05:49:25 INFO - 'LANG': 'en_US.UTF-8', 05:49:25 INFO - 'LANGUAGE': 'en_US:en', 05:49:25 INFO - 'LOGNAME': 'cltbld', 05:49:25 INFO - 'MAIL': '/var/mail/cltbld', 05:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:25 INFO - 'MOZ_NO_REMOTE': '1', 05:49:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:25 INFO - 'NO_EM_RESTART': '1', 05:49:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:25 INFO - 'PWD': '/builds/slave/test', 05:49:25 INFO - 'SHELL': '/bin/bash', 05:49:25 INFO - 'SHLVL': '1', 05:49:25 INFO - 'TERM': 'linux', 05:49:25 INFO - 'TMOUT': '86400', 05:49:25 INFO - 'USER': 'cltbld', 05:49:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', 05:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:25 INFO - '_': '/tools/buildbot/bin/python'} 05:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:25 INFO - Downloading/unpacking blobuploader==1.2.4 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:27 INFO - Downloading blobuploader-1.2.4.tar.gz 05:49:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:49:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:49:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:28 INFO - Downloading docopt-0.6.1.tar.gz 05:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:49:28 INFO - Installing collected packages: blobuploader, requests, docopt 05:49:28 INFO - Running setup.py install for blobuploader 05:49:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:49:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:49:28 INFO - Running setup.py install for requests 05:49:28 INFO - Running setup.py install for docopt 05:49:28 INFO - Successfully installed blobuploader requests docopt 05:49:28 INFO - Cleaning up... 05:49:28 INFO - Return code: 0 05:49:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', '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 05:49:28 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 05:49:28 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 05:49:28 INFO - Using env: {'DISPLAY': ':0', 05:49:28 INFO - 'HOME': '/home/cltbld', 05:49:28 INFO - 'LANG': 'en_US.UTF-8', 05:49:28 INFO - 'LANGUAGE': 'en_US:en', 05:49:28 INFO - 'LOGNAME': 'cltbld', 05:49:28 INFO - 'MAIL': '/var/mail/cltbld', 05:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:28 INFO - 'MOZ_NO_REMOTE': '1', 05:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:28 INFO - 'NO_EM_RESTART': '1', 05:49:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:28 INFO - 'PWD': '/builds/slave/test', 05:49:28 INFO - 'SHELL': '/bin/bash', 05:49:28 INFO - 'SHLVL': '1', 05:49:28 INFO - 'TERM': 'linux', 05:49:28 INFO - 'TMOUT': '86400', 05:49:28 INFO - 'USER': 'cltbld', 05:49:28 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', 05:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:28 INFO - '_': '/tools/buildbot/bin/python'} 05:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:29 INFO - Running setup.py (path:/tmp/pip-3LZli6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:29 INFO - Running setup.py (path:/tmp/pip-sNE1Xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:29 INFO - Running setup.py (path:/tmp/pip-uNC9ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:29 INFO - Running setup.py (path:/tmp/pip-51efPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:29 INFO - Running setup.py (path:/tmp/pip-zOKyBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:29 INFO - Running setup.py (path:/tmp/pip-7HVkoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:29 INFO - Running setup.py (path:/tmp/pip-8y_nhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:29 INFO - Running setup.py (path:/tmp/pip-ObZ7Zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:29 INFO - Running setup.py (path:/tmp/pip-T8AZvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:29 INFO - Running setup.py (path:/tmp/pip-uPH17H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:29 INFO - Running setup.py (path:/tmp/pip-mO7Apq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:29 INFO - Running setup.py (path:/tmp/pip-WebtnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:29 INFO - Running setup.py (path:/tmp/pip-YUbEkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:30 INFO - Running setup.py (path:/tmp/pip-vjpq6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:30 INFO - Running setup.py (path:/tmp/pip-CU9GzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:30 INFO - Running setup.py (path:/tmp/pip-_UsHGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:30 INFO - Running setup.py (path:/tmp/pip-ltoJDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:49:30 INFO - Running setup.py install for manifestparser 05:49:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:49:30 INFO - Running setup.py install for mozcrash 05:49:30 INFO - Running setup.py install for mozdebug 05:49:30 INFO - Running setup.py install for mozdevice 05:49:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:49:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:49:30 INFO - Running setup.py install for mozfile 05:49:30 INFO - Running setup.py install for mozhttpd 05:49:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:49:30 INFO - Running setup.py install for mozinfo 05:49:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:49:31 INFO - Running setup.py install for mozInstall 05:49:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:49:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:49:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:49:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:49:31 INFO - Running setup.py install for mozleak 05:49:31 INFO - Running setup.py install for mozlog 05:49:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:49:31 INFO - Running setup.py install for moznetwork 05:49:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:49:31 INFO - Running setup.py install for mozprocess 05:49:31 INFO - Running setup.py install for mozprofile 05:49:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:49:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:49:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:49:31 INFO - Running setup.py install for mozrunner 05:49:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:49:31 INFO - Running setup.py install for mozscreenshot 05:49:31 INFO - Running setup.py install for moztest 05:49:32 INFO - Running setup.py install for mozversion 05:49:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:49:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:49:32 INFO - Cleaning up... 05:49:32 INFO - Return code: 0 05:49:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:32 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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', '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 05:49:32 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 05:49:32 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 05:49:32 INFO - Using env: {'DISPLAY': ':0', 05:49:32 INFO - 'HOME': '/home/cltbld', 05:49:32 INFO - 'LANG': 'en_US.UTF-8', 05:49:32 INFO - 'LANGUAGE': 'en_US:en', 05:49:32 INFO - 'LOGNAME': 'cltbld', 05:49:32 INFO - 'MAIL': '/var/mail/cltbld', 05:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:32 INFO - 'MOZ_NO_REMOTE': '1', 05:49:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:32 INFO - 'NO_EM_RESTART': '1', 05:49:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:32 INFO - 'PWD': '/builds/slave/test', 05:49:32 INFO - 'SHELL': '/bin/bash', 05:49:32 INFO - 'SHLVL': '1', 05:49:32 INFO - 'TERM': 'linux', 05:49:32 INFO - 'TMOUT': '86400', 05:49:32 INFO - 'USER': 'cltbld', 05:49:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', 05:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:32 INFO - '_': '/tools/buildbot/bin/python'} 05:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:32 INFO - Running setup.py (path:/tmp/pip-K0ehy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:32 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)) 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:32 INFO - Running setup.py (path:/tmp/pip-C6KlNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:32 INFO - Running setup.py (path:/tmp/pip-piXIjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:32 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)) 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:32 INFO - Running setup.py (path:/tmp/pip-uv7q3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:32 INFO - Running setup.py (path:/tmp/pip-AJmXTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:32 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)) 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:32 INFO - Running setup.py (path:/tmp/pip-wyBbtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:32 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)) 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:32 INFO - Running setup.py (path:/tmp/pip-a8p5D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:32 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)) 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:32 INFO - Running setup.py (path:/tmp/pip-IIj_6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:32 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)) 05:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:32 INFO - Running setup.py (path:/tmp/pip-iHGs5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:33 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)) 05:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:33 INFO - Running setup.py (path:/tmp/pip-IDuHN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 05:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:33 INFO - Running setup.py (path:/tmp/pip-imWxxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:33 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)) 05:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:33 INFO - Running setup.py (path:/tmp/pip-0K_iFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:33 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)) 05:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:33 INFO - Running setup.py (path:/tmp/pip-XRJXsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:33 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)) 05:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:33 INFO - Running setup.py (path:/tmp/pip-BzFZ0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 05:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:33 INFO - Running setup.py (path:/tmp/pip-IIxGA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:33 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)) 05:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:33 INFO - Running setup.py (path:/tmp/pip-rYe5SW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:33 INFO - Running setup.py (path:/tmp/pip-Q_9617-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:33 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)) 05:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:33 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)) 05:49:33 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:33 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:35 INFO - Downloading blessings-1.6.tar.gz 05:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:49:35 INFO - Installing collected packages: blessings 05:49:35 INFO - Running setup.py install for blessings 05:49:35 INFO - Successfully installed blessings 05:49:35 INFO - Cleaning up... 05:49:35 INFO - Return code: 0 05:49:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:49:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:35 INFO - Reading from file tmpfile_stdout 05:49:35 INFO - Current package versions: 05:49:35 INFO - argparse == 1.2.1 05:49:35 INFO - blessings == 1.6 05:49:35 INFO - blobuploader == 1.2.4 05:49:35 INFO - docopt == 0.6.1 05:49:35 INFO - functools32 == 3.2.3-2 05:49:35 INFO - jsonschema == 2.5.1 05:49:35 INFO - manifestparser == 1.1 05:49:35 INFO - mozInstall == 1.12 05:49:35 INFO - mozcrash == 0.17 05:49:35 INFO - mozdebug == 0.1 05:49:35 INFO - mozdevice == 0.48 05:49:35 INFO - mozfile == 1.2 05:49:35 INFO - mozhttpd == 0.7 05:49:35 INFO - mozinfo == 0.9 05:49:35 INFO - mozleak == 0.1 05:49:35 INFO - mozlog == 3.3 05:49:35 INFO - moznetwork == 0.27 05:49:35 INFO - mozprocess == 0.23 05:49:35 INFO - mozprofile == 0.28 05:49:35 INFO - mozrunner == 6.12 05:49:35 INFO - mozscreenshot == 0.1 05:49:35 INFO - mozsystemmonitor == 0.3 05:49:35 INFO - moztest == 0.7 05:49:35 INFO - mozversion == 1.4 05:49:35 INFO - psutil == 3.1.1 05:49:35 INFO - requests == 1.2.3 05:49:35 INFO - wsgiref == 0.1.2 05:49:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:35 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:35 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:35 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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', '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 05:49:35 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 05:49:35 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 05:49:35 INFO - Using env: {'DISPLAY': ':0', 05:49:35 INFO - 'HOME': '/home/cltbld', 05:49:35 INFO - 'LANG': 'en_US.UTF-8', 05:49:35 INFO - 'LANGUAGE': 'en_US:en', 05:49:35 INFO - 'LOGNAME': 'cltbld', 05:49:35 INFO - 'MAIL': '/var/mail/cltbld', 05:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:35 INFO - 'MOZ_NO_REMOTE': '1', 05:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:35 INFO - 'NO_EM_RESTART': '1', 05:49:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:35 INFO - 'PWD': '/builds/slave/test', 05:49:35 INFO - 'SHELL': '/bin/bash', 05:49:35 INFO - 'SHLVL': '1', 05:49:35 INFO - 'TERM': 'linux', 05:49:35 INFO - 'TMOUT': '86400', 05:49:35 INFO - 'USER': 'cltbld', 05:49:35 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', 05:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:35 INFO - '_': '/tools/buildbot/bin/python'} 05:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:36 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)) 05:49:36 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)) 05:49:36 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)) 05:49:36 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)) 05:49:36 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)) 05:49:36 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)) 05:49:36 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)) 05:49:36 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)) 05:49:36 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)) 05:49:36 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)) 05:49:36 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)) 05:49:36 INFO - Cleaning up... 05:49:36 INFO - Return code: 0 05:49:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:49:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:36 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 0x1214030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', '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 05:49:36 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 05:49:36 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 05:49:36 INFO - Using env: {'DISPLAY': ':0', 05:49:36 INFO - 'HOME': '/home/cltbld', 05:49:36 INFO - 'LANG': 'en_US.UTF-8', 05:49:36 INFO - 'LANGUAGE': 'en_US:en', 05:49:36 INFO - 'LOGNAME': 'cltbld', 05:49:36 INFO - 'MAIL': '/var/mail/cltbld', 05:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:36 INFO - 'MOZ_NO_REMOTE': '1', 05:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:36 INFO - 'NO_EM_RESTART': '1', 05:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:36 INFO - 'PWD': '/builds/slave/test', 05:49:36 INFO - 'SHELL': '/bin/bash', 05:49:36 INFO - 'SHLVL': '1', 05:49:36 INFO - 'TERM': 'linux', 05:49:36 INFO - 'TMOUT': '86400', 05:49:36 INFO - 'USER': 'cltbld', 05:49:36 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', 05:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:36 INFO - '_': '/tools/buildbot/bin/python'} 05:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:49:36 INFO - Cleaning up... 05:49:36 INFO - Return code: 0 05:49:36 INFO - Running post-action listener: _resource_record_post_action 05:49:36 INFO - Running post-action listener: _start_resource_monitoring 05:49:36 INFO - Starting resource monitoring. 05:49:36 INFO - [mozharness: 2016-07-25 12:49:36.438620Z] Finished create-virtualenv step (success) 05:49:36 INFO - [mozharness: 2016-07-25 12:49:36.439091Z] Running install step. 05:49:36 INFO - Running pre-action listener: _resource_record_pre_action 05:49:36 INFO - Running main action method: install 05:49:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:36 INFO - Reading from file tmpfile_stdout 05:49:36 INFO - Detecting whether we're running mozinstall >=1.0... 05:49:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:49:36 INFO - Reading from file tmpfile_stdout 05:49:36 INFO - Output received: 05:49:36 INFO - Usage: mozinstall [options] installer 05:49:36 INFO - Options: 05:49:36 INFO - -h, --help show this help message and exit 05:49:36 INFO - -d DEST, --destination=DEST 05:49:36 INFO - Directory to install application into. [default: 05:49:36 INFO - "/builds/slave/test"] 05:49:36 INFO - --app=APP Application being installed. [default: firefox] 05:49:36 INFO - mkdir: /builds/slave/test/build/application 05:49:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:49:53 INFO - Reading from file tmpfile_stdout 05:49:53 INFO - Output received: 05:49:53 INFO - /builds/slave/test/build/application/firefox/firefox 05:49:53 INFO - Running post-action listener: _resource_record_post_action 05:49:53 INFO - [mozharness: 2016-07-25 12:49:53.951154Z] Finished install step (success) 05:49:53 INFO - [mozharness: 2016-07-25 12:49:53.951499Z] Running run-tests step. 05:49:53 INFO - Running pre-action listener: _resource_record_pre_action 05:49:53 INFO - Running main action method: run_tests 05:49:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:49:53 INFO - Python 2.7.3 05:49:53 INFO - Return code: 0 05:49:53 INFO - grabbing minidump binary from tooltool 05:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:53 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 0x14d33b0>, '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 0x14d42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14d4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:49:53 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 05:49:53 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 05:49:53 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 05:49:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:49:54 INFO - Return code: 0 05:49:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:49:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:49:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:49:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:49:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:49:54 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/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 05:49:54 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/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 05:49:54 INFO - Using env: {'DISPLAY': ':0', 05:49:54 INFO - 'HOME': '/home/cltbld', 05:49:54 INFO - 'LANG': 'en_US.UTF-8', 05:49:54 INFO - 'LANGUAGE': 'en_US:en', 05:49:54 INFO - 'LOGNAME': 'cltbld', 05:49:54 INFO - 'MAIL': '/var/mail/cltbld', 05:49:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:49:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:54 INFO - 'MOZ_NO_REMOTE': '1', 05:49:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:54 INFO - 'NO_EM_RESTART': '1', 05:49:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:54 INFO - 'PWD': '/builds/slave/test', 05:49:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:49:54 INFO - 'SHELL': '/bin/bash', 05:49:54 INFO - 'SHLVL': '1', 05:49:54 INFO - 'TERM': 'linux', 05:49:54 INFO - 'TMOUT': '86400', 05:49:54 INFO - 'USER': 'cltbld', 05:49:54 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159', 05:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:54 INFO - '_': '/tools/buildbot/bin/python'} 05:49:54 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/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 05:49:54 INFO - mozversion application_buildid: 20160725030248 05:49:54 INFO - mozversion application_changeset: 7c669d5d63efceb12696cd65cfa72c296013dafb 05:49:54 INFO - mozversion application_display_name: Nightly 05:49:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:49:54 INFO - mozversion application_name: Firefox 05:49:54 INFO - mozversion application_remotingname: firefox 05:49:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:49:54 INFO - mozversion application_vendor: Mozilla 05:49:54 INFO - mozversion application_version: 50.0a1 05:49:54 INFO - mozversion platform_buildid: 20160725030248 05:49:54 INFO - mozversion platform_changeset: 7c669d5d63efceb12696cd65cfa72c296013dafb 05:49:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:49:54 INFO - mozversion platform_version: 50.0a1 05:49:54 INFO - using testdate: 1469450994 05:49:54 INFO - actual date: 1469450994 05:49:54 INFO - starting webserver on 'localhost:47814' 05:49:54 INFO - SUITE-START | Running 2 tests 05:49:54 INFO - TEST-START | dromaeo_css 05:49:54 INFO - operating with platform_type : linux_ 05:49:54 INFO - Initialising browser for dromaeo_css test... 05:49:54 INFO - TEST-INFO | started process 23664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy9dnbH/profile http://localhost:47814/getInfo.html) 05:49:57 INFO - PROCESS | 23664 | JavaScript error: , line 0: uncaught exception: undefined 05:49:58 INFO - PROCESS | 23664 | __metrics Screen width/height:1600/1200 05:49:58 INFO - PROCESS | 23664 | colorDepth:24 05:49:58 INFO - PROCESS | 23664 | Browser inner width/height: 1024/697 05:49:58 INFO - PROCESS | 23664 | __metrics 05:49:59 ERROR - PROCESS | 23664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:50:00 INFO - TEST-INFO | 23664: exit 0 05:50:00 INFO - Browser initialized. 05:50:00 INFO - Running cycle 1/1 for dromaeo_css test... 05:50:00 INFO - TEST-INFO | started process 23786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy9dnbH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:12 INFO - PROCESS | 23786 | RSS: Main: 167825408 05:50:12 INFO - PROCESS | 23786 | 05:51:01 INFO - PROCESS | 23786 | 1469451061709 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] 05:53:09 INFO - PROCESS | 23786 | Cycle 1(1): loaded http://localhost:47814/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47814/tests/dromaeo/cssquery-ext.html) 05:53:10 INFO - PROCESS | 23786 | RSS: Main: 171556864 05:53:10 INFO - PROCESS | 23786 | 05:56:13 INFO - PROCESS | 23786 | Cycle 1(1): loaded http://localhost:47814/tests/dromaeo/cssquery-ext.html (next: http://localhost:47814/tests/dromaeo/cssquery-jquery.html) 05:56:13 INFO - PROCESS | 23786 | RSS: Main: 168538112 05:56:13 INFO - PROCESS | 23786 | 05:59:15 INFO - PROCESS | 23786 | Cycle 1(1): loaded http://localhost:47814/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47814/tests/dromaeo/cssquery-mootools.html) 05:59:16 INFO - PROCESS | 23786 | RSS: Main: 172806144 05:59:16 INFO - PROCESS | 23786 | 06:02:18 INFO - PROCESS | 23786 | Cycle 1(1): loaded http://localhost:47814/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47814/tests/dromaeo/cssquery-prototype.html) 06:02:18 INFO - PROCESS | 23786 | RSS: Main: 167604224 06:02:18 INFO - PROCESS | 23786 | 06:05:21 INFO - PROCESS | 23786 | Cycle 1(1): loaded http://localhost:47814/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47814/tests/dromaeo/cssquery-yui.html) 06:05:21 INFO - PROCESS | 23786 | RSS: Main: 169426944 06:05:21 INFO - PROCESS | 23786 | 06:08:25 INFO - PROCESS | 23786 | Cycle 1(1): loaded http://localhost:47814/tests/dromaeo/cssquery-yui.html (next: http://localhost:47814/tests/dromaeo/cssquery-dojo.html) 06:08:25 INFO - PROCESS | 23786 | RSS: Main: 172527616 06:08:25 INFO - PROCESS | 23786 | 06:08:25 INFO - PROCESS | 23786 | __start_tp_report 06:08:25 INFO - PROCESS | 23786 | _x_x_mozilla_page_load 06:08:25 INFO - PROCESS | 23786 | _x_x_mozilla_page_load_details 06:08:25 INFO - PROCESS | 23786 | |i|pagename|runs| 06:08:25 INFO - PROCESS | 23786 | |0;dojo.html;3049.6797836227197;3072.0323098224067;3085.336652619688;3094.350186460843;3104.6274447066357;5348.919766203505;5376.220448035033;5381;5452.509274165324;5476.096444086721;5273.683578985264;5396.136618141099;5396.136618141099;5424.321959755031;5455.972720136404;4901.828436004732;4904.681195722266;4938.950610493885;5017.9247311290355;5032.11937910866;4885.413750349945;5016.372953380827;5019.84940451787;5030.5975521958335;5035.597152227813;4856.927146092811;4905.583025442842;4918.950810491885;4940.97529512352;4989.501049895;4854.732989685566;4900.607951363882;4910.312556242129;4945.2829339745895;4956.776945037482;4868.537488938545;4874.147024270738;4883.389576302962;4898.962016880306;4930.679505832145;5284.445133261029;5338.652987555796;5348.572114230852;5354.571634269249;5408.864778380533;5811.128330750379;5814.738336774855;5822.301323841124;5845.035569131088;5878.882422351572;5781.335146458169;5810.680412577307;5849.327327357366;5857.531397488191;5858.912116318259;5334.146536554172;5426.67439953604;5450.182472629137;5474.479924407175;5483.287172667568;5959.672218027963;5972.044472884318;6014.6391216527145;6049.334573196945;6073.969630151821;5774.971125144348;5784.132380143013;5789.8552536186935;5794;5794.768209271666;5675.347335056521;5755.5683323750045;5884.47039766423;5892.263467066617;5899.026660601038;5636.18275350072;5721.256236689287;5741.224934633771;5808.332041815245;5823.912641310384;5730.885382292414;5773.740181691834;5786.855328616734;5792.1311803229855;5813.5349172066135;4419.381286619811;4429.911401771947;4433.357163211316;4435.911281774411;4454.97535566815;3849;3921.843126274974;3962.4848769660334;3963.3064213762477;4006.2788698034633;5633.746481408347;5647.407022262603;5653.208550802891;5657.151427285858;5665.886682266331;5916.467517923407;5928.229330187048;5942.851428714317;5950.137230101697;5957.106434034929;5504.4770746778995;5533.335999680065;5582.720863956786;5597.188407680945;5653.858653533694;5035.899282014339;5054.7978080876355;5054.898902022012;5058.696478211319;5063.316452278895;5980.820575382745;6028;6031.065184896348;6042.788502402483;6066.969665151646;5797.362290148165;5804.970975145182;5822.359540450631;5865.970670146622;5927.525797936241;5991.610545314541;6022.728977196124;6032.065029920369;6039.305479869871;6046.697665116639;5721.906771437324;5744.798932037359;5752.884942301047;5763.9135412968;5767.336756273083;5691.715414229189;5744.339400968942;5782.161586570008;5794.82615521535;5861.296644402699;5624.775008999594;5625.718714064362;5661.150827375926;5669.489745922887;5670.773169073191;5610.298712660918;5635.577331700057;5649.435056494318;5654.85862853432;5667.801626943037;5459.781608735606;5536.114221724505;5612.522935550524;5633.577481688808;5662.235598194356;5635.549156067586;5696.344920334214;5731.111677689964;5747.224124743107;5775.249217601685;5438.646487978269;5622.465865742748;5623.550115990629;5634.74643641029;5647.915281270702 06:08:25 INFO - PROCESS | 23786 | |1;ext.html;565.2347699325197;571.6627189957925;579.5913880714095;600.5255847880175;610.4993904997904;38799.41800872989;41985.7900710496;41997.79001104994;42001.57998420022;42116.57883421165;41739.58260417395;42219.577804222026;42302;42332;42365.36451953215;8853.203211710961;8953.328500362466;8963.193312601865;8969.237614802749;9004.189622933935;8787.912120878773;8874.29005679544;8905.955470222672;8911.420757650732;8913.064128266536;8940.10598940104;8974.102589741038;8999;9001.909980900205;9061.411008284473;8849.601767920427;8874.423162494417;8915.063918288584;8952.060033696498;8953.149450802164;8632.611532481053;8672.089430609822;8683.088275731083;8697.52163631;8702.47785132894;41116.58883411157;41588.79205603953;41647.167056659004;41657.58342416567;41674;3736.4021756518828;3780.640839120279;3832.8850134495733;4002.519697636302;4304.80628371724;32671.614192654477;33421.498677519856;33447.83276083628;33622.32755344904;33717.494237586456;4298.20483210607;4348.239058164809;4372.934405983913;4401.757903315316;4545.636349092098;371354;372038;372218;372833;373818;33258;54991;55317;55399.169012464845;55428.16857747137;33974.83012584971;35289.8235508826;35410.64589354125;35565.8221708895;35643;14431.92784036094;14479.276036198147;14480.710385792436;14519;14524.273786310641;11835.408229588485;11872.940635296769;11954.402279885971;11976.820347694616;11988.34064126464;8176.509409435453;8216.630251638691;8290.875636865452;8298.917010829935;8418.368622353348;3233.547303377529;3251.804891706458;3252.121927079675;3263.2494526259093;3302.5211344354934;976.4629453800381;1010.3887148275188;1042.864427624404;1099.4113505983937;1168.9064874809994;30876;30980.845095774377;31227.37545249082;31252.843735781174;31560.684393155774;1074.387599068539;1100.5762781329086;1106.4799544214206;1108.5676586131415;1203.1337437045313;16880.746788798177;17198.168006033375;17290.481285561455;17316.39392621252;17350.3059877606;153722;154420;154832.22583887007;605978;606110;56756.148657770165;56983.14525282124;57063.714681426325;57087;57446.425535744944;1320.3794216718127;1336.0714303559128;1347.8113064171023;1357.674158202044;1364.1814911053486;30214;31735.84132079325;31739;32107.03678889637;32270.35459290848;51629;56094;56177.43822561722;56189.15716264178;56234.43765562292;533363;537357;537639;539864;540619;27237.86381068082;28370.57444138298;28512.144635660963;29917.252068698457;43330.56669433265;47887.281690775366;48247.75876120597;48507;49136;49742.25386619131;40219.3967090488;41084.12411131192;41282.587174129076;41538.37692434676;42611.57388426076;42069;42329;42442.15115697607;42910.78544607257;42967.57032429636;39463.60536394599;40447.59552404438;40828;40907.1818563633;43339.78330108456;32977.505337420436;37208;37929.24141517099;38451.615483844806;38591.228175436896;28089.71910280871;28147;28410.43179136447;28658.85670571634;28966.7103328964 06:08:25 INFO - PROCESS | 23786 | |2;jquery.html;378.16048372612806;383.80762621836914;385.866875927805;395.86540576204084;415.45367841288703;13671.316434178301;18473.538161545966;19129;19820.207191712332;19828.60342793145;18398.540036499093;18676.252949882022;19131;19731.816091034547;19751.111199995998;5564.276644036279;5699.373068962411;5730.226419433386;5785.508231800302;5834.27071616048;5603.635763675348;5707.801361714024;5736.684482353469;5744.511716504102;5753.424657534234;5533.584981126412;5719.28508936383;5719.857003574903;5725.198472213893;5833.3874943130995;5788.797392091277;5817;5821.767129314843;6102.359252278491;6336.841578960517;5683.232763576905;5747.885042299173;5848.064309710426;5848.502877255439;5849.38581448946;12680.74638507234;12868.87131128686;13013.08908376414;13277.535286264934;13299.468021279137;2425.3936515871032;2562.9871850640816;2695.4609078184244;2712.403271280315;2737.137801592512;9746.658866939693;9964.501774911225;10137.239707022003;10174.389536627827;10277.126444252248;1880.2479008396751;1898.0509745127436;1918.7985261547615;1924.8363889069446;1951.4535929939639;74596;80931.5953420235;81268.59365703134;81404.18595814025;81940;10181.898181018096;10241.641542545975;10262.230332725076;10609.310394824312;10684.572617095384;14029.22839243831;14048.438062477386;14076.436942522389;14093.647658808406;14130.434782608787;7711.498752581177;7925.801854953557;7996.80007999793;8126.796830079295;8176.754697359089;7708.075030996316;7730.342920851678;7789;7956.283934445928;8025.2777250047775;4429.7785110744335;4479.462464504215;4495.100979804052;4533.614642755337;4571.497135315112;1812.275089964025;1879.5489082620072;1879.821416965386;1900.097453709477;1948.5420926082359;1006.9345492543108;1015.5125539740966;1033.9172866170688;1056.1128651932413;1073.2755390111643;19518.902405487883;20011.49971250701;20084.799152008585;20092.296769612993;20383.694244586342;969.0793745941384;973.8393165127675;987.0425687083517;1009.4044513736784;1016.1362841584594;10448.145689458675;11041.668749937515;11135.220534562503;11155.107591392669;11237.831432528355;512007;513773;514788;536281;537772.3111384496;90312;92446;93036.06963930275;93290.53354733318;93325;961.8268711631973;985.605757696927;992.4690290694588;1004.8492726091145;1011.1910471622673;16807.915960420607;17348.566285842953;17882;17955.910220448815;18040.639187216446;27028.32429189286;29470.557941631323;40436.79781601073;40668.79665601653;41228.38157427701;57198;58088;58246.41753582579;59014;59220.70389648024;8324.25081742646;8485.745427637181;8663.6101375437;8735.868961965449;8745.60644770974;12322.383880806103;13205.933970330087;13266.46934122663;13579.932100339434;14333.64165895861;10859.728506787393;10865;11236.381998990135;11564.710882228012;12175.57385491539;10415.94792026035;10801.783964320826;10964.451777411257;11071.889281107085;11217.383043932661;11688.94155529217;11950.760984780081;12036.097292703258;12096.274223546616;12292.139550231397;8444.577771111297;8577;8609.268212202032;8617.913820861962;8843.214387467928;9708.466034368177;11411.429428528707;11709.88290117122;11795.174337796272;11909.166358354832 06:08:25 INFO - PROCESS | 23786 | |3;mootools.html;1484.4952716076534;1501.3919362658123;1646.8600168985636;1735.5834599696077;1794.8205179482054;7762.7671169865;8501.78745531362;8581.485110893344;9112.817743645122;9138.634454621815;8571.828563428744;8867.73396798097;8872.37893347466;8884.511351875644;8891.555422228896;2351.200591798788;2394.1500767227644;2394.197943688858;2396.940076498084;2398.760123987605;2379.6192609182535;2383.8688872112025;2401.6157414813633;2404.1945948107405;2410.650455683925;2343.238447504568;2352.776486233805;2355.9411014724596;2356.0693526057285;2360.0677732295735;2267.614505534055;2296.9310920672406;2297.2993237062688;2302.527981763743;2318.0959425823944;2269.1830940861278;2282.132789539981;2297.4715815362392;2309.722833260003;2318.4435735423376;8815.779605509913;8898.510581918057;8904.643814247422;8906.421082629608;8918.643254269822;5077.49225077493;5105.5149760772665;5189.3772747270195;5282.81510147143;5292.470752924715;3290.5064240364136;3441.2429265561536;3457.170279133015;3504.5969713483023;3521.2429327694413;1111.7387413957713;1162.2038903351147;1163.4182908545727;1169.4386694386742;1170.2159553099443;12274.815877761841;12279.815802763054;12321.75356492874;12325.753484930252;12328.07539434546;4334.761588112621;4576.039031803359;4606.447226332862;4733.100710864925;4739.3838800955655;10486.947565262124;10497.737556561147;10501.842472362921;10505.632302869362;10527;5246.501582349671;5249.448807875195;5262.97368513155;5272.420033796279;5275.050490911673;4340.76125813077;4791.233402655628;4851.126797176472;4903.362562866804;4944.159492886218;3899.9610003899597;4022.4971878515184;4046.433499310099;4063.349864021742;4107.383892416102;1263.5009171377437;1268.2707443220186;1278.7058976435285;1284.5953524639895;1294.8251985981772;867.8654808504566;979.3046936674898;983.5033308179324;987.1609132237684;1029.711680729397;5996.13056106862;6018.458338749533;6029.728662210124;6143.109249158847;6197.876042479215;435.4752523209525;443.59411138807627;445.3119929708608;449.17576247585396;452.80303068164795;4172.687048471377;4190.266703326905;4218.135282267128;4263.744175349489;4306.849260275875;10691.518881650345;10984.231103822816;11126.944365278121;11138.053265472363;11166.385848778233;10541.789164216827;10854.837177442345;10983.121350291958;11012.284201527036;11083.833742493869;8173.75478735627;8396.748097557083;8410.621522031523;8415.831683366298;8425;6013.639181649115;6047.395260474093;6096.969515152396;6152.815415537541;6194.650662078694;10091.243156763125;10141.84787228207;10149;10183.592656293666;10222.693319200436;9944.552495137592;10161.288709790244;10265.486725663537;10443.686689399026;10476.371417714961;7897.960510197412;7985.121636619851;7996.3602911768085;8076.152004039726;8109.635066422144;8687.826243475221;8695.434796738191;8708;8718.82562348762;8728.563571821256;7795;7842.254985776342;8024.919750802417;8157.6329065193395;8213.876791848246;7656.770296891103;7816.218378162138;7892;7896.447248692536;7989.360851132012;6913.723451062102;7018.75434359795;7030.894536581853;7048.154221493453;7068.5758854468895;5296.920546191733;5326.680399176062;5398.838034858961;5426.67439953604;5463.72681365938;5157.742112894415;5248.973755131353;5271.78912843482;5313.628046036741;5373.516383525502 06:08:25 INFO - PROCESS | 23786 | |4;prototype.html;323.6682400539448;332.4796693175181;333.3815771743416;340.0665174097103;342.6060030964389;5389.541888939445;5434.429384914576;5522.668639881605;5579.386267510576;5608.653923058472;5475.945240547593;5484.890302193954;5494.148406996912;5504;5522.784987302797;4257.467311767753;4270.594293542124;4273.594008569181;4291.785410729467;4325.372820940962;4166.916661666764;4269.231538323101;4308.569143085682;4314.525402205771;4344.543822898598;4229.407882896397;4261.061217146206;4264.765437900915;4269.167512335096;4278.828846846122;4268.061026574149;4282.207791558556;4290.892727681801;4297.39836422901;4309.11663109065;3676.6507181817683;3774.471573979645;3782.5650050244026;3791.298609757204;3791.50710407648;5372.355317361941;5410.5401040911565;5428.782848686048;5436.728163591804;5456.399796022434;4888.486708895586;4911.140550403665;4913.754312284372;4920.5571498565305;4925.581325587329;5591.8881622367735;5770.826875193751;5795.478406943354;5826.592138550303;5838.649681019152;4094.28350038745;4108.219438306712;4109.260333140033;4114.938275925863;4120.114175452262;5962.791302304442;6026.969865150646;6036.547258955596;6061.636301821861;6092.939070609282;3984.621460961204;4202.936955945664;4204.62158405745;4215.262329092397;4225.471816022997;4250.829966801293;4255.5957184067465;4258.723182993095;4263.914721705549;4270.594293542109;4876.707397556158;4900.313956046157;4901.779419926112;4929;4973.751312434364;5746.770129194869;5904.881902361929;5924.407559244041;5948.494377977834;5966.985612445895;1469.8089248397853;1476.0258229568433;1480.8445113263167;1481.1335368809152;1489.113977183574;898.0166717444388;931.6552875436132;935.7473482159779;954.7756277274835;958.4488918871676;4973.776180071905;4985.354832905133;5017.698938063655;5040.445550989388;5043.84868453947;5222.634415590948;5243.5542978847225;5317.085849094323;5370.570354371641;5393.305585673826;5008.724520151427;5070.65627608684;5086.583872660457;5345.54562862161;5766.971165144148;3199.2961548459302;3205.909990603206;3225.7258133058485;3228.773066234816;3235.7734958553146;6140.785072522441;6254.781082662085;6263.812085637438;6300.873982520324;6301.905471417932;6055.303640081359;6089.604175728564;6102.328743838174;6108.35862234459;6108.35862234459;6207.937920620736;6220.284667263232;6235.594686345464;6251.593646412968;6271.498280137669;5803.303603567599;6009.609375390585;6013.428724271363;6027;6043.576949613484;5958.361450601119;5980.372060933713;5987.131865879336;6002.2893475359315;6023.608465449907;6032.969835150796;6109.480694141048;6226.3151053385;6232.470240029648;6246.843828904313;4092.976755811047;4159.708820382544;4174.645155161724;4178.122594255119;4198.391233271098;5967.850803729942;5971.402859713994;5987.520998320211;5998.370171132143;6022.633590646746;5716.256886604715;5779.190913272229;5820.359760426434;5820.796272130455;5832.154337621106;5742.511886489695;5787.276590426197;5819.563532734977;5825.126231065374;5826.155207494974;5785.566082543742;5792.21805056312;5793.536517078708;5803.216565763568;5810.970945145247;5735.311762588349;5891.231121372948;5932.940670593239;5955.464008239279;5984.640921544721;5783.219265399117;5791.391903850204;5791.7683292667825;5821.883562328645;5841.474267315962 06:08:25 INFO - PROCESS | 23786 | |5;yui.html;705.8870580707081;725.5247812682693;769.9114601820793;816.2572059425923;833.6860977613985;15344.232788360594;15378.769318460218;15454.1500217488;15458.690826183483;16900;16370.672586548291;17114.31542738292;17159.227834747435;17170.141492925333;17183;669.4610838275187;788.4756636836497;815.787895147263;816.6896579299857;819.4755356571799;802.430274505102;823.2631794543879;823.3618945317367;829.402829962426;830.7258604660448;875.4747151708988;877.0265005843509;877.644553955649;878.8989266234369;880.0671288434248;870.6256309786789;870.7083127152412;871.0853603716073;871.1419252036738;871.9564021798948;632.4086978674908;636.8949123394634;637.1812221295659;637.6970938804031;638.798778384812;15437.459688910834;15536.922315388463;15552.066875987477;15578.143202123878;15656.373745050185;14969.925150374178;14984.400623975029;15060.548183554401;15174.468893588672;15306.846931530765;11894.643160705193;11898.286102833858;11903.94048029763;11926.821097683542;12255.203411778206;3859.3246181918053;3874.8837534874;4010.9598904010877;4055.5741647127215;4069.532003819569;76778.23221767767;76794.61602692006;77701.22298776996;78369.60815195944;78384;11318.773624527463;11337.206395552397;11354.26197297173;11422;11507.482163302671;20580.58838823215;20682.172713091608;20809.89595052015;20842.1663133476;20876.895615521826;8313.750587482386;8459.280961118251;8553.914460855312;8618.095100014534;8744.737657870273;4699.154152252628;4742.644301677319;4764.880877978009;4789.95210047902;4799.3041009053495;3589.066842620937;3668.5597728272246;3714;3730.2539492101687;3734.9439758403646;623.3436231351794;628.9213848268967;631.210986267166;647.2782847125516;650.3626446082865;717.3472140352254;750.951188172767;760.2815339504226;767.2404319723433;769.6998170713426;9745;10353.223508236912;10379.221558383151;10798.190135739851;10983.61557345489;704.3519961635308;737.7036989296437;785.6268272570484;791.9643616037292;809.4374409785261;4779.976100119547;4916.754162291871;5014.423341315723;5030;5130.322323915653;111528;111554.44222778997;112489;113252.43373783078;113474;98436.50781746046;99711.50144249233;100377;100442.49778751205;100797;78123;78842.6057869707;80493;86032.56983715041;90772.54613727021;10290.536925838205;10833.729156771144;10916.890831091587;10997.890021099687;11024.559017639205;50497.24254136117;51911.480885190664;52279.73860130675;52822.73588632032;52989;45089.09821803611;45924.54075459336;68603.3139668597;71295;72426;12664.240145591293;13235.544090149882;13576.59270221895;13753.931230343784;13953.651158721113;15618.843811562194;15649.84350156484;16032.438864640148;16236.67526649484;16600.335986560403;14151.59353994572;14544.49094281695;14578.489752858599;14943.626409339853;15161.772573411186;13765.793513097111;14573.198474084027;15524.767128492857;15747.606309842346;15754.212289385256;12883.162594431333;13109.020983201437;13116.213027218397;13330.343573261347;13603.659908502366;11761.943068997763;11797.587084452003;12152.635420937386;12263.87736122663;12599.433025514058;12041.217320874115;12136.514539418324;12329.50681972711;12662.366881656064;12762.872371276168 06:08:25 INFO - PROCESS | 23786 | __end_tp_report 06:08:25 INFO - PROCESS | 23786 | __start_cc_report 06:08:25 INFO - PROCESS | 23786 | _x_x_mozilla_cycle_collect,381 06:08:25 INFO - PROCESS | 23786 | __end_cc_report 06:08:25 INFO - PROCESS | 23786 | __startTimestamp1469452105261__endTimestamp 06:08:25 INFO - PROCESS | 23786 | 06:08:25 INFO - PROCESS | 23786 | ------- Summary: start ------- 06:08:25 INFO - PROCESS | 23786 | Number of tests: 6 06:08:25 INFO - PROCESS | 23786 | 06:08:25 INFO - PROCESS | 23786 | [#0] dojo.html Cycles:165 Average:5404.86 Median:5635.58 stddev:629.00 (11.2%) stddev-sans-first:603.18 06:08:25 INFO - PROCESS | 23786 | Values: 3049.7 3072.0 3085.3 3094.4 3104.6 5348.9 5376.2 5381.0 5452.5 5476.1 5273.7 5396.1 5396.1 5424.3 5456.0 4901.8 4904.7 4939.0 5017.9 5032.1 4885.4 5016.4 5019.8 5030.6 5035.6 4856.9 4905.6 4919.0 4941.0 4989.5 4854.7 4900.6 4910.3 4945.3 4956.8 4868.5 4874.1 4883.4 4899.0 4930.7 5284.4 5338.7 5348.6 5354.6 5408.9 5811.1 5814.7 5822.3 5845.0 5878.9 5781.3 5810.7 5849.3 5857.5 5858.9 5334.1 5426.7 5450.2 5474.5 5483.3 5959.7 5972.0 6014.6 6049.3 6074.0 5775.0 5784.1 5789.9 5794.0 5794.8 5675.3 5755.6 5884.5 5892.3 5899.0 5636.2 5721.3 5741.2 5808.3 5823.9 5730.9 5773.7 5786.9 5792.1 5813.5 4419.4 4429.9 4433.4 4435.9 4455.0 3849.0 3921.8 3962.5 3963.3 4006.3 5633.7 5647.4 5653.2 5657.2 5665.9 5916.5 5928.2 5942.9 5950.1 5957.1 5504.5 5533.3 5582.7 5597.2 5653.9 5035.9 5054.8 5054.9 5058.7 5063.3 5980.8 6028.0 6031.1 6042.8 6067.0 5797.4 5805.0 5822.4 5866.0 5927.5 5991.6 6022.7 6032.1 6039.3 6046.7 5721.9 5744.8 5752.9 5763.9 5767.3 5691.7 5744.3 5782.2 5794.8 5861.3 5624.8 5625.7 5661.2 5669.5 5670.8 5610.3 5635.6 5649.4 5654.9 5667.8 5459.8 5536.1 5612.5 5633.6 5662.2 5635.5 5696.3 5731.1 5747.2 5775.2 5438.6 5622.5 5623.6 5634.7 5647.9 06:08:25 INFO - PROCESS | 23786 | 06:08:25 INFO - PROCESS | 23786 | [#1] ext.html Cycles:180 Average:56873.71 Median:41563.58 stddev:118552.05 (285.2%) stddev-sans-first:118809.24 06:08:25 INFO - PROCESS | 23786 | Values: 565.2 571.7 579.6 600.5 610.5 38799.4 41985.8 41997.8 42001.6 42116.6 41739.6 42219.6 42302.0 42332.0 42365.4 8853.2 8953.3 8963.2 8969.2 9004.2 8787.9 8874.3 8906.0 8911.4 8913.1 8940.1 8974.1 8999.0 9001.9 9061.4 8849.6 8874.4 8915.1 8952.1 8953.1 8632.6 8672.1 8683.1 8697.5 8702.5 41116.6 41588.8 41647.2 41657.6 41674.0 3736.4 3780.6 3832.9 4002.5 4304.8 32671.6 33421.5 33447.8 33622.3 33717.5 4298.2 4348.2 4372.9 4401.8 4545.6 371354.0 372038.0 372218.0 372833.0 373818.0 33258.0 54991.0 55317.0 55399.2 55428.2 33974.8 35289.8 35410.6 35565.8 35643.0 14431.9 14479.3 14480.7 14519.0 14524.3 11835.4 11872.9 11954.4 11976.8 11988.3 8176.5 8216.6 8290.9 8298.9 8418.4 3233.5 3251.8 3252.1 3263.2 3302.5 976.5 1010.4 1042.9 1099.4 1168.9 30876.0 30980.8 31227.4 31252.8 31560.7 1074.4 1100.6 1106.5 1108.6 1203.1 16880.7 17198.2 17290.5 17316.4 17350.3 153722.0 154420.0 154832.2 605978.0 606110.0 56756.1 56983.1 57063.7 57087.0 57446.4 1320.4 1336.1 1347.8 1357.7 1364.2 30214.0 31735.8 31739.0 32107.0 32270.4 51629.0 56094.0 56177.4 56189.2 56234.4 533363.0 537357.0 537639.0 539864.0 540619.0 27237.9 28370.6 28512.1 29917.3 43330.6 47887.3 48247.8 48507.0 49136.0 49742.3 40219.4 41084.1 41282.6 41538.4 42611.6 42069.0 42329.0 42442.2 42910.8 42967.6 39463.6 40447.6 40828.0 40907.2 43339.8 32977.5 37208.0 37929.2 38451.6 38591.2 28089.7 28147.0 28410.4 28658.9 28966.7 06:08:25 INFO - PROCESS | 23786 | 06:08:25 INFO - PROCESS | 23786 | [#2] jquery.html Cycles:180 Average:29395.70 Median:2724.77 stddev:86109.93 (3160.3%) stddev-sans-first:86323.92 06:08:25 INFO - PROCESS | 23786 | Values: 378.2 383.8 385.9 395.9 415.5 13671.3 18473.5 19129.0 19820.2 19828.6 18398.5 18676.3 19131.0 19731.8 19751.1 5564.3 5699.4 5730.2 5785.5 5834.3 5603.6 5707.8 5736.7 5744.5 5753.4 5533.6 5719.3 5719.9 5725.2 5833.4 5788.8 5817.0 5821.8 6102.4 6336.8 5683.2 5747.9 5848.1 5848.5 5849.4 12680.7 12868.9 13013.1 13277.5 13299.5 2425.4 2563.0 2695.5 2712.4 2737.1 9746.7 9964.5 10137.2 10174.4 10277.1 1880.2 1898.1 1918.8 1924.8 1951.5 74596.0 80931.6 81268.6 81404.2 81940.0 10181.9 10241.6 10262.2 10609.3 10684.6 14029.2 14048.4 14076.4 14093.6 14130.4 7711.5 7925.8 7996.8 8126.8 8176.8 7708.1 7730.3 7789.0 7956.3 8025.3 4429.8 4479.5 4495.1 4533.6 4571.5 1812.3 1879.5 1879.8 1900.1 1948.5 1006.9 1015.5 1033.9 1056.1 1073.3 19518.9 20011.5 20084.8 20092.3 20383.7 969.1 973.8 987.0 1009.4 1016.1 10448.1 11041.7 11135.2 11155.1 11237.8 512007.0 513773.0 514788.0 536281.0 537772.3 90312.0 92446.0 93036.1 93290.5 93325.0 961.8 985.6 992.5 1004.8 1011.2 16807.9 17348.6 17882.0 17955.9 18040.6 27028.3 29470.6 40436.8 40668.8 41228.4 57198.0 58088.0 58246.4 59014.0 59220.7 8324.3 8485.7 8663.6 8735.9 8745.6 12322.4 13205.9 13266.5 13579.9 14333.6 10859.7 10865.0 11236.4 11564.7 12175.6 10415.9 10801.8 10964.5 11071.9 11217.4 11688.9 11950.8 12036.1 12096.3 12292.1 8444.6 8577.0 8609.3 8617.9 8843.2 9708.5 11411.4 11709.9 11795.2 11909.2 06:08:25 INFO - PROCESS | 23786 | 06:08:25 INFO - PROCESS | 23786 | [#3] mootools.html Cycles:180 Average:5860.71 Median:450.99 stddev:3342.94 (741.2%) stddev-sans-first:3336.14 06:08:25 INFO - PROCESS | 23786 | Values: 1484.5 1501.4 1646.9 1735.6 1794.8 7762.8 8501.8 8581.5 9112.8 9138.6 8571.8 8867.7 8872.4 8884.5 8891.6 2351.2 2394.2 2394.2 2396.9 2398.8 2379.6 2383.9 2401.6 2404.2 2410.7 2343.2 2352.8 2355.9 2356.1 2360.1 2267.6 2296.9 2297.3 2302.5 2318.1 2269.2 2282.1 2297.5 2309.7 2318.4 8815.8 8898.5 8904.6 8906.4 8918.6 5077.5 5105.5 5189.4 5282.8 5292.5 3290.5 3441.2 3457.2 3504.6 3521.2 1111.7 1162.2 1163.4 1169.4 1170.2 12274.8 12279.8 12321.8 12325.8 12328.1 4334.8 4576.0 4606.4 4733.1 4739.4 10486.9 10497.7 10501.8 10505.6 10527.0 5246.5 5249.4 5263.0 5272.4 5275.1 4340.8 4791.2 4851.1 4903.4 4944.2 3900.0 4022.5 4046.4 4063.3 4107.4 1263.5 1268.3 1278.7 1284.6 1294.8 867.9 979.3 983.5 987.2 1029.7 5996.1 6018.5 6029.7 6143.1 6197.9 435.5 443.6 445.3 449.2 452.8 4172.7 4190.3 4218.1 4263.7 4306.8 10691.5 10984.2 11126.9 11138.1 11166.4 10541.8 10854.8 10983.1 11012.3 11083.8 8173.8 8396.7 8410.6 8415.8 8425.0 6013.6 6047.4 6097.0 6152.8 6194.7 10091.2 10141.8 10149.0 10183.6 10222.7 9944.6 10161.3 10265.5 10443.7 10476.4 7898.0 7985.1 7996.4 8076.2 8109.6 8687.8 8695.4 8708.0 8718.8 8728.6 7795.0 7842.3 8024.9 8157.6 8213.9 7656.8 7816.2 7892.0 7896.4 7989.4 6913.7 7018.8 7030.9 7048.2 7068.6 5296.9 5326.7 5398.8 5426.7 5463.7 5157.7 5249.0 5271.8 5313.6 5373.5 06:08:25 INFO - PROCESS | 23786 | 06:08:25 INFO - PROCESS | 23786 | [#4] prototype.html Cycles:180 Average:4857.80 Median:5466.17 stddev:1446.45 (26.5%) stddev-sans-first:1409.90 06:08:25 INFO - PROCESS | 23786 | Values: 323.7 332.5 333.4 340.1 342.6 5389.5 5434.4 5522.7 5579.4 5608.7 5475.9 5484.9 5494.1 5504.0 5522.8 4257.5 4270.6 4273.6 4291.8 4325.4 4166.9 4269.2 4308.6 4314.5 4344.5 4229.4 4261.1 4264.8 4269.2 4278.8 4268.1 4282.2 4290.9 4297.4 4309.1 3676.7 3774.5 3782.6 3791.3 3791.5 5372.4 5410.5 5428.8 5436.7 5456.4 4888.5 4911.1 4913.8 4920.6 4925.6 5591.9 5770.8 5795.5 5826.6 5838.6 4094.3 4108.2 4109.3 4114.9 4120.1 5962.8 6027.0 6036.5 6061.6 6092.9 3984.6 4202.9 4204.6 4215.3 4225.5 4250.8 4255.6 4258.7 4263.9 4270.6 4876.7 4900.3 4901.8 4929.0 4973.8 5746.8 5904.9 5924.4 5948.5 5967.0 1469.8 1476.0 1480.8 1481.1 1489.1 898.0 931.7 935.7 954.8 958.4 4973.8 4985.4 5017.7 5040.4 5043.8 5222.6 5243.6 5317.1 5370.6 5393.3 5008.7 5070.7 5086.6 5345.5 5767.0 3199.3 3205.9 3225.7 3228.8 3235.8 6140.8 6254.8 6263.8 6300.9 6301.9 6055.3 6089.6 6102.3 6108.4 6108.4 6207.9 6220.3 6235.6 6251.6 6271.5 5803.3 6009.6 6013.4 6027.0 6043.6 5958.4 5980.4 5987.1 6002.3 6023.6 6033.0 6109.5 6226.3 6232.5 6246.8 4093.0 4159.7 4174.6 4178.1 4198.4 5967.9 5971.4 5987.5 5998.4 6022.6 5716.3 5779.2 5820.4 5820.8 5832.2 5742.5 5787.3 5819.6 5825.1 5826.2 5785.6 5792.2 5793.5 5803.2 5811.0 5735.3 5891.2 5932.9 5955.5 5984.6 5783.2 5791.4 5791.8 5821.9 5841.5 06:08:25 INFO - PROCESS | 23786 | 06:08:25 INFO - PROCESS | 23786 | [#5] yui.html Cycles:180 Average:20670.95 Median:3732.60 stddev:29028.02 (777.7%) stddev-sans-first:29070.74 06:08:25 INFO - PROCESS | 23786 | Values: 705.9 725.5 769.9 816.3 833.7 15344.2 15378.8 15454.2 15458.7 16900.0 16370.7 17114.3 17159.2 17170.1 17183.0 669.5 788.5 815.8 816.7 819.5 802.4 823.3 823.4 829.4 830.7 875.5 877.0 877.6 878.9 880.1 870.6 870.7 871.1 871.1 872.0 632.4 636.9 637.2 637.7 638.8 15437.5 15536.9 15552.1 15578.1 15656.4 14969.9 14984.4 15060.5 15174.5 15306.8 11894.6 11898.3 11903.9 11926.8 12255.2 3859.3 3874.9 4011.0 4055.6 4069.5 76778.2 76794.6 77701.2 78369.6 78384.0 11318.8 11337.2 11354.3 11422.0 11507.5 20580.6 20682.2 20809.9 20842.2 20876.9 8313.8 8459.3 8553.9 8618.1 8744.7 4699.2 4742.6 4764.9 4790.0 4799.3 3589.1 3668.6 3714.0 3730.3 3734.9 623.3 628.9 631.2 647.3 650.4 717.3 751.0 760.3 767.2 769.7 9745.0 10353.2 10379.2 10798.2 10983.6 704.4 737.7 785.6 792.0 809.4 4780.0 4916.8 5014.4 5030.0 5130.3 111528.0 111554.4 112489.0 113252.4 113474.0 98436.5 99711.5 100377.0 100442.5 100797.0 78123.0 78842.6 80493.0 86032.6 90772.5 10290.5 10833.7 10916.9 10997.9 11024.6 50497.2 51911.5 52279.7 52822.7 52989.0 45089.1 45924.5 68603.3 71295.0 72426.0 12664.2 13235.5 13576.6 13753.9 13953.7 15618.8 15649.8 16032.4 16236.7 16600.3 14151.6 14544.5 14578.5 14943.6 15161.8 13765.8 14573.2 15524.8 15747.6 15754.2 12883.2 13109.0 13116.2 13330.3 13603.7 11761.9 11797.6 12152.6 12263.9 12599.4 12041.2 12136.5 12329.5 12662.4 12762.9 06:08:25 INFO - PROCESS | 23786 | -------- Summary: end -------- 06:08:25 INFO - PROCESS | 23786 | 06:08:25 INFO - TEST-INFO | 23786: exit 0 06:08:25 INFO - TEST-OK | dromaeo_css | took 1111767ms 06:08:25 INFO - TEST-START | kraken 06:08:25 INFO - operating with platform_type : linux_ 06:08:26 INFO - Initialising browser for kraken test... 06:08:26 INFO - TEST-INFO | started process 24036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRPu3gc/profile http://localhost:47814/getInfo.html) 06:08:29 INFO - PROCESS | 24036 | JavaScript error: , line 0: uncaught exception: undefined 06:08:30 INFO - PROCESS | 24036 | __metrics Screen width/height:1600/1200 06:08:30 INFO - PROCESS | 24036 | colorDepth:24 06:08:30 INFO - PROCESS | 24036 | Browser inner width/height: 1024/697 06:08:30 INFO - PROCESS | 24036 | __metrics 06:08:31 ERROR - PROCESS | 24036 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 06:08:31 INFO - TEST-INFO | 24036: exit 0 06:08:31 INFO - Browser initialized. 06:08:31 INFO - Running cycle 1/1 for kraken test... 06:08:31 INFO - TEST-INFO | started process 24156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRPu3gc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:43 INFO - PROCESS | 24156 | RSS: Main: 167591936 06:08:43 INFO - PROCESS | 24156 | 06:08:46 INFO - PROCESS | 24156 | Cycle 1(1): loaded http://localhost:47814/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47814/tests/kraken/driver.html?testName=audio-beat-detection) 06:08:47 INFO - PROCESS | 24156 | RSS: Main: 173330432 06:08:47 INFO - PROCESS | 24156 | 06:08:49 INFO - PROCESS | 24156 | Cycle 1(1): loaded http://localhost:47814/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47814/tests/kraken/driver.html?testName=audio-dft) 06:08:50 INFO - PROCESS | 24156 | RSS: Main: 171851776 06:08:50 INFO - PROCESS | 24156 | 06:08:53 INFO - PROCESS | 24156 | Cycle 1(1): loaded http://localhost:47814/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47814/tests/kraken/driver.html?testName=audio-fft) 06:08:54 INFO - PROCESS | 24156 | RSS: Main: 168337408 06:08:54 INFO - PROCESS | 24156 | 06:08:56 INFO - PROCESS | 24156 | Cycle 1(1): loaded http://localhost:47814/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47814/tests/kraken/driver.html?testName=audio-oscillator) 06:08:56 INFO - PROCESS | 24156 | RSS: Main: 168816640 06:08:56 INFO - PROCESS | 24156 | 06:08:59 INFO - PROCESS | 24156 | Cycle 1(1): loaded http://localhost:47814/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47814/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:08:59 INFO - PROCESS | 24156 | RSS: Main: 169517056 06:08:59 INFO - PROCESS | 24156 | 06:09:02 INFO - PROCESS | 24156 | Cycle 1(1): loaded http://localhost:47814/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47814/tests/kraken/driver.html?testName=imaging-darkroom) 06:09:03 INFO - PROCESS | 24156 | RSS: Main: 169734144 06:09:03 INFO - PROCESS | 24156 | 06:09:07 INFO - PROCESS | 24156 | Cycle 1(1): loaded http://localhost:47814/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47814/tests/kraken/driver.html?testName=imaging-desaturate) 06:09:07 INFO - PROCESS | 24156 | RSS: Main: 170397696 06:09:07 INFO - PROCESS | 24156 | 06:09:10 INFO - PROCESS | 24156 | Cycle 1(1): loaded http://localhost:47814/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47814/tests/kraken/driver.html?testName=json-parse-financial) 06:09:11 INFO - PROCESS | 24156 | RSS: Main: 169902080 06:09:11 INFO - PROCESS | 24156 | 06:09:12 INFO - PROCESS | 24156 | Cycle 1(1): loaded http://localhost:47814/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47814/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:09:13 INFO - PROCESS | 24156 | RSS: Main: 169775104 06:09:13 INFO - PROCESS | 24156 | 06:09:15 INFO - PROCESS | 24156 | Cycle 1(1): loaded http://localhost:47814/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47814/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:09:15 INFO - PROCESS | 24156 | RSS: Main: 170180608 06:09:15 INFO - PROCESS | 24156 | 06:09:17 INFO - PROCESS | 24156 | Cycle 1(1): loaded http://localhost:47814/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47814/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:09:18 INFO - PROCESS | 24156 | RSS: Main: 170184704 06:09:18 INFO - PROCESS | 24156 | 06:09:21 INFO - PROCESS | 24156 | Cycle 1(1): loaded http://localhost:47814/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:09:21 INFO - PROCESS | 24156 | RSS: Main: 170287104 06:09:21 INFO - PROCESS | 24156 | 06:09:24 INFO - PROCESS | 24156 | Cycle 1(1): loaded http://localhost:47814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:09:25 INFO - PROCESS | 24156 | RSS: Main: 170565632 06:09:25 INFO - PROCESS | 24156 | 06:09:26 INFO - PROCESS | 24156 | Cycle 1(1): loaded http://localhost:47814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47814/tests/kraken/driver.html?testName=ai-astar) 06:09:26 INFO - PROCESS | 24156 | RSS: Main: 171089920 06:09:26 INFO - PROCESS | 24156 | 06:09:27 INFO - PROCESS | 24156 | __start_tp_report 06:09:27 INFO - PROCESS | 24156 | _x_x_mozilla_page_load 06:09:27 INFO - PROCESS | 24156 | _x_x_mozilla_page_load_details 06:09:27 INFO - PROCESS | 24156 | |i|pagename|runs| 06:09:27 INFO - PROCESS | 24156 | |0;ai-astar;103;115;106;112;112;114;115;115;116;113 06:09:27 INFO - PROCESS | 24156 | |1;audio-beat-detection;155;119;146;184;121;151;152;127;184;123 06:09:27 INFO - PROCESS | 24156 | |2;audio-dft;166;161;161;161;162;165;175;167;162;162 06:09:27 INFO - PROCESS | 24156 | |3;audio-fft;76;76;75;158;77;76;75;76;174;77 06:09:27 INFO - PROCESS | 24156 | |4;audio-oscillator;85;86;152;85;85;84;142;85;84;157 06:09:27 INFO - PROCESS | 24156 | |5;imaging-gaussian-blur;118;125;117;118;117;117;117;118;118;122 06:09:27 INFO - PROCESS | 24156 | |6;imaging-darkroom;147;147;147;148;147;147;147;147;147;147 06:09:27 INFO - PROCESS | 24156 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;95;95 06:09:27 INFO - PROCESS | 24156 | |8;json-parse-financial;51;52;54;52;51;52;51;54;52;52 06:09:27 INFO - PROCESS | 24156 | |9;json-stringify-tinderbox;67;64;65;64;65;64;63;64;64;65 06:09:27 INFO - PROCESS | 24156 | |10;stanford-crypto-aes;76;79;76;76;80;85;76;76;81;75 06:09:27 INFO - PROCESS | 24156 | |11;stanford-crypto-ccm;136;127;127;121;128;124;130;136;162;139 06:09:27 INFO - PROCESS | 24156 | |12;stanford-crypto-pbkdf2;165;157;159;155;161;155;157;154;158;154 06:09:27 INFO - PROCESS | 24156 | |13;stanford-crypto-sha256-iterative;67;63;63;63;65;63;65;64;63;63 06:09:27 INFO - PROCESS | 24156 | __end_tp_report 06:09:27 INFO - PROCESS | 24156 | __start_cc_report 06:09:27 INFO - PROCESS | 24156 | _x_x_mozilla_cycle_collect,935 06:09:27 INFO - PROCESS | 24156 | __end_cc_report 06:09:27 INFO - PROCESS | 24156 | __startTimestamp1469452166998__endTimestamp 06:09:27 INFO - PROCESS | 24156 | 06:09:27 INFO - PROCESS | 24156 | ------- Summary: start ------- 06:09:27 INFO - PROCESS | 24156 | Number of tests: 14 06:09:27 INFO - PROCESS | 24156 | 06:09:27 INFO - PROCESS | 24156 | [#0] ai-astar Cycles:10 Average:112.10 Median:114.50 stddev:4.28 (3.7%) stddev-sans-first:3.02 06:09:27 INFO - PROCESS | 24156 | Values: 103.0 115.0 106.0 112.0 112.0 114.0 115.0 115.0 116.0 113.0 06:09:27 INFO - PROCESS | 24156 | 06:09:27 INFO - PROCESS | 24156 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:151.50 stddev:24.21 (16.0%) stddev-sans-first:25.46 06:09:27 INFO - PROCESS | 24156 | Values: 155.0 119.0 146.0 184.0 121.0 151.0 152.0 127.0 184.0 123.0 06:09:27 INFO - PROCESS | 24156 | 06:09:27 INFO - PROCESS | 24156 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:4.39 (2.7%) stddev-sans-first:4.61 06:09:27 INFO - PROCESS | 24156 | Values: 166.0 161.0 161.0 161.0 162.0 165.0 175.0 167.0 162.0 162.0 06:09:27 INFO - PROCESS | 24156 | 06:09:27 INFO - PROCESS | 24156 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:38.14 (50.2%) stddev-sans-first:39.89 06:09:27 INFO - PROCESS | 24156 | Values: 76.0 76.0 75.0 158.0 77.0 76.0 75.0 76.0 174.0 77.0 06:09:27 INFO - PROCESS | 24156 | 06:09:27 INFO - PROCESS | 24156 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:85.00 stddev:31.84 (37.5%) stddev-sans-first:32.98 06:09:27 INFO - PROCESS | 24156 | Values: 85.0 86.0 152.0 85.0 85.0 84.0 142.0 85.0 84.0 157.0 06:09:27 INFO - PROCESS | 24156 | 06:09:27 INFO - PROCESS | 24156 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:118.00 stddev:2.67 (2.3%) stddev-sans-first:2.82 06:09:27 INFO - PROCESS | 24156 | Values: 118.0 125.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 122.0 06:09:27 INFO - PROCESS | 24156 | 06:09:27 INFO - PROCESS | 24156 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 06:09:27 INFO - PROCESS | 24156 | Values: 147.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 147.0 06:09:27 INFO - PROCESS | 24156 | 06:09:27 INFO - PROCESS | 24156 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:09:27 INFO - PROCESS | 24156 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 06:09:27 INFO - PROCESS | 24156 | 06:09:27 INFO - PROCESS | 24156 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:1.10 (2.1%) stddev-sans-first:1.09 06:09:27 INFO - PROCESS | 24156 | Values: 51.0 52.0 54.0 52.0 51.0 52.0 51.0 54.0 52.0 52.0 06:09:27 INFO - PROCESS | 24156 | 06:09:27 INFO - PROCESS | 24156 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.50 stddev:1.08 (1.7%) stddev-sans-first:0.67 06:09:27 INFO - PROCESS | 24156 | Values: 67.0 64.0 65.0 64.0 65.0 64.0 63.0 64.0 64.0 65.0 06:09:27 INFO - PROCESS | 24156 | 06:09:27 INFO - PROCESS | 24156 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:77.50 stddev:3.20 (4.1%) stddev-sans-first:3.31 06:09:27 INFO - PROCESS | 24156 | Values: 76.0 79.0 76.0 76.0 80.0 85.0 76.0 76.0 81.0 75.0 06:09:27 INFO - PROCESS | 24156 | 06:09:27 INFO - PROCESS | 24156 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:133.00 stddev:11.67 (8.8%) stddev-sans-first:12.33 06:09:27 INFO - PROCESS | 24156 | Values: 136.0 127.0 127.0 121.0 128.0 124.0 130.0 136.0 162.0 139.0 06:09:27 INFO - PROCESS | 24156 | 06:09:27 INFO - PROCESS | 24156 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.50 Median:157.50 stddev:3.47 (2.2%) stddev-sans-first:2.40 06:09:27 INFO - PROCESS | 24156 | Values: 165.0 157.0 159.0 155.0 161.0 155.0 157.0 154.0 158.0 154.0 06:09:27 INFO - PROCESS | 24156 | 06:09:27 INFO - PROCESS | 24156 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:63.50 stddev:1.37 (2.2%) stddev-sans-first:0.88 06:09:27 INFO - PROCESS | 24156 | Values: 67.0 63.0 63.0 63.0 65.0 63.0 65.0 64.0 63.0 63.0 06:09:27 INFO - PROCESS | 24156 | -------- Summary: end -------- 06:09:27 INFO - PROCESS | 24156 | 06:09:27 INFO - TEST-INFO | 24156: exit 0 06:09:27 INFO - TEST-OK | kraken | took 61955ms 06:09:27 INFO - SUITE-END | took 1173s 06:09:28 INFO - Completed test suite (00:19:33) 06:09:28 INFO - javascript benchmark 06:09:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7231.488742720443, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3049.6797836227197, 3072.0323098224067, 3085.336652619688, 3094.350186460843, 3104.6274447066357, 5348.919766203505, 5376.220448035033, 5381.0, 5452.509274165324, 5476.096444086721, 5273.683578985264, 5396.136618141099, 5396.136618141099, 5424.321959755031, 5455.972720136404, 4901.828436004732, 4904.681195722266, 4938.950610493885, 5017.9247311290355, 5032.11937910866, 4885.413750349945, 5016.372953380827, 5019.84940451787, 5030.5975521958335, 5035.597152227813, 4856.927146092811, 4905.583025442842, 4918.950810491885, 4940.97529512352, 4989.501049895, 4854.732989685566, 4900.607951363882, 4910.312556242129, 4945.2829339745895, 4956.776945037482, 4868.537488938545, 4874.147024270738, 4883.389576302962, 4898.962016880306, 4930.679505832145, 5284.445133261029, 5338.652987555796, 5348.572114230852, 5354.571634269249, 5408.864778380533, 5811.128330750379, 5814.738336774855, 5822.301323841124, 5845.035569131088, 5878.882422351572, 5781.335146458169, 5810.680412577307, 5849.327327357366, 5857.531397488191, 5858.912116318259, 5334.146536554172, 5426.67439953604, 5450.182472629137, 5474.479924407175, 5483.287172667568, 5959.672218027963, 5972.044472884318, 6014.6391216527145, 6049.334573196945, 6073.969630151821, 5774.971125144348, 5784.132380143013, 5789.8552536186935, 5794.0, 5794.768209271666, 5675.347335056521, 5755.5683323750045, 5884.47039766423, 5892.263467066617, 5899.026660601038, 5636.18275350072, 5721.256236689287, 5741.224934633771, 5808.332041815245, 5823.912641310384, 5730.885382292414, 5773.740181691834, 5786.855328616734, 5792.1311803229855, 5813.5349172066135, 4419.381286619811, 4429.911401771947, 4433.357163211316, 4435.911281774411, 4454.97535566815, 3849.0, 3921.843126274974, 3962.4848769660334, 3963.3064213762477, 4006.2788698034633, 5633.746481408347, 5647.407022262603, 5653.208550802891, 5657.151427285858, 5665.886682266331, 5916.467517923407, 5928.229330187048, 5942.851428714317, 5950.137230101697, 5957.106434034929, 5504.4770746778995, 5533.335999680065, 5582.720863956786, 5597.188407680945, 5653.858653533694, 5035.899282014339, 5054.7978080876355, 5054.898902022012, 5058.696478211319, 5063.316452278895, 5980.820575382745, 6028.0, 6031.065184896348, 6042.788502402483, 6066.969665151646, 5797.362290148165, 5804.970975145182, 5822.359540450631, 5865.970670146622, 5927.525797936241, 5991.610545314541, 6022.728977196124, 6032.065029920369, 6039.305479869871, 6046.697665116639, 5721.906771437324, 5744.798932037359, 5752.884942301047, 5763.9135412968, 5767.336756273083, 5691.715414229189, 5744.339400968942, 5782.161586570008, 5794.82615521535, 5861.296644402699, 5624.775008999594, 5625.718714064362, 5661.150827375926, 5669.489745922887, 5670.773169073191, 5610.298712660918, 5635.577331700057, 5649.435056494318, 5654.85862853432, 5667.801626943037, 5459.781608735606, 5536.114221724505, 5612.522935550524, 5633.577481688808, 5662.235598194356, 5635.549156067586, 5696.344920334214, 5731.111677689964, 5747.224124743107, 5775.249217601685, 5438.646487978269, 5622.465865742748, 5623.550115990629, 5634.74643641029, 5647.915281270702], "value": 5360.905989660666, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.2347699325197, 571.6627189957925, 579.5913880714095, 600.5255847880175, 610.4993904997904, 38799.41800872989, 41985.7900710496, 41997.79001104994, 42001.57998420022, 42116.57883421165, 41739.58260417395, 42219.577804222026, 42302.0, 42332.0, 42365.36451953215, 8853.203211710961, 8953.328500362466, 8963.193312601865, 8969.237614802749, 9004.189622933935, 8787.912120878773, 8874.29005679544, 8905.955470222672, 8911.420757650732, 8913.064128266536, 8940.10598940104, 8974.102589741038, 8999.0, 9001.909980900205, 9061.411008284473, 8849.601767920427, 8874.423162494417, 8915.063918288584, 8952.060033696498, 8953.149450802164, 8632.611532481053, 8672.089430609822, 8683.088275731083, 8697.52163631, 8702.47785132894, 41116.58883411157, 41588.79205603953, 41647.167056659004, 41657.58342416567, 41674.0, 3736.4021756518828, 3780.640839120279, 3832.8850134495733, 4002.519697636302, 4304.80628371724, 32671.614192654477, 33421.498677519856, 33447.83276083628, 33622.32755344904, 33717.494237586456, 4298.20483210607, 4348.239058164809, 4372.934405983913, 4401.757903315316, 4545.636349092098, 371354.0, 372038.0, 372218.0, 372833.0, 373818.0, 33258.0, 54991.0, 55317.0, 55399.169012464845, 55428.16857747137, 33974.83012584971, 35289.8235508826, 35410.64589354125, 35565.8221708895, 35643.0, 14431.92784036094, 14479.276036198147, 14480.710385792436, 14519.0, 14524.273786310641, 11835.408229588485, 11872.940635296769, 11954.402279885971, 11976.820347694616, 11988.34064126464, 8176.509409435453, 8216.630251638691, 8290.875636865452, 8298.917010829935, 8418.368622353348, 3233.547303377529, 3251.804891706458, 3252.121927079675, 3263.2494526259093, 3302.5211344354934, 976.4629453800381, 1010.3887148275188, 1042.864427624404, 1099.4113505983937, 1168.9064874809994, 30876.0, 30980.845095774377, 31227.37545249082, 31252.843735781174, 31560.684393155774, 1074.387599068539, 1100.5762781329086, 1106.4799544214206, 1108.5676586131415, 1203.1337437045313, 16880.746788798177, 17198.168006033375, 17290.481285561455, 17316.39392621252, 17350.3059877606, 153722.0, 154420.0, 154832.22583887007, 605978.0, 606110.0, 56756.148657770165, 56983.14525282124, 57063.714681426325, 57087.0, 57446.425535744944, 1320.3794216718127, 1336.0714303559128, 1347.8113064171023, 1357.674158202044, 1364.1814911053486, 30214.0, 31735.84132079325, 31739.0, 32107.03678889637, 32270.35459290848, 51629.0, 56094.0, 56177.43822561722, 56189.15716264178, 56234.43765562292, 533363.0, 537357.0, 537639.0, 539864.0, 540619.0, 27237.86381068082, 28370.57444138298, 28512.144635660963, 29917.252068698457, 43330.56669433265, 47887.281690775366, 48247.75876120597, 48507.0, 49136.0, 49742.25386619131, 40219.3967090488, 41084.12411131192, 41282.587174129076, 41538.37692434676, 42611.57388426076, 42069.0, 42329.0, 42442.15115697607, 42910.78544607257, 42967.57032429636, 39463.60536394599, 40447.59552404438, 40828.0, 40907.1818563633, 43339.78330108456, 32977.505337420436, 37208.0, 37929.24141517099, 38451.615483844806, 38591.228175436896, 28089.71910280871, 28147.0, 28410.43179136447, 28658.85670571634, 28966.7103328964], "value": 18810.682382564333, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.16048372612806, 383.80762621836914, 385.866875927805, 395.86540576204084, 415.45367841288703, 13671.316434178301, 18473.538161545966, 19129.0, 19820.207191712332, 19828.60342793145, 18398.540036499093, 18676.252949882022, 19131.0, 19731.816091034547, 19751.111199995998, 5564.276644036279, 5699.373068962411, 5730.226419433386, 5785.508231800302, 5834.27071616048, 5603.635763675348, 5707.801361714024, 5736.684482353469, 5744.511716504102, 5753.424657534234, 5533.584981126412, 5719.28508936383, 5719.857003574903, 5725.198472213893, 5833.3874943130995, 5788.797392091277, 5817.0, 5821.767129314843, 6102.359252278491, 6336.841578960517, 5683.232763576905, 5747.885042299173, 5848.064309710426, 5848.502877255439, 5849.38581448946, 12680.74638507234, 12868.87131128686, 13013.08908376414, 13277.535286264934, 13299.468021279137, 2425.3936515871032, 2562.9871850640816, 2695.4609078184244, 2712.403271280315, 2737.137801592512, 9746.658866939693, 9964.501774911225, 10137.239707022003, 10174.389536627827, 10277.126444252248, 1880.2479008396751, 1898.0509745127436, 1918.7985261547615, 1924.8363889069446, 1951.4535929939639, 74596.0, 80931.5953420235, 81268.59365703134, 81404.18595814025, 81940.0, 10181.898181018096, 10241.641542545975, 10262.230332725076, 10609.310394824312, 10684.572617095384, 14029.22839243831, 14048.438062477386, 14076.436942522389, 14093.647658808406, 14130.434782608787, 7711.498752581177, 7925.801854953557, 7996.80007999793, 8126.796830079295, 8176.754697359089, 7708.075030996316, 7730.342920851678, 7789.0, 7956.283934445928, 8025.2777250047775, 4429.7785110744335, 4479.462464504215, 4495.100979804052, 4533.614642755337, 4571.497135315112, 1812.275089964025, 1879.5489082620072, 1879.821416965386, 1900.097453709477, 1948.5420926082359, 1006.9345492543108, 1015.5125539740966, 1033.9172866170688, 1056.1128651932413, 1073.2755390111643, 19518.902405487883, 20011.49971250701, 20084.799152008585, 20092.296769612993, 20383.694244586342, 969.0793745941384, 973.8393165127675, 987.0425687083517, 1009.4044513736784, 1016.1362841584594, 10448.145689458675, 11041.668749937515, 11135.220534562503, 11155.107591392669, 11237.831432528355, 512007.0, 513773.0, 514788.0, 536281.0, 537772.3111384496, 90312.0, 92446.0, 93036.06963930275, 93290.53354733318, 93325.0, 961.8268711631973, 985.605757696927, 992.4690290694588, 1004.8492726091145, 1011.1910471622673, 16807.915960420607, 17348.566285842953, 17882.0, 17955.910220448815, 18040.639187216446, 27028.32429189286, 29470.557941631323, 40436.79781601073, 40668.79665601653, 41228.38157427701, 57198.0, 58088.0, 58246.41753582579, 59014.0, 59220.70389648024, 8324.25081742646, 8485.745427637181, 8663.6101375437, 8735.868961965449, 8745.60644770974, 12322.383880806103, 13205.933970330087, 13266.46934122663, 13579.932100339434, 14333.64165895861, 10859.728506787393, 10865.0, 11236.381998990135, 11564.710882228012, 12175.57385491539, 10415.94792026035, 10801.783964320826, 10964.451777411257, 11071.889281107085, 11217.383043932661, 11688.94155529217, 11950.760984780081, 12036.097292703258, 12096.274223546616, 12292.139550231397, 8444.577771111297, 8577.0, 8609.268212202032, 8617.913820861962, 8843.214387467928, 9708.466034368177, 11411.429428528707, 11709.88290117122, 11795.174337796272, 11909.166358354832], "value": 9015.79951024435, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1484.4952716076534, 1501.3919362658123, 1646.8600168985636, 1735.5834599696077, 1794.8205179482054, 7762.7671169865, 8501.78745531362, 8581.485110893344, 9112.817743645122, 9138.634454621815, 8571.828563428744, 8867.73396798097, 8872.37893347466, 8884.511351875644, 8891.555422228896, 2351.200591798788, 2394.1500767227644, 2394.197943688858, 2396.940076498084, 2398.760123987605, 2379.6192609182535, 2383.8688872112025, 2401.6157414813633, 2404.1945948107405, 2410.650455683925, 2343.238447504568, 2352.776486233805, 2355.9411014724596, 2356.0693526057285, 2360.0677732295735, 2267.614505534055, 2296.9310920672406, 2297.2993237062688, 2302.527981763743, 2318.0959425823944, 2269.1830940861278, 2282.132789539981, 2297.4715815362392, 2309.722833260003, 2318.4435735423376, 8815.779605509913, 8898.510581918057, 8904.643814247422, 8906.421082629608, 8918.643254269822, 5077.49225077493, 5105.5149760772665, 5189.3772747270195, 5282.81510147143, 5292.470752924715, 3290.5064240364136, 3441.2429265561536, 3457.170279133015, 3504.5969713483023, 3521.2429327694413, 1111.7387413957713, 1162.2038903351147, 1163.4182908545727, 1169.4386694386742, 1170.2159553099443, 12274.815877761841, 12279.815802763054, 12321.75356492874, 12325.753484930252, 12328.07539434546, 4334.761588112621, 4576.039031803359, 4606.447226332862, 4733.100710864925, 4739.3838800955655, 10486.947565262124, 10497.737556561147, 10501.842472362921, 10505.632302869362, 10527.0, 5246.501582349671, 5249.448807875195, 5262.97368513155, 5272.420033796279, 5275.050490911673, 4340.76125813077, 4791.233402655628, 4851.126797176472, 4903.362562866804, 4944.159492886218, 3899.9610003899597, 4022.4971878515184, 4046.433499310099, 4063.349864021742, 4107.383892416102, 1263.5009171377437, 1268.2707443220186, 1278.7058976435285, 1284.5953524639895, 1294.8251985981772, 867.8654808504566, 979.3046936674898, 983.5033308179324, 987.1609132237684, 1029.711680729397, 5996.13056106862, 6018.458338749533, 6029.728662210124, 6143.109249158847, 6197.876042479215, 435.4752523209525, 443.59411138807627, 445.3119929708608, 449.17576247585396, 452.80303068164795, 4172.687048471377, 4190.266703326905, 4218.135282267128, 4263.744175349489, 4306.849260275875, 10691.518881650345, 10984.231103822816, 11126.944365278121, 11138.053265472363, 11166.385848778233, 10541.789164216827, 10854.837177442345, 10983.121350291958, 11012.284201527036, 11083.833742493869, 8173.75478735627, 8396.748097557083, 8410.621522031523, 8415.831683366298, 8425.0, 6013.639181649115, 6047.395260474093, 6096.969515152396, 6152.815415537541, 6194.650662078694, 10091.243156763125, 10141.84787228207, 10149.0, 10183.592656293666, 10222.693319200436, 9944.552495137592, 10161.288709790244, 10265.486725663537, 10443.686689399026, 10476.371417714961, 7897.960510197412, 7985.121636619851, 7996.3602911768085, 8076.152004039726, 8109.635066422144, 8687.826243475221, 8695.434796738191, 8708.0, 8718.82562348762, 8728.563571821256, 7795.0, 7842.254985776342, 8024.919750802417, 8157.6329065193395, 8213.876791848246, 7656.770296891103, 7816.218378162138, 7892.0, 7896.447248692536, 7989.360851132012, 6913.723451062102, 7018.75434359795, 7030.894536581853, 7048.154221493453, 7068.5758854468895, 5296.920546191733, 5326.680399176062, 5398.838034858961, 5426.67439953604, 5463.72681365938, 5157.742112894415, 5248.973755131353, 5271.78912843482, 5313.628046036741, 5373.516383525502], "value": 4608.019418770976, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.6682400539448, 332.4796693175181, 333.3815771743416, 340.0665174097103, 342.6060030964389, 5389.541888939445, 5434.429384914576, 5522.668639881605, 5579.386267510576, 5608.653923058472, 5475.945240547593, 5484.890302193954, 5494.148406996912, 5504.0, 5522.784987302797, 4257.467311767753, 4270.594293542124, 4273.594008569181, 4291.785410729467, 4325.372820940962, 4166.916661666764, 4269.231538323101, 4308.569143085682, 4314.525402205771, 4344.543822898598, 4229.407882896397, 4261.061217146206, 4264.765437900915, 4269.167512335096, 4278.828846846122, 4268.061026574149, 4282.207791558556, 4290.892727681801, 4297.39836422901, 4309.11663109065, 3676.6507181817683, 3774.471573979645, 3782.5650050244026, 3791.298609757204, 3791.50710407648, 5372.355317361941, 5410.5401040911565, 5428.782848686048, 5436.728163591804, 5456.399796022434, 4888.486708895586, 4911.140550403665, 4913.754312284372, 4920.5571498565305, 4925.581325587329, 5591.8881622367735, 5770.826875193751, 5795.478406943354, 5826.592138550303, 5838.649681019152, 4094.28350038745, 4108.219438306712, 4109.260333140033, 4114.938275925863, 4120.114175452262, 5962.791302304442, 6026.969865150646, 6036.547258955596, 6061.636301821861, 6092.939070609282, 3984.621460961204, 4202.936955945664, 4204.62158405745, 4215.262329092397, 4225.471816022997, 4250.829966801293, 4255.5957184067465, 4258.723182993095, 4263.914721705549, 4270.594293542109, 4876.707397556158, 4900.313956046157, 4901.779419926112, 4929.0, 4973.751312434364, 5746.770129194869, 5904.881902361929, 5924.407559244041, 5948.494377977834, 5966.985612445895, 1469.8089248397853, 1476.0258229568433, 1480.8445113263167, 1481.1335368809152, 1489.113977183574, 898.0166717444388, 931.6552875436132, 935.7473482159779, 954.7756277274835, 958.4488918871676, 4973.776180071905, 4985.354832905133, 5017.698938063655, 5040.445550989388, 5043.84868453947, 5222.634415590948, 5243.5542978847225, 5317.085849094323, 5370.570354371641, 5393.305585673826, 5008.724520151427, 5070.65627608684, 5086.583872660457, 5345.54562862161, 5766.971165144148, 3199.2961548459302, 3205.909990603206, 3225.7258133058485, 3228.773066234816, 3235.7734958553146, 6140.785072522441, 6254.781082662085, 6263.812085637438, 6300.873982520324, 6301.905471417932, 6055.303640081359, 6089.604175728564, 6102.328743838174, 6108.35862234459, 6108.35862234459, 6207.937920620736, 6220.284667263232, 6235.594686345464, 6251.593646412968, 6271.498280137669, 5803.303603567599, 6009.609375390585, 6013.428724271363, 6027.0, 6043.576949613484, 5958.361450601119, 5980.372060933713, 5987.131865879336, 6002.2893475359315, 6023.608465449907, 6032.969835150796, 6109.480694141048, 6226.3151053385, 6232.470240029648, 6246.843828904313, 4092.976755811047, 4159.708820382544, 4174.645155161724, 4178.122594255119, 4198.391233271098, 5967.850803729942, 5971.402859713994, 5987.520998320211, 5998.370171132143, 6022.633590646746, 5716.256886604715, 5779.190913272229, 5820.359760426434, 5820.796272130455, 5832.154337621106, 5742.511886489695, 5787.276590426197, 5819.563532734977, 5825.126231065374, 5826.155207494974, 5785.566082543742, 5792.21805056312, 5793.536517078708, 5803.216565763568, 5810.970945145247, 5735.311762588349, 5891.231121372948, 5932.940670593239, 5955.464008239279, 5984.640921544721, 5783.219265399117, 5791.391903850204, 5791.7683292667825, 5821.883562328645, 5841.474267315962], "value": 4391.8810828061905, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.8870580707081, 725.5247812682693, 769.9114601820793, 816.2572059425923, 833.6860977613985, 15344.232788360594, 15378.769318460218, 15454.1500217488, 15458.690826183483, 16900.0, 16370.672586548291, 17114.31542738292, 17159.227834747435, 17170.141492925333, 17183.0, 669.4610838275187, 788.4756636836497, 815.787895147263, 816.6896579299857, 819.4755356571799, 802.430274505102, 823.2631794543879, 823.3618945317367, 829.402829962426, 830.7258604660448, 875.4747151708988, 877.0265005843509, 877.644553955649, 878.8989266234369, 880.0671288434248, 870.6256309786789, 870.7083127152412, 871.0853603716073, 871.1419252036738, 871.9564021798948, 632.4086978674908, 636.8949123394634, 637.1812221295659, 637.6970938804031, 638.798778384812, 15437.459688910834, 15536.922315388463, 15552.066875987477, 15578.143202123878, 15656.373745050185, 14969.925150374178, 14984.400623975029, 15060.548183554401, 15174.468893588672, 15306.846931530765, 11894.643160705193, 11898.286102833858, 11903.94048029763, 11926.821097683542, 12255.203411778206, 3859.3246181918053, 3874.8837534874, 4010.9598904010877, 4055.5741647127215, 4069.532003819569, 76778.23221767767, 76794.61602692006, 77701.22298776996, 78369.60815195944, 78384.0, 11318.773624527463, 11337.206395552397, 11354.26197297173, 11422.0, 11507.482163302671, 20580.58838823215, 20682.172713091608, 20809.89595052015, 20842.1663133476, 20876.895615521826, 8313.750587482386, 8459.280961118251, 8553.914460855312, 8618.095100014534, 8744.737657870273, 4699.154152252628, 4742.644301677319, 4764.880877978009, 4789.95210047902, 4799.3041009053495, 3589.066842620937, 3668.5597728272246, 3714.0, 3730.2539492101687, 3734.9439758403646, 623.3436231351794, 628.9213848268967, 631.210986267166, 647.2782847125516, 650.3626446082865, 717.3472140352254, 750.951188172767, 760.2815339504226, 767.2404319723433, 769.6998170713426, 9745.0, 10353.223508236912, 10379.221558383151, 10798.190135739851, 10983.61557345489, 704.3519961635308, 737.7036989296437, 785.6268272570484, 791.9643616037292, 809.4374409785261, 4779.976100119547, 4916.754162291871, 5014.423341315723, 5030.0, 5130.322323915653, 111528.0, 111554.44222778997, 112489.0, 113252.43373783078, 113474.0, 98436.50781746046, 99711.50144249233, 100377.0, 100442.49778751205, 100797.0, 78123.0, 78842.6057869707, 80493.0, 86032.56983715041, 90772.54613727021, 10290.536925838205, 10833.729156771144, 10916.890831091587, 10997.890021099687, 11024.559017639205, 50497.24254136117, 51911.480885190664, 52279.73860130675, 52822.73588632032, 52989.0, 45089.09821803611, 45924.54075459336, 68603.3139668597, 71295.0, 72426.0, 12664.240145591293, 13235.544090149882, 13576.59270221895, 13753.931230343784, 13953.651158721113, 15618.843811562194, 15649.84350156484, 16032.438864640148, 16236.67526649484, 16600.335986560403, 14151.59353994572, 14544.49094281695, 14578.489752858599, 14943.626409339853, 15161.772573411186, 13765.793513097111, 14573.198474084027, 15524.767128492857, 15747.606309842346, 15754.212289385256, 12883.162594431333, 13109.020983201437, 13116.213027218397, 13330.343573261347, 13603.659908502366, 11761.943068997763, 11797.587084452003, 12152.635420937386, 12263.87736122663, 12599.433025514058, 12041.217320874115, 12136.514539418324, 12329.50681972711, 12662.366881656064, 12762.872371276168], "value": 7771.654570851474, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 106.0, 112.0, 112.0, 114.0, 115.0, 115.0, 116.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 119.0, 146.0, 184.0, 121.0, 151.0, 152.0, 127.0, 184.0, 123.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 161.0, 161.0, 161.0, 162.0, 165.0, 175.0, 167.0, 162.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 158.0, 77.0, 76.0, 75.0, 76.0, 174.0, 77.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 152.0, 85.0, 85.0, 84.0, 142.0, 85.0, 84.0, 157.0], "value": 104.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 125.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 122.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 54.0, 52.0, 51.0, 52.0, 51.0, 54.0, 52.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 65.0, 64.0, 65.0, 64.0, 63.0, 64.0, 64.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 76.0, 80.0, 85.0, 76.0, 76.0, 81.0, 75.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 127.0, 127.0, 121.0, 128.0, 124.0, 130.0, 136.0, 162.0, 139.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 157.0, 159.0, 155.0, 161.0, 155.0, 157.0, 154.0, 158.0, 154.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 63.0, 63.0, 65.0, 63.0, 65.0, 64.0, 63.0, 63.0], "value": 63.9, "unit": "score"}]}]} 06:09:28 INFO - Return code: 0 06:09:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:09:28 ERROR - # TBPL SUCCESS # 06:09:28 INFO - Running post-action listener: _resource_record_post_action 06:09:28 INFO - [mozharness: 2016-07-25 13:09:28.293564Z] Finished run-tests step (success) 06:09:28 INFO - Running post-run listener: _resource_record_post_run 06:09:28 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 566968320; Read time: 40; Write time: 519264 06:09:28 INFO - TinderboxPrint: CPU usage
13.3% 06:09:28 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 40 06:09:28 INFO - TinderboxPrint: I/O write bytes / time
566,968,320 / 519,264 06:09:28 INFO - TinderboxPrint: CPU idle
8,233.6 (86.6%) 06:09:28 INFO - TinderboxPrint: CPU user
1,212.8 (12.8%) 06:09:28 INFO - TinderboxPrint: Swap in / out
0 / 0 06:09:28 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 271777792; Read time: 0; Write time: 274044 06:09:28 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295190528; Read time: 24; Write time: 245220 06:09:28 INFO - Running post-run listener: _upload_blobber_files 06:09:28 INFO - Blob upload gear active. 06:09:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:09:28 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 06:09:28 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'] 06:09:28 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 06:09:29 INFO - (blobuploader) - INFO - Open directory for files ... 06:09:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:09:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:09:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:55 INFO - (blobuploader) - INFO - Done attempting. 06:09:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:09:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:09:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:55 INFO - (blobuploader) - INFO - Done attempting. 06:09:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:09:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:09:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:56 INFO - (blobuploader) - INFO - Done attempting. 06:09:56 INFO - (blobuploader) - INFO - Iteration through files over. 06:09:56 INFO - Return code: 0 06:09:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:09:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:09:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8f72ad4dd99ad1da6b1e73850ac9bca28f578ef849ba974bc1602b1b4a91c994402fa148247c93195ff6132dd1aca3c581896be8c3bd0d42355f0a845395f4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/318c1c52bad7167eae108c68849f7b814e02cc40b7e89353f1913f1fecdd8caa29983b9f075b6a7ab505a0f5b7ead3f34b25208f7631cbfbdbc7787dd02f611b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/763655fff9a0ae1bdadf93a6414d086d4674c203411ffb269e8b46ce70d5b5457b9563f934f327635f379512dc4ec27fe4db1fadfe9800fc0bd94771c1f4219e"} 06:09:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:09:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:09:56 INFO - Contents: 06:09:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8f72ad4dd99ad1da6b1e73850ac9bca28f578ef849ba974bc1602b1b4a91c994402fa148247c93195ff6132dd1aca3c581896be8c3bd0d42355f0a845395f4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/318c1c52bad7167eae108c68849f7b814e02cc40b7e89353f1913f1fecdd8caa29983b9f075b6a7ab505a0f5b7ead3f34b25208f7631cbfbdbc7787dd02f611b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/763655fff9a0ae1bdadf93a6414d086d4674c203411ffb269e8b46ce70d5b5457b9563f934f327635f379512dc4ec27fe4db1fadfe9800fc0bd94771c1f4219e"} 06:09:56 INFO - Running post-run listener: copy_logs_to_upload_dir 06:09:56 INFO - Copying logs to upload dir... 06:09:56 INFO - mkdir: /builds/slave/test/build/upload/logs 06:09:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.715946 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-25 06:09:56.610666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 06:09:56.614668) ========= 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=03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8f72ad4dd99ad1da6b1e73850ac9bca28f578ef849ba974bc1602b1b4a91c994402fa148247c93195ff6132dd1aca3c581896be8c3bd0d42355f0a845395f4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/318c1c52bad7167eae108c68849f7b814e02cc40b7e89353f1913f1fecdd8caa29983b9f075b6a7ab505a0f5b7ead3f34b25208f7631cbfbdbc7787dd02f611b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/763655fff9a0ae1bdadf93a6414d086d4674c203411ffb269e8b46ce70d5b5457b9563f934f327635f379512dc4ec27fe4db1fadfe9800fc0bd94771c1f4219e"} build_url:https://queue.taskcluster.net/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/Of-EwqGdQRez2OHfCWQMLA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8f72ad4dd99ad1da6b1e73850ac9bca28f578ef849ba974bc1602b1b4a91c994402fa148247c93195ff6132dd1aca3c581896be8c3bd0d42355f0a845395f4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/318c1c52bad7167eae108c68849f7b814e02cc40b7e89353f1913f1fecdd8caa29983b9f075b6a7ab505a0f5b7ead3f34b25208f7631cbfbdbc7787dd02f611b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/763655fff9a0ae1bdadf93a6414d086d4674c203411ffb269e8b46ce70d5b5457b9563f934f327635f379512dc4ec27fe4db1fadfe9800fc0bd94771c1f4219e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 06:09:56.643106) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:09:56.643580) ========= 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=03627c79f6bb3d1578c4a402000001ba-1469448840.802888-758712159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 06:09:56.730755) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 06:09:56.731174) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 06:09:56.731515) ========= ========= Total master_lag: 0.19 =========