builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1467770649.45 results: success (0) buildid: 20160705163017 builduid: 08eae0dd4fe24f2b883a0f218339cbee revision: 9b428173a0889f5a25e7a6e855f2d1726207a723 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 19:04:09.453616) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 19:04:09.454503) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 19:04:09.454843) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 19:04:09.500729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:04:09.501232) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 19:04:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-07-05 19:04:09 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141121 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:04:09.687063) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:04:09.687774) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.084616 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:04:09.787791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:04:09.788708) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9b428173a0889f5a25e7a6e855f2d1726207a723 --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 9b428173a0889f5a25e7a6e855f2d1726207a723 --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=516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 19:04:09,749 truncating revision to first 12 chars 2016-07-05 19:04:09,749 Setting DEBUG logging. 2016-07-05 19:04:09,749 attempt 1/10 2016-07-05 19:04:09,749 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9b428173a088?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 19:04:10,054 unpacking tar archive at: mozilla-central-9b428173a088/testing/mozharness/ program finished with exit code 0 elapsedTime=0.707743 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:04:10.513981) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 19:04:10.514835) ========= script_repo_revision: 9b428173a0889f5a25e7a6e855f2d1726207a723 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 19:04:10.515872) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 19:04:10.516600) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 19:04:10.534353) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-05 19:04:10.534914) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:04:10 INFO - MultiFileLogger online at 20160705 19:04:10 in /builds/slave/test 19:04:10 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 19:04:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:04:10 INFO - {'append_to_log': False, 19:04:10 INFO - 'base_work_dir': '/builds/slave/test', 19:04:10 INFO - 'blob_upload_branch': 'Firefox', 19:04:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:04:10 INFO - 'branch': 'Firefox', 19:04:10 INFO - 'buildbot_json_path': 'buildprops.json', 19:04:10 INFO - 'config_files': ('talos/linux_config.py',), 19:04:10 INFO - 'default_actions': ('clobber', 19:04:10 INFO - 'read-buildbot-config', 19:04:10 INFO - 'download-and-extract', 19:04:10 INFO - 'populate-webroot', 19:04:10 INFO - 'create-virtualenv', 19:04:10 INFO - 'install', 19:04:10 INFO - 'run-tests'), 19:04:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:04:10 INFO - 'download_minidump_stackwalk': True, 19:04:10 INFO - 'download_symbols': 'ondemand', 19:04:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:04:10 INFO - 'tooltool.py': '/tools/tooltool.py', 19:04:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:04:10 INFO - '/tools/misc-python/virtualenv.py')}, 19:04:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:04:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:04:10 INFO - 'installer_path': 'installer.exe', 19:04:10 INFO - 'log_level': 'info', 19:04:10 INFO - 'log_name': 'talos', 19:04:10 INFO - 'log_to_console': True, 19:04:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:04:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:04:10 INFO - 'opt_config_files': (), 19:04:10 INFO - 'pip_index': False, 19:04:10 INFO - 'sps_profile': False, 19:04:10 INFO - 'sps_profile_interval': 0, 19:04:10 INFO - 'suite': 'dromaeojs-e10s', 19:04:10 INFO - 'system_bits': '32', 19:04:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:04:10 INFO - 'title': 'talos-linux64-ix-061', 19:04:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:04:10 INFO - 'use_talos_json': True, 19:04:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:04:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:04:10 INFO - 'work_dir': 'build'} 19:04:10 INFO - ##### 19:04:10 INFO - ##### Running clobber step. 19:04:10 INFO - ##### 19:04:10 INFO - Running pre-action listener: _resource_record_pre_action 19:04:10 INFO - Running main action method: clobber 19:04:10 INFO - rmtree: /builds/slave/test/build 19:04:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:04:11 INFO - Running post-action listener: _resource_record_post_action 19:04:11 INFO - ##### 19:04:11 INFO - ##### Finished clobber step (success) 19:04:11 INFO - ##### 19:04:11 INFO - ##### 19:04:11 INFO - ##### Running read-buildbot-config step. 19:04:11 INFO - ##### 19:04:11 INFO - Running pre-action listener: _resource_record_pre_action 19:04:11 INFO - Running main action method: read_buildbot_config 19:04:11 INFO - Using buildbot properties: 19:04:11 INFO - { 19:04:11 INFO - "project": "", 19:04:11 INFO - "product": "firefox", 19:04:11 INFO - "script_repo_revision": "production", 19:04:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:04:11 INFO - "repository": "", 19:04:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:04:11 INFO - "buildid": "20160705163017", 19:04:11 INFO - "pgo_build": "True", 19:04:11 INFO - "basedir": "/builds/slave/test", 19:04:11 INFO - "buildnumber": 77, 19:04:11 INFO - "slavename": "talos-linux64-ix-061", 19:04:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:04:11 INFO - "platform": "ubuntu64_hw", 19:04:11 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:04:11 INFO - "branch": "mozilla-central", 19:04:11 INFO - "repo_path": "mozilla-central", 19:04:11 INFO - "revision": "9b428173a0889f5a25e7a6e855f2d1726207a723", 19:04:11 INFO - "stage_platform": "linux64-pgo", 19:04:11 INFO - "builduid": "08eae0dd4fe24f2b883a0f218339cbee", 19:04:11 INFO - "slavebuilddir": "test" 19:04:11 INFO - } 19:04:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:04:11 INFO - Running post-action listener: _resource_record_post_action 19:04:11 INFO - ##### 19:04:11 INFO - ##### Finished read-buildbot-config step (success) 19:04:11 INFO - ##### 19:04:11 INFO - ##### 19:04:11 INFO - ##### Running download-and-extract step. 19:04:11 INFO - ##### 19:04:11 INFO - Running pre-action listener: _resource_record_pre_action 19:04:11 INFO - Running main action method: download_and_extract 19:04:11 INFO - mkdir: /builds/slave/test/build/tests 19:04:11 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')]} 19:04:11 INFO - https://queue.taskcluster.net/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:04:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:04:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:04:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/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 19:04:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/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 19:04:13 INFO - Downloaded 1361 bytes. 19:04:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:04:13 INFO - Using the following test package requirements: 19:04:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:04:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:04:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:04:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:13 INFO - u'jsshell-linux-x86_64.zip'], 19:04:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:04:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:04:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:04:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:04:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:04:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:04:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:04:13 INFO - https://queue.taskcluster.net/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:04:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:04:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:04:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/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 19:04:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/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 19:04:17 INFO - Downloaded 24300513 bytes. 19:04:17 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'] 19:04:17 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 19:04:18 INFO - Return code: 0 19:04:18 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 19:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:04:18 INFO - https://queue.taskcluster.net/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:04:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:04:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:04:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/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 19:04:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/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 19:04:33 INFO - Downloaded 24300513 bytes. 19:04:33 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'] 19:04:33 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 19:04:35 INFO - Return code: 0 19:04: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')]} 19:04:35 INFO - https://queue.taskcluster.net/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:04:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:04:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:04:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/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 19:04:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/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 19:04:36 INFO - Downloaded 14403333 bytes. 19:04:36 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'] 19:04:36 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 19:04:36 INFO - Return code: 0 19:04: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')]} 19:04:36 INFO - https://queue.taskcluster.net/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:04:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:04:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:04:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/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 19:04:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYco3xR4S3ew0u5cels8WQ/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 19:04:39 INFO - Downloaded 60381489 bytes. 19:04:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:04:39 INFO - mkdir: /builds/slave/test/properties 19:04:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:04:39 INFO - Writing to file /builds/slave/test/properties/build_url 19:04:39 INFO - Contents: 19:04:39 INFO - build_url:https://queue.taskcluster.net/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:04:39 INFO - Running post-action listener: _resource_record_post_action 19:04:39 INFO - Running post-action listener: set_extra_try_arguments 19:04:39 INFO - ##### 19:04:39 INFO - ##### Finished download-and-extract step (success) 19:04:39 INFO - ##### 19:04:39 INFO - ##### 19:04:39 INFO - ##### Running populate-webroot step. 19:04:39 INFO - ##### 19:04:39 INFO - Running pre-action listener: _resource_record_pre_action 19:04:39 INFO - Running main action method: populate_webroot 19:04:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:04:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:04:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:04:39 INFO - '--tppagecycles', 19:04:39 INFO - '7'], 19:04:39 INFO - 'tests': ['tsvgm']}}, 19:04:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:04:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:04:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:04:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:04:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:04:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:04:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:39 INFO - 'talos_options': ['--disable-e10s'], 19:04:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:04:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:04:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:39 INFO - 'talos_options': ['--disable-e10s'], 19:04:39 INFO - 'tests': ['damp', 'tps']}, 19:04:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:39 INFO - 'tests': ['damp', 'tps']}, 19:04:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:04:39 INFO - 'tests': ['dromaeo_dom']}, 19:04:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:04:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:04:39 INFO - 'tests': ['basic_compositor_video']}, 19:04:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:04:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:04:39 INFO - 'tests': ['a11yr', 19:04:39 INFO - 'ts_paint', 19:04:39 INFO - 'tpaint', 19:04:39 INFO - 'sessionrestore', 19:04:39 INFO - 'sessionrestore_no_auto_restore', 19:04:39 INFO - 'tabpaint']}, 19:04:39 INFO - 'other-e10s': {'tests': ['a11yr', 19:04:39 INFO - 'ts_paint', 19:04:39 INFO - 'tpaint', 19:04:39 INFO - 'sessionrestore', 19:04:39 INFO - 'sessionrestore_no_auto_restore', 19:04:39 INFO - 'tabpaint']}, 19:04:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:04:39 INFO - 'ts_paint', 19:04:39 INFO - 'tpaint', 19:04:39 INFO - 'sessionrestore', 19:04:39 INFO - 'sessionrestore_no_auto_restore', 19:04:39 INFO - 'tabpaint']}, 19:04:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:04:39 INFO - 'ts_paint', 19:04:39 INFO - 'tpaint', 19:04:39 INFO - 'sessionrestore', 19:04:39 INFO - 'sessionrestore_no_auto_restore', 19:04:39 INFO - 'tabpaint']}, 19:04:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:04:39 INFO - 'tests': ['a11yr', 19:04:39 INFO - 'ts_paint', 19:04:39 INFO - 'tpaint', 19:04:39 INFO - 'sessionrestore', 19:04:39 INFO - 'sessionrestore_no_auto_restore', 19:04:39 INFO - 'tabpaint']}, 19:04:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:04:39 INFO - 'tests': ['a11yr', 19:04:39 INFO - 'ts_paint', 19:04:39 INFO - 'tpaint', 19:04:39 INFO - 'sessionrestore', 19:04:39 INFO - 'sessionrestore_no_auto_restore', 19:04:39 INFO - 'tabpaint']}, 19:04:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:04:39 INFO - 'tests': ['tsvgx', 19:04:39 INFO - 'tsvgr_opacity', 19:04:39 INFO - 'tart', 19:04:39 INFO - 'tscrollx', 19:04:39 INFO - 'cart']}, 19:04:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:04:39 INFO - 'tsvgr_opacity', 19:04:39 INFO - 'tart', 19:04:39 INFO - 'tscrollx', 19:04:39 INFO - 'cart']}, 19:04:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:39 INFO - 'talos_options': ['--disable-e10s'], 19:04:39 INFO - 'tests': ['tp5o']}, 19:04:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:39 INFO - 'tests': ['tp5o']}, 19:04:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:39 INFO - 'talos_options': ['--disable-e10s', 19:04:39 INFO - '--xperf_path', 19:04:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:04:39 INFO - 'tests': ['tp5n']}, 19:04:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:39 INFO - 'talos_options': ['--xperf_path', 19:04:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:04:39 INFO - 'tests': ['tp5n']}}, 19:04:39 INFO - 'talos.zip': {'path': '', 19:04:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:04:39 INFO - Running post-action listener: _resource_record_post_action 19:04:39 INFO - ##### 19:04:39 INFO - ##### Finished populate-webroot step (success) 19:04:39 INFO - ##### 19:04:39 INFO - ##### 19:04:39 INFO - ##### Running create-virtualenv step. 19:04:39 INFO - ##### 19:04:39 INFO - Running pre-action listener: _resource_record_pre_action 19:04:39 INFO - Running main action method: create_virtualenv 19:04:39 INFO - Creating virtualenv /builds/slave/test/build/venv 19:04:39 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 19:04:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:04:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:04:40 INFO - Using real prefix '/usr' 19:04:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:04:40 INFO - Installing distribute.............................................................................................................................................................................................done. 19:04:42 INFO - Installing pip.................done. 19:04:42 INFO - Return code: 0 19:04:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:04:42 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')]} 19:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:42 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')]} 19:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:42 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 0x1907030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc63b0>, '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 0x1bc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', '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 19:04:42 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 19:04:42 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 19:04:42 INFO - Using env: {'DISPLAY': ':0', 19:04:42 INFO - 'HOME': '/home/cltbld', 19:04:42 INFO - 'LANG': 'en_US.UTF-8', 19:04:42 INFO - 'LANGUAGE': 'en_US:en', 19:04:42 INFO - 'LOGNAME': 'cltbld', 19:04:42 INFO - 'MAIL': '/var/mail/cltbld', 19:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:42 INFO - 'MOZ_NO_REMOTE': '1', 19:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:42 INFO - 'NO_EM_RESTART': '1', 19:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:42 INFO - 'PWD': '/builds/slave/test', 19:04:42 INFO - 'SHELL': '/bin/bash', 19:04:42 INFO - 'SHLVL': '1', 19:04:42 INFO - 'TERM': 'linux', 19:04:42 INFO - 'TMOUT': '86400', 19:04:42 INFO - 'USER': 'cltbld', 19:04:42 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', 19:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:42 INFO - '_': '/tools/buildbot/bin/python'} 19:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:42 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 19:04:42 INFO - Cleaning up... 19:04:42 INFO - Return code: 0 19:04:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:04:42 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')]} 19:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:42 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')]} 19:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:42 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 0x1907030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc63b0>, '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 0x1bc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', '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 19:04:42 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 19:04:42 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 19:04:42 INFO - Using env: {'DISPLAY': ':0', 19:04:42 INFO - 'HOME': '/home/cltbld', 19:04:42 INFO - 'LANG': 'en_US.UTF-8', 19:04:42 INFO - 'LANGUAGE': 'en_US:en', 19:04:42 INFO - 'LOGNAME': 'cltbld', 19:04:42 INFO - 'MAIL': '/var/mail/cltbld', 19:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:42 INFO - 'MOZ_NO_REMOTE': '1', 19:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:42 INFO - 'NO_EM_RESTART': '1', 19:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:42 INFO - 'PWD': '/builds/slave/test', 19:04:42 INFO - 'SHELL': '/bin/bash', 19:04:42 INFO - 'SHLVL': '1', 19:04:42 INFO - 'TERM': 'linux', 19:04:42 INFO - 'TMOUT': '86400', 19:04:42 INFO - 'USER': 'cltbld', 19:04:42 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', 19:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:42 INFO - '_': '/tools/buildbot/bin/python'} 19:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:43 INFO - Downloading/unpacking psutil>=3.1.1 19:04:43 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 19:04:43 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 19:04:43 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 19:04:43 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 19:04:43 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 19:04:43 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 19:04:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:04:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:04:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:04:45 INFO - Installing collected packages: psutil 19:04:45 INFO - Running setup.py install for psutil 19:04:45 INFO - building 'psutil._psutil_linux' extension 19:04:45 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 19:04:46 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 19:04:46 INFO - building 'psutil._psutil_posix' extension 19:04:46 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 19:04:46 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 19:04:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:04:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:04:46 INFO - Successfully installed psutil 19:04:46 INFO - Cleaning up... 19:04:46 INFO - Return code: 0 19:04:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:04:46 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')]} 19:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:46 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')]} 19:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:46 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 0x1907030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc63b0>, '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 0x1bc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', '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 19:04:46 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 19:04:46 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 19:04:46 INFO - Using env: {'DISPLAY': ':0', 19:04:46 INFO - 'HOME': '/home/cltbld', 19:04:46 INFO - 'LANG': 'en_US.UTF-8', 19:04:46 INFO - 'LANGUAGE': 'en_US:en', 19:04:46 INFO - 'LOGNAME': 'cltbld', 19:04:46 INFO - 'MAIL': '/var/mail/cltbld', 19:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:46 INFO - 'MOZ_NO_REMOTE': '1', 19:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:46 INFO - 'NO_EM_RESTART': '1', 19:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:46 INFO - 'PWD': '/builds/slave/test', 19:04:46 INFO - 'SHELL': '/bin/bash', 19:04:46 INFO - 'SHLVL': '1', 19:04:46 INFO - 'TERM': 'linux', 19:04:46 INFO - 'TMOUT': '86400', 19:04:46 INFO - 'USER': 'cltbld', 19:04:46 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', 19:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:46 INFO - '_': '/tools/buildbot/bin/python'} 19:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:04:46 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 19:04:46 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 19:04:46 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 19:04:46 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 19:04:46 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 19:04:46 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 19:04:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:04:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:04:48 INFO - Installing collected packages: mozsystemmonitor 19:04:48 INFO - Running setup.py install for mozsystemmonitor 19:04:48 INFO - Successfully installed mozsystemmonitor 19:04:48 INFO - Cleaning up... 19:04:48 INFO - Return code: 0 19:04:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:04:48 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')]} 19:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:48 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')]} 19:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:48 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 0x1907030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc63b0>, '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 0x1bc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', '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 19:04:48 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 19:04:48 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 19:04:48 INFO - Using env: {'DISPLAY': ':0', 19:04:48 INFO - 'HOME': '/home/cltbld', 19:04:48 INFO - 'LANG': 'en_US.UTF-8', 19:04:48 INFO - 'LANGUAGE': 'en_US:en', 19:04:48 INFO - 'LOGNAME': 'cltbld', 19:04:48 INFO - 'MAIL': '/var/mail/cltbld', 19:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:48 INFO - 'MOZ_NO_REMOTE': '1', 19:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:48 INFO - 'NO_EM_RESTART': '1', 19:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:48 INFO - 'PWD': '/builds/slave/test', 19:04:48 INFO - 'SHELL': '/bin/bash', 19:04:48 INFO - 'SHLVL': '1', 19:04:48 INFO - 'TERM': 'linux', 19:04:48 INFO - 'TMOUT': '86400', 19:04:48 INFO - 'USER': 'cltbld', 19:04:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', 19:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:48 INFO - '_': '/tools/buildbot/bin/python'} 19:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:49 INFO - Downloading/unpacking jsonschema==2.5.1 19:04:49 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 19:04:49 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 19:04:49 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 19:04:49 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 19:04:49 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 19:04:49 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 19:04:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:04:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:04:51 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 19:04:51 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 19:04:51 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 19:04:51 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 19:04:51 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 19:04:51 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 19:04:51 INFO - Downloading functools32-3.2.3-2.tar.gz 19:04:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:04:51 INFO - warning: no files found matching '*.txt' 19:04:51 INFO - no previously-included directories found matching 'build' 19:04:51 INFO - no previously-included directories found matching 'dist' 19:04:51 INFO - no previously-included directories found matching '.git*' 19:04:51 INFO - Installing collected packages: jsonschema, functools32 19:04:51 INFO - Running setup.py install for functools32 19:04:51 INFO - warning: no files found matching '*.txt' 19:04:51 INFO - no previously-included directories found matching 'build' 19:04:51 INFO - no previously-included directories found matching 'dist' 19:04:51 INFO - no previously-included directories found matching '.git*' 19:04:51 INFO - Successfully installed jsonschema functools32 19:04:51 INFO - Cleaning up... 19:04:51 INFO - Return code: 0 19:04:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:04:51 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')]} 19:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:51 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')]} 19:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:51 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 0x1907030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc63b0>, '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 0x1bc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', '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 19:04:51 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 19:04:51 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 19:04:51 INFO - Using env: {'DISPLAY': ':0', 19:04:51 INFO - 'HOME': '/home/cltbld', 19:04:51 INFO - 'LANG': 'en_US.UTF-8', 19:04:51 INFO - 'LANGUAGE': 'en_US:en', 19:04:51 INFO - 'LOGNAME': 'cltbld', 19:04:51 INFO - 'MAIL': '/var/mail/cltbld', 19:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:51 INFO - 'MOZ_NO_REMOTE': '1', 19:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:51 INFO - 'NO_EM_RESTART': '1', 19:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:51 INFO - 'PWD': '/builds/slave/test', 19:04:51 INFO - 'SHELL': '/bin/bash', 19:04:51 INFO - 'SHLVL': '1', 19:04:51 INFO - 'TERM': 'linux', 19:04:51 INFO - 'TMOUT': '86400', 19:04:51 INFO - 'USER': 'cltbld', 19:04:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', 19:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:51 INFO - '_': '/tools/buildbot/bin/python'} 19:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:51 INFO - Downloading/unpacking blobuploader==1.2.4 19:04:51 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 19:04:51 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 19:04:51 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 19:04:51 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 19:04:51 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 19:04:51 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 19:04:53 INFO - Downloading blobuploader-1.2.4.tar.gz 19:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:04:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:04:53 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 19:04:53 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 19:04:53 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 19:04:53 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 19:04:53 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 19:04:53 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 19:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:04:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:04:54 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 19:04:54 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 19:04:54 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 19:04:54 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 19:04:54 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 19:04:54 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 19:04:54 INFO - Downloading docopt-0.6.1.tar.gz 19:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:04:54 INFO - Installing collected packages: blobuploader, requests, docopt 19:04:54 INFO - Running setup.py install for blobuploader 19:04:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:04:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:04:54 INFO - Running setup.py install for requests 19:04:54 INFO - Running setup.py install for docopt 19:04:54 INFO - Successfully installed blobuploader requests docopt 19:04:54 INFO - Cleaning up... 19:04:55 INFO - Return code: 0 19:04:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:55 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 0x1907030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc63b0>, '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 0x1bc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', '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 19:04:55 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 19:04:55 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 19:04:55 INFO - Using env: {'DISPLAY': ':0', 19:04:55 INFO - 'HOME': '/home/cltbld', 19:04:55 INFO - 'LANG': 'en_US.UTF-8', 19:04:55 INFO - 'LANGUAGE': 'en_US:en', 19:04:55 INFO - 'LOGNAME': 'cltbld', 19:04:55 INFO - 'MAIL': '/var/mail/cltbld', 19:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:55 INFO - 'MOZ_NO_REMOTE': '1', 19:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:55 INFO - 'NO_EM_RESTART': '1', 19:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:55 INFO - 'PWD': '/builds/slave/test', 19:04:55 INFO - 'SHELL': '/bin/bash', 19:04:55 INFO - 'SHLVL': '1', 19:04:55 INFO - 'TERM': 'linux', 19:04:55 INFO - 'TMOUT': '86400', 19:04:55 INFO - 'USER': 'cltbld', 19:04:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', 19:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:55 INFO - '_': '/tools/buildbot/bin/python'} 19:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:04:55 INFO - Running setup.py (path:/tmp/pip-mVVxYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:04:55 INFO - Running setup.py (path:/tmp/pip-0s23rI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:04:55 INFO - Running setup.py (path:/tmp/pip-HmseBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:04:55 INFO - Running setup.py (path:/tmp/pip-z_B1rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:04:55 INFO - Running setup.py (path:/tmp/pip-T530s0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:04:55 INFO - Running setup.py (path:/tmp/pip-46wMZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:04:55 INFO - Running setup.py (path:/tmp/pip-miWO7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:04:55 INFO - Running setup.py (path:/tmp/pip-zpwM45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:04:55 INFO - Running setup.py (path:/tmp/pip-Ic5yS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:04:55 INFO - Running setup.py (path:/tmp/pip-kPKXDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:04:55 INFO - Running setup.py (path:/tmp/pip-T_y_le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:04:56 INFO - Running setup.py (path:/tmp/pip-nuI6O7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:04:56 INFO - Running setup.py (path:/tmp/pip-ITERu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:04:56 INFO - Running setup.py (path:/tmp/pip-k1rnjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:04:56 INFO - Running setup.py (path:/tmp/pip-XkULRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:04:56 INFO - Running setup.py (path:/tmp/pip-geAzt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:04:56 INFO - Running setup.py (path:/tmp/pip-vuh0o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:04:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:04:56 INFO - Running setup.py install for manifestparser 19:04:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:04:56 INFO - Running setup.py install for mozcrash 19:04:56 INFO - Running setup.py install for mozdebug 19:04:56 INFO - Running setup.py install for mozdevice 19:04:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:04:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:04:56 INFO - Running setup.py install for mozfile 19:04:56 INFO - Running setup.py install for mozhttpd 19:04:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Running setup.py install for mozinfo 19:04:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Running setup.py install for mozInstall 19:04:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Running setup.py install for mozleak 19:04:57 INFO - Running setup.py install for mozlog 19:04:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Running setup.py install for moznetwork 19:04:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Running setup.py install for mozprocess 19:04:57 INFO - Running setup.py install for mozprofile 19:04:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Running setup.py install for mozrunner 19:04:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Running setup.py install for mozscreenshot 19:04:58 INFO - Running setup.py install for moztest 19:04:58 INFO - Running setup.py install for mozversion 19:04:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:04:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:04:58 INFO - Cleaning up... 19:04:58 INFO - Return code: 0 19:04:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:04:58 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')]} 19:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:58 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')]} 19:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:58 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 0x1907030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc63b0>, '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 0x1bc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', '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 19:04:58 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 19:04:58 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 19:04:58 INFO - Using env: {'DISPLAY': ':0', 19:04:58 INFO - 'HOME': '/home/cltbld', 19:04:58 INFO - 'LANG': 'en_US.UTF-8', 19:04:58 INFO - 'LANGUAGE': 'en_US:en', 19:04:58 INFO - 'LOGNAME': 'cltbld', 19:04:58 INFO - 'MAIL': '/var/mail/cltbld', 19:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:58 INFO - 'MOZ_NO_REMOTE': '1', 19:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:58 INFO - 'NO_EM_RESTART': '1', 19:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:58 INFO - 'PWD': '/builds/slave/test', 19:04:58 INFO - 'SHELL': '/bin/bash', 19:04:58 INFO - 'SHLVL': '1', 19:04:58 INFO - 'TERM': 'linux', 19:04:58 INFO - 'TMOUT': '86400', 19:04:58 INFO - 'USER': 'cltbld', 19:04:58 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', 19:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:58 INFO - '_': '/tools/buildbot/bin/python'} 19:04:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:04:58 INFO - Running setup.py (path:/tmp/pip-_tt4A1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:04:58 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)) 19:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:04:58 INFO - Running setup.py (path:/tmp/pip-f1_fHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:04:58 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)) 19:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:04:58 INFO - Running setup.py (path:/tmp/pip-rEOI2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:04:58 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)) 19:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:04:58 INFO - Running setup.py (path:/tmp/pip-XOfnKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:04:58 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)) 19:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:04:58 INFO - Running setup.py (path:/tmp/pip-7yprP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:04:58 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)) 19:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:04:58 INFO - Running setup.py (path:/tmp/pip-dzwgOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:04:58 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)) 19:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:04:58 INFO - Running setup.py (path:/tmp/pip-JgqjD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:04:58 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)) 19:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:04:58 INFO - Running setup.py (path:/tmp/pip-JGiuHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:04:59 INFO - Running setup.py (path:/tmp/pip-Z_K4fK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:04:59 INFO - Running setup.py (path:/tmp/pip-n_0WkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 19:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:04:59 INFO - Running setup.py (path:/tmp/pip-aPG179-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:04:59 INFO - Running setup.py (path:/tmp/pip-6nA__H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 19:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:04:59 INFO - Running setup.py (path:/tmp/pip-eJ8Gy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:04:59 INFO - Running setup.py (path:/tmp/pip-TdgTl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 19:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:04:59 INFO - Running setup.py (path:/tmp/pip-fRM2TK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:04:59 INFO - Running setup.py (path:/tmp/pip-JUVDTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:04:59 INFO - Running setup.py (path:/tmp/pip-iEgID5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:04:59 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)) 19:04:59 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)) 19:04:59 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)) 19:04:59 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)) 19:04:59 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)) 19:04:59 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)) 19:04:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:04:59 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 19:04:59 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 19:04:59 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 19:04:59 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 19:04:59 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 19:04:59 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 19:05:01 INFO - Downloading blessings-1.6.tar.gz 19:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:05:01 INFO - Installing collected packages: blessings 19:05:01 INFO - Running setup.py install for blessings 19:05:01 INFO - Successfully installed blessings 19:05:01 INFO - Cleaning up... 19:05:01 INFO - Return code: 0 19:05:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:05:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:02 INFO - Reading from file tmpfile_stdout 19:05:02 INFO - Current package versions: 19:05:02 INFO - argparse == 1.2.1 19:05:02 INFO - blessings == 1.6 19:05:02 INFO - blobuploader == 1.2.4 19:05:02 INFO - docopt == 0.6.1 19:05:02 INFO - functools32 == 3.2.3-2 19:05:02 INFO - jsonschema == 2.5.1 19:05:02 INFO - manifestparser == 1.1 19:05:02 INFO - mozInstall == 1.12 19:05:02 INFO - mozcrash == 0.17 19:05:02 INFO - mozdebug == 0.1 19:05:02 INFO - mozdevice == 0.48 19:05:02 INFO - mozfile == 1.2 19:05:02 INFO - mozhttpd == 0.7 19:05:02 INFO - mozinfo == 0.9 19:05:02 INFO - mozleak == 0.1 19:05:02 INFO - mozlog == 3.2 19:05:02 INFO - moznetwork == 0.27 19:05:02 INFO - mozprocess == 0.22 19:05:02 INFO - mozprofile == 0.28 19:05:02 INFO - mozrunner == 6.11 19:05:02 INFO - mozscreenshot == 0.1 19:05:02 INFO - mozsystemmonitor == 0.3 19:05:02 INFO - moztest == 0.7 19:05:02 INFO - mozversion == 1.4 19:05:02 INFO - psutil == 3.1.1 19:05:02 INFO - requests == 1.2.3 19:05:02 INFO - wsgiref == 0.1.2 19:05:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:02 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')]} 19:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:02 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')]} 19:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:02 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 0x1907030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc63b0>, '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 0x1bc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', '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 19:05:02 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 19:05:02 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 19:05:02 INFO - Using env: {'DISPLAY': ':0', 19:05:02 INFO - 'HOME': '/home/cltbld', 19:05:02 INFO - 'LANG': 'en_US.UTF-8', 19:05:02 INFO - 'LANGUAGE': 'en_US:en', 19:05:02 INFO - 'LOGNAME': 'cltbld', 19:05:02 INFO - 'MAIL': '/var/mail/cltbld', 19:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:02 INFO - 'MOZ_NO_REMOTE': '1', 19:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:02 INFO - 'NO_EM_RESTART': '1', 19:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:02 INFO - 'PWD': '/builds/slave/test', 19:05:02 INFO - 'SHELL': '/bin/bash', 19:05:02 INFO - 'SHLVL': '1', 19:05:02 INFO - 'TERM': 'linux', 19:05:02 INFO - 'TMOUT': '86400', 19:05:02 INFO - 'USER': 'cltbld', 19:05:02 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', 19:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:02 INFO - '_': '/tools/buildbot/bin/python'} 19:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:02 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)) 19:05:02 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)) 19:05:02 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)) 19:05:02 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)) 19:05:02 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)) 19:05:02 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)) 19:05:02 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)) 19:05:02 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)) 19:05:02 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)) 19:05:02 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)) 19:05:02 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)) 19:05:02 INFO - Cleaning up... 19:05:02 INFO - Return code: 0 19:05:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:05:02 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')]} 19:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:02 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')]} 19:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:02 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 0x1907030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc63b0>, '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 0x1bc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', '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 19:05:02 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 19:05:02 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 19:05:02 INFO - Using env: {'DISPLAY': ':0', 19:05:02 INFO - 'HOME': '/home/cltbld', 19:05:02 INFO - 'LANG': 'en_US.UTF-8', 19:05:02 INFO - 'LANGUAGE': 'en_US:en', 19:05:02 INFO - 'LOGNAME': 'cltbld', 19:05:02 INFO - 'MAIL': '/var/mail/cltbld', 19:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:02 INFO - 'MOZ_NO_REMOTE': '1', 19:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:02 INFO - 'NO_EM_RESTART': '1', 19:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:02 INFO - 'PWD': '/builds/slave/test', 19:05:02 INFO - 'SHELL': '/bin/bash', 19:05:02 INFO - 'SHLVL': '1', 19:05:02 INFO - 'TERM': 'linux', 19:05:02 INFO - 'TMOUT': '86400', 19:05:02 INFO - 'USER': 'cltbld', 19:05:02 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', 19:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:02 INFO - '_': '/tools/buildbot/bin/python'} 19:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:05:02 INFO - Cleaning up... 19:05:02 INFO - Return code: 0 19:05:02 INFO - Running post-action listener: _resource_record_post_action 19:05:02 INFO - Running post-action listener: _start_resource_monitoring 19:05:02 INFO - Starting resource monitoring. 19:05:02 INFO - ##### 19:05:02 INFO - ##### Finished create-virtualenv step (success) 19:05:02 INFO - ##### 19:05:02 INFO - ##### 19:05:02 INFO - ##### Running install step. 19:05:02 INFO - ##### 19:05:02 INFO - Running pre-action listener: _resource_record_pre_action 19:05:02 INFO - Running main action method: install 19:05:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:02 INFO - Reading from file tmpfile_stdout 19:05:02 INFO - Detecting whether we're running mozinstall >=1.0... 19:05:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:05:02 INFO - Reading from file tmpfile_stdout 19:05:02 INFO - Output received: 19:05:02 INFO - Usage: mozinstall [options] installer 19:05:02 INFO - Options: 19:05:02 INFO - -h, --help show this help message and exit 19:05:02 INFO - -d DEST, --destination=DEST 19:05:02 INFO - Directory to install application into. [default: 19:05:02 INFO - "/builds/slave/test"] 19:05:02 INFO - --app=APP Application being installed. [default: firefox] 19:05:02 INFO - mkdir: /builds/slave/test/build/application 19:05:02 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'] 19:05:02 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 19:05:20 INFO - Reading from file tmpfile_stdout 19:05:20 INFO - Output received: 19:05:20 INFO - /builds/slave/test/build/application/firefox/firefox 19:05:20 INFO - Running post-action listener: _resource_record_post_action 19:05:20 INFO - ##### 19:05:20 INFO - ##### Finished install step (success) 19:05:20 INFO - ##### 19:05:20 INFO - ##### 19:05:20 INFO - ##### Running run-tests step. 19:05:20 INFO - ##### 19:05:20 INFO - Running pre-action listener: _resource_record_pre_action 19:05:20 INFO - Running main action method: run_tests 19:05:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:05:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:05:20 INFO - Python 2.7.3 19:05:20 INFO - Return code: 0 19:05:20 INFO - grabbing minidump binary from tooltool 19:05: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')]} 19:05:20 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 0x1bc63b0>, '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 0x1bc72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:05:20 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 19:05:20 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 19:05:20 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 19:05:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:05:20 INFO - Return code: 0 19:05:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:05:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:05:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:05:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:05:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:05:20 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/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 19:05:20 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/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 19:05:20 INFO - Using env: {'DISPLAY': ':0', 19:05:20 INFO - 'HOME': '/home/cltbld', 19:05:20 INFO - 'LANG': 'en_US.UTF-8', 19:05:20 INFO - 'LANGUAGE': 'en_US:en', 19:05:20 INFO - 'LOGNAME': 'cltbld', 19:05:20 INFO - 'MAIL': '/var/mail/cltbld', 19:05:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:05:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:20 INFO - 'MOZ_NO_REMOTE': '1', 19:05:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:05:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:20 INFO - 'NO_EM_RESTART': '1', 19:05:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:20 INFO - 'PWD': '/builds/slave/test', 19:05:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:05:20 INFO - 'SHELL': '/bin/bash', 19:05:20 INFO - 'SHLVL': '1', 19:05:20 INFO - 'TERM': 'linux', 19:05:20 INFO - 'TMOUT': '86400', 19:05:20 INFO - 'USER': 'cltbld', 19:05:20 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594', 19:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:20 INFO - '_': '/tools/buildbot/bin/python'} 19:05:20 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/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 19:05:20 INFO - mozversion application_buildid: 20160705163017 19:05:20 INFO - mozversion application_changeset: 9b428173a0889f5a25e7a6e855f2d1726207a723 19:05:20 INFO - mozversion application_display_name: Nightly 19:05:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:05:20 INFO - mozversion application_name: Firefox 19:05:20 INFO - mozversion application_remotingname: firefox 19:05:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:05:20 INFO - mozversion application_vendor: Mozilla 19:05:20 INFO - mozversion application_version: 50.0a1 19:05:20 INFO - mozversion platform_buildid: 20160705163017 19:05:20 INFO - mozversion platform_changeset: 9b428173a0889f5a25e7a6e855f2d1726207a723 19:05:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:05:20 INFO - mozversion platform_version: 50.0a1 19:05:20 INFO - using testdate: 1467770720 19:05:20 INFO - actual date: 1467770720 19:05:20 INFO - starting webserver on 'localhost:48934' 19:05:20 INFO - SUITE-START | Running 2 tests 19:05:20 INFO - TEST-START | dromaeo_css 19:05:20 INFO - operating with platform_type : linux_ 19:05:20 INFO - Initialising browser for dromaeo_css test... 19:05:20 INFO - TEST-INFO | started process 3290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKNehD5/profile http://localhost:48934/getInfo.html) 19:05:26 INFO - PROCESS | 3290 | __metrics Screen width/height:1600/1200 19:05:26 INFO - PROCESS | 3290 | colorDepth:24 19:05:26 INFO - PROCESS | 3290 | Browser inner width/height: 1024/697 19:05:26 INFO - PROCESS | 3290 | __metrics 19:05:27 ERROR - PROCESS | 3290 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 19:05:27 INFO - TEST-INFO | 3290: exit 0 19:05:27 INFO - Browser initialized. 19:05:27 INFO - Running cycle 1/1 for dromaeo_css test... 19:05:27 INFO - TEST-INFO | started process 3414 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKNehD5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:05:39 INFO - PROCESS | 3414 | RSS: Main: 168505344 19:05:39 INFO - PROCESS | 3414 | 19:06:29 INFO - PROCESS | 3414 | 1467770789296 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] 19:08:37 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:48934/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48934/tests/dromaeo/cssquery-ext.html) 19:08:38 INFO - PROCESS | 3414 | RSS: Main: 172032000 19:08:38 INFO - PROCESS | 3414 | 19:11:40 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:48934/tests/dromaeo/cssquery-ext.html (next: http://localhost:48934/tests/dromaeo/cssquery-jquery.html) 19:11:41 INFO - PROCESS | 3414 | RSS: Main: 168878080 19:11:41 INFO - PROCESS | 3414 | 19:14:43 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:48934/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48934/tests/dromaeo/cssquery-mootools.html) 19:14:43 INFO - PROCESS | 3414 | RSS: Main: 171937792 19:14:43 INFO - PROCESS | 3414 | 19:17:45 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:48934/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48934/tests/dromaeo/cssquery-prototype.html) 19:17:46 INFO - PROCESS | 3414 | RSS: Main: 167866368 19:17:46 INFO - PROCESS | 3414 | 19:20:48 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:48934/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48934/tests/dromaeo/cssquery-yui.html) 19:20:49 INFO - PROCESS | 3414 | RSS: Main: 170082304 19:20:49 INFO - PROCESS | 3414 | 19:23:52 INFO - PROCESS | 3414 | Cycle 1(1): loaded http://localhost:48934/tests/dromaeo/cssquery-yui.html (next: http://localhost:48934/tests/dromaeo/cssquery-dojo.html) 19:23:52 INFO - PROCESS | 3414 | RSS: Main: 170835968 19:23:52 INFO - PROCESS | 3414 | 19:23:52 INFO - PROCESS | 3414 | __start_tp_report 19:23:52 INFO - PROCESS | 3414 | _x_x_mozilla_page_load 19:23:52 INFO - PROCESS | 3414 | _x_x_mozilla_page_load_details 19:23:52 INFO - PROCESS | 3414 | |i|pagename|runs| 19:23:52 INFO - PROCESS | 3414 | |0;dojo.html;3106.114757294171;3177.38041081989;3189.6331921828983;3194.4729119695253;3200.2799370141706;5418.133098704208;5443.292371991641;5456.918146227805;5525.723713814304;5590.776368945248;5291.3385826771655;5385.434529374418;5418.8916221675545;5422.53908417784;5481.260029895963;4917.852464426064;4947.8268260610885;5027.648064635477;5071.518205770446;5110.565601923841;885.5664547426943;4966.428860681014;5086.6693664911845;5092.770825312851;5117.385913690344;4916.803327866917;4949.752512374367;4963.578095861838;4968.205087186051;5017.974910125426;4898.363212782351;4963.354763880709;4970.378702662168;5013.573846223076;5028.446870844205;4846.466888642247;4873.80504779812;4879.560839524424;4892.412910450733;4901.50984901507;5403.945960540384;5411.675299482004;5420.376656684492;5457.808976685837;5511.751971161268;5759.136129580596;5827.096799996008;5835.212246346731;5837.270341207349;5842;5860.970695146497;5865.237519122529;5915.556333275022;5933;5970.850728731773;5517.393086760453;5531.446855314477;5535.889282214373;5541.113421852484;5545.279113715232;5862.237909071793;5965.910511342333;5992.0712289595185;6021.488173505213;6035;5842.503387212049;5846.269216347957;5848.912266316009;5850.912236316459;5852.063669812809;5928.051511758098;5929.258842644669;5932.7923522677365;5935.436133567304;5937.198478205473;5678.949394361974;5719.885602287931;5788.942110578924;5798.536117110621;5799.710014499258;5678.205051292823;5767.88464230713;5810.912836307459;5821.09772985188;5881.558883083786;4412.558744125562;4422.491413487426;4434.667399944952;4454.1982443159895;4483;3845;3882.6699730523223;3946.0134966258433;3953.4267531207815;3981.3231750602467;5560.082586373203;5596.608237423341;5607.635503692247;5610.943890561124;5613.101903695389;5817.7382017809305;5849.976254155506;5885.058390657474;5893.204417403681;5932.881342373128;5385;5569.081101618269;5630.859228519238;5631.521320687705;5643.40744221859;5057.241413787961;5083.517065878736;5105.2086926526445;5116.8209112681625;5121.718305493234;5882.588218824641;6110.29731580865;6116.082587611894;6132.6933653317155;6135.815925522242;5806.709664516758;5890.646561206341;5921.289445266423;5929.881402371842;5937.198478205387;6031.035034394651;6037.154798328325;6085.4523092921845;6092.208012958287;6098.451139397475;5668;5735.770569177186;5736.741846616996;5765.682887441231;5779.306483222041;5855.414458554281;5900.085486749561;5903.970480147572;5932.377100404396;5969.462748352669;5690.260266165372;5703.771849125988;5719.256496655408;5775.595708300379;5792.362840087671;5617.185508101221;5644.068728659725;5694.259746232963;5751.1085781703905;5770.711464426846;5541.3904470507405;5594.86012849682;5641.971790141187;5660.405657405913;5718.914216286676;5737.397573254748;5743.770249189985;5781.913271300849;5788.710564471844;5790.39200883918;5544.667319960815;5634.126710359901;5668.51817595509;5669.34802497718;5678.574106941914 19:23:52 INFO - PROCESS | 3414 | |1;ext.html;563.124341648736;597.766870920341;616.4421198815071;619.0250355689786;637.9585326953745;41670.37494437586;42648.573514264885;42828.57171428285;45742;45937.0812583749;43618.34572481416;44145.7792711036;44241.55758442423;44554;44863.551364486346;8861.37970342078;8988.59551320192;9017.45895246284;9021.503817290046;9056.547172641342;8854.981677107118;8858.424202426853;8890.73327800167;8907.153820387086;8911.643534258621;8919.910800891972;8962.641494340218;8964.775880602972;9003.5048072356;9036.915570131594;8933.19601235892;8941.284697224239;8986.68546600869;8998.415103018282;9008.279337652972;8840.469571825712;8878.955605221998;8892.15524525169;8904.065073167354;8910.19808217257;41005.38491922594;41011.58988410138;41448.585514144776;41548.79225603853;41669.583304166874;3296.3572103439838;3465.2722928185112;3533.116720819795;3538.840752166133;3646.6535679110443;28803.135905922856;31698;31703;31732.365352692817;31797.682023179936;4272.487301523837;4344.7827608619755;4434.578715022068;4477.843275485375;4540.841070562515;336383;339593;340588;341087;341502.2924885384;57992.71003644955;58109.70945145247;58605.70697146487;58679;58755.118673219935;34854;60746.69626651927;60874.69562652247;61290;61322.693386533676;16708.916455417646;17609.7358539622;17694.823051769574;17715.911420442815;17735.113244337732;13247.403866826016;13353.532626358225;13453;13465.730685386237;13466.730665386833;18974.810251897303;19071.332503362315;19182;19207.231710731692;19241.4227573173;6969.2682268361095;7129.7861064168155;7277.126744790659;7296.197418283985;7344.889826652605;958.3483231402713;1036.4092467293722;1062.792755412687;1091.8689757229183;1100.3782862682558;31479;31525;31788.682113179035;31807.84096079505;31821.20446988844;1094.195766111907;1140.5950887434842;1153.8673052599058;1161.233585833363;1200.9759804803855;16645.50063498097;16732.16339183036;16771.2452939618;16807.579810504834;16903.81983327112;540707;544166;548835;551092;553402;56052;56342.436575634536;56550;56571.717141414854;56623.150652740245;1276.304414094321;1298.9740205195844;1306.4839388441512;1314.8290722206052;1338.9330533473287;29807.254818629706;30673;31069.844650776602;31221.253449585285;31432.37135257236;49687;49993.50006500034;50172.247416289516;50173.498265018345;50380.74809625928;420071.3942884501;420975;422573;422692;423140;26694.59958100591;27310.45379092447;27583.586246206723;27607.30981725473;27658.031968881798;46117.53882461132;46121;46186.769066154455;46974.76512617415;47542.28686569774;39712.20575588414;40750.79624601858;40824.38763418492;40953.59046409498;41138.38292425556;39357.606423935395;39924.40113398359;40019.599804001584;40391.596084038785;40612.18775624412;39415;39729.205415890945;40251;40365.39451908282;42750;33680;37232.62767372291;37275.81362093281;37610;37675.43486847645;27231.86384068146;27607.58588621132;27722.722772772013;27790;27825.44349113047 19:23:52 INFO - PROCESS | 3414 | |2;jquery.html;390.8592906553642;391.3835708758705;393.7834191194842;395.5075930466569;407.93880917862316;13835;18440.262389504438;18528.90735546322;19935.700964485528;20008.29970951017;18454.16956236969;19130.426087217405;19313.130909109088;19398.515037124078;19417.805821941776;5583.218349431083;5668.206451096849;5755.510781583571;5787.623804452718;5792.073268277077;5506.834794956138;5658.886822263552;5664.915026274609;5671.886562268752;5682.034054210794;5455.072637651609;5605.383407825136;5623.971880140593;5753.741081651336;5764.452377024176;5554.583406244547;5586.41342659021;5597.104463285875;5607.607467477278;5648.9152662709685;5617.382087970361;5715.514181294595;5735.283089613798;5774.162746401748;5798.768049278024;19851.602967940704;20889.5822083559;22114.778852211595;22287.888560557254;22309.665355019686;2279.3959600705825;2299.9310020699404;2306.0660432524855;2363.3973336799177;2915.3731947631363;9737.513124343825;9845.45849978251;9899.80200395988;9975.650852220137;10042.648507302209;1827.7075667893073;1909.809019098093;1913.7703475583019;1929.5754933914516;1935.0808366026024;78494.60752696257;81393.18606813916;81434;82522;82887;10409.5836166554;10795.46022698862;11005.559777608805;11138.832917506244;11518.136139789549;15131.924340378448;15201.163935983406;15252.084874907541;15280.31238594266;15305;8149.959250203711;8226.341892648574;8317.20986506293;8326.209010144026;8343.749687509384;7862;7864.033991502124;7891.881621775678;8079.192080791874;8092.71675491355;4642.280446530793;4661.440627124767;4706.42334817833;4738.8341408050555;4842.7336496493035;1951.9024048797503;1976.416956997689;2001.599680063964;2028.3813436901592;2040.5918816236813;868.561376504861;910.5765818894114;936.279065119854;994.7065615643403;1007.7531004903846;18328.633427331377;18389.81610183881;18799.90600046991;19256.22975081009;19541;1003.3027046202965;1005.1958433253515;1010.3382284603597;1014.8477728340808;1020.7039958412125;10259.127974122133;10620.628278010387;10675.25273230882;10697.465126743631;10720.46397680113;478981;485490;487732;488188;496171;77683.61158194173;87036;97000.54499182518;98291;101989;1042.6402891002592;1044.2585764107569;1048.5229220704562;1048.99475502622;1052.6052730226165;17231.655366892843;17238.655226895644;17677.38129165473;17801.46595602134;17902.28390864351;42915;42975.785121074194;43778.12443751171;43897;44012.779936100116;61382.541829051326;61862.381376185665;62075;62910.685446572475;63131.36868631255;8059;8147.63335649909;8248.092709802037;8317.293030092267;8521.786955326166;12233.26600403943;12685.492580296685;12942.223466592035;13423.395947182595;13588.796168057685;10087.29388942767;10246.231532634933;10323.432211228455;10342.37945723259;10389.480525973822;11501.597444089752;11876;12008.699782505508;12037.217580857216;12373.814392783936;10244.64143754965;10276.743081423025;10286.485675716334;10476.266661333633;10538.683839484827;8531.786705332417;8673.783155420913;8706.434081784664;8784.956075219583;8832.160944710242;9703.369280996712;9915.801683966136;10299.330543514947;10302.175825934057;10339.84490232632 19:23:52 INFO - PROCESS | 3414 | |3;mootools.html;1472.477270568948;1507.1861194954724;1613.50788009657;1779.4127937780543;1783.8126996665342;7738.303552680258;8437.071922088566;8484.745457636282;8923.419977701453;9025.729228123151;8543.957280213606;8717.259032982203;8809.339299552526;8824.91175088249;8832.867506987384;2300.5283916797057;2328.441174118208;2340.578695834749;2344.3904584807988;2344.6834677318598;2300.3559003479054;2323.361075704178;2332.3819187915215;2343.0979073056824;2345.319857241398;2304.089884495623;2307.3424074138875;2320;2347.295811256625;2347.4131467133216;2281.5208806150727;2287.8284128690416;2292.4727312718087;2298.0463107810324;2301.4821665125296;2237.630790919496;2245.6070187717246;2249.201533455616;2257.413072601119;2265.286434773058;8687.348448866298;8760.4305720128;8778.473291602524;8828.382013259074;8840.071792461764;5150.510701483353;5254.474552544753;5299.046171689094;5305.65513241638;5317.229001794757;3088.984555077233;3148.6536480987074;3199.2641692410875;3207.262329664167;3209.3420848725955;1062.718379629399;1067.210264404343;1077.3912739302268;1087.0162502934857;1115.275071203716;11926.284422934565;11980.760384792255;12040.337781422018;12042.458089385998;12063.758724825455;4458.799354029076;4500.594946454835;4684.484706682262;4692.4603670577635;4704.435467743824;9655.758606034764;9656.75858103553;9671.274654400948;9681.564329605184;9704.951475242578;5222.791088356499;5238.842834714965;5254.2118682197215;5262.631615786858;5281.524662780292;4213.4522512073845;4677.649176311722;4841.249606310957;4848.200046992207;4873.31773551703;4010.7393019453643;4032.0927791247323;4088.509378874554;4137.46212992309;4141.275276826544;1248.3259040118417;1320.8679132086716;1328.5018118205674;1336.0580790542645;1338.1903948111446;895.5298468304062;982.7887253679222;986.605357856863;994.8109859126743;1012.0638409471356;5970.283565972024;6117.480014198754;6139.969300153471;6185.41238582334;6197.845053873689;435.6514788169515;435.72331569453627;438.64469779478725;440.8479074719217;451.04603763040933;3972.980135099306;4062.289099407592;4104.117614712851;4117.21772863155;4145.834166633361;10658;10813.297135686313;10819.675409737563;10912;10919.181061420426;10743.677689669323;10779.676609701564;10811.6215932442;10831.079358254636;10833.620823271147;7828.334591559781;8169.836603267901;8193.385496087818;8279.420440569102;8283;5845.883082338414;6132.202813634199;6150.661713605795;6167;6277.811665650038;9700.417974921245;10058.19534437258;10080.193584513074;10148.289619726844;10181.083702466814;9984.800303994025;10070.848937266093;10105.19158467306;10124.746881328027;10129.848052279074;6968.128983877015;7546.584937828472;7736.613169341623;7812.765617031499;7961.681532738626;8457.492550446992;8472.152784721478;8521.233089022018;8533.74398768013;8548.957255213933;7292.307230813064;7527;7556.584387858501;7602.50583712057;7689.538627682357;7389.224131466119;7429.368503677248;7492.925070749223;7549.0563679540055;7639.083310002835;6809.489288303496;6810.761623343159;6883;6890.586564806128;6899.586024838526;5157.355330583677;5168.922466163086;5218.869528261824;5221.556167725786;5387.084195686664;5187.403448603459;5409.215663728816;5442.074847275893;5445.891082178414;5529.115341545334 19:23:52 INFO - PROCESS | 3414 | |4;prototype.html;308.81008179969314;321.06089687663587;323.5324955439391;323.83969934882236;327.43844307013467;5506.614536982413;5629.6340737852115;5663.225019740328;5749.597528173024;5785.942140578598;5654.349749778777;5702.857428564288;5710.628809127404;5728.25532680752;5751.367349591542;4396.978015109928;4438.979034821993;4444.555544445546;4453.109378124372;4460;4342.717723347972;4403.4495688039;4413.735175889441;4415.955840441603;4442.733435993835;4344.370066340379;4388.583084606973;4400.119976004796;4400.227856450431;4413.823447062114;4404.8458303959205;4407.581279778416;4412.205802955451;4419.602235798778;4424.469063712343;3758.5113935188524;3824.541055073409;3869.052082239841;3881.7088718346236;3885.9805700971597;5575.191597218381;5583.553315734772;5592.049351610236;5607.57943154261;5643.520300774439;5007.522780779679;5056.115179843549;5084.084864724348;5091.414487333967;5097.617678674114;5733.283339582552;5980.611260268069;5998.28020637522;5998.730057147439;6015.127806468037;4252.978735106305;4269.210196113729;4275.657947364203;4276.23027854986;4284.479009951454;6165.969170154121;6271.404216599416;6290.276618188921;6299.7085597452415;6321.209848768904;4189.769562674082;4291.6566674665955;4309.482862056573;4322.7190232634775;4334.804933777988;4337.240982827992;4351.0210202704775;4355.237833379146;4375.606195442426;4394.406755088086;5004.974975125101;5021.372328458942;5040.949590504121;5050.49495050492;5079.263506791494;5594.9720251398485;5800.88398232033;5952.464278214981;6050.515958723292;6065.939340606626;1428.992855035718;1450.4995776457106;1450.7751298548742;1451.3468938977503;1456.7960485532035;906.7143849687327;927.096081320707;936.8735220745249;941.4492521874643;950.8383574792164;5101.163581110797;5103.87240318995;5110.958979407247;5179.792808287626;5215.844414129473;5405.243265942771;5458.6724796512335;5489.533389661844;5526.861828454321;5531.806386776443;4942.5057494251005;5013.874653133628;5158.555604430765;5181.859990802018;5184.274201611777;2889.942201155965;2941.911742647724;2948.8967886123883;2951.896683616063;2955.9110729287945;5541.337598720368;5556.555475561945;5585.497305242548;5594.888102237933;5696.430356964353;5319;5426.647267927572;5520.861978450571;5555.50000499957;5602.411746766531;5611.3266408031295;5640.379558248589;5650.039493286234;5651.2935883014625;5666.546676265889;5315.654482458628;5379.784808607768;5456.890862182655;5481.232627432242;5742.799002034909;6126;6135.171751813448;6145.907811382922;6159;6184.845378865564;6366.77716279928;6421.261554921244;6470.320616335217;6476.255230648536;6488.826243208578;4188.036751547223;4292.720973136736;4312.633426158812;4325.178216138924;4330.761808100585;5954.285485741739;6062.787802426894;6253.78111766086;6260.373962603885;6275.403836635513;5988;6023.186869772525;6045.939540604713;6062.848428789315;6066.3630318815885;6040.335563088145;6046.758129674764;6051.33435322123;6077.392260774064;6086.60437071589;5749.7125143741805;6004.339522652417;6006.489448396936;6016.187814645142;6048.879022419439;6115.296740874856;6115.785947491817;6120.296165940796;6125.509959203164;6134.631922084689;5561.610687251854;5938.524918006463;5947.583669143119;5991.131285963598;5994.580379373402 19:23:52 INFO - PROCESS | 3414 | |5;yui.html;725.4414101142117;737.5095561451634;781.7928249014009;820.7414664380723;852.2755657690964;14364.928175359122;15643.061416315;15765.60585985351;15797.447089351876;15887.205639718011;13378.264195469244;13486.527971520998;13517.864821351783;13524.661883452918;13529.526466573672;633.3792882974687;760.6653072648045;768.2893323675605;790.4032455496092;799.2327365728908;774.2992591704516;781.5349866829256;784.3607459920147;785.9253370929781;786.4455558831011;838.5010918503481;848.4697064334791;850.6554845287668;855.2730179347567;855.3072011670566;836.1429534726893;840.4369072721291;841.5834162089743;843.026304618167;843.7089204224533;610.0270069239556;616.5899676714979;618.2951435363689;620.534599050712;620.9906851397233;13641.181529108286;13673.589792306248;13786.724265514735;13787;13804.723905521832;14855.48005819802;14873.256337183206;14890.329935152944;15094.849051509564;15162.620934476616;12203.095443678618;12216.816747748791;12363.258204507758;12567.622971310875;12584.370781460982;3941.5365396627108;3996.72022958393;4075.673946084306;4159.396887451303;4165.500139983191;72124.2787572128;75458;76220;76345.61827190884;76592;11764.529418823322;11784;12051.819222711667;12229.327386993622;12238.143329966995;21949.890250548644;22234.77765222327;22396.328110156723;22397.552048959256;22450.10199591998;8783.516906570072;9138.725838224864;9168.404053736485;9203.677871274473;9207.125323094295;4871.853844384674;5007.349044624176;5051.166557517969;5177.430482646906;5187.118189907649;3212.277237621563;3381.3406385754542;3411.4712219606;3413.5562376890844;3416.0947348952545;587.6356658871441;590.2179612014098;602.3314121325326;607.7022259093101;609.823151286131;725.9582499113789;732.9047223860971;754.294734423316;769.8798248548349;791.9010123734533;9546.42721436716;9630.229581633592;9757.707268781947;9780.217582593517;10328.483575821328;707.604515568788;735.198633489499;754.4153281207108;765.4527013185487;770.6570576093696;4829.517048295143;4852.393450818648;4893.632977526629;4906.975465122651;4954.900901982012;61610;61846;75422;111465;112446;94377.528112359;96423.51788241154;97062;97883;98069;84471.5776421114;85041.57479212564;85360.99999999876;85714;86130.56934715286;9188.448693078437;9298.488583127722;9422.670206542738;9432.386894851812;9447.52762361893;49595;51493.48506514887;51971.74014129905;52506.062045345985;53694;67793.66103169453;73066;73680.63159684167;75021;76147;11612.94193529027;11790.72726549773;12045.397730113635;12726.755246640669;13348.466061357436;13283.535076272285;13332.800007999695;13431.597052088453;13670.17978921268;13689.24709140967;12021.402265304412;12311.384430778604;12403.875961240272;12897.548585799452;12964.416601252778;12594.559190428292;12664.366781660696;13078.803817942548;13312.134711243738;13423.731525369243;12558.748825023631;13005.544805931748;13064.21614703121;13469;13482.595522134352;10295.330803497749;10690.25168238247;10853.891461085288;10948.781024379627;11261.66215013551;10627.521761520904;10711.625093121704;10764.46177691128;10870.510827012646;10899.727506812393 19:23:52 INFO - PROCESS | 3414 | __end_tp_report 19:23:52 INFO - PROCESS | 3414 | __start_cc_report 19:23:52 INFO - PROCESS | 3414 | _x_x_mozilla_cycle_collect,380 19:23:52 INFO - PROCESS | 3414 | __end_cc_report 19:23:52 INFO - PROCESS | 3414 | __startTimestamp1467771832261__endTimestamp 19:23:52 INFO - PROCESS | 3414 | 19:23:52 INFO - PROCESS | 3414 | ------- Summary: start ------- 19:23:52 INFO - PROCESS | 3414 | Number of tests: 6 19:23:52 INFO - PROCESS | 3414 | 19:23:52 INFO - PROCESS | 3414 | [#0] dojo.html Cycles:165 Average:5418.15 Median:5668.00 stddev:720.04 (12.7%) stddev-sans-first:699.03 19:23:52 INFO - PROCESS | 3414 | Values: 3106.1 3177.4 3189.6 3194.5 3200.3 5418.1 5443.3 5456.9 5525.7 5590.8 5291.3 5385.4 5418.9 5422.5 5481.3 4917.9 4947.8 5027.6 5071.5 5110.6 885.6 4966.4 5086.7 5092.8 5117.4 4916.8 4949.8 4963.6 4968.2 5018.0 4898.4 4963.4 4970.4 5013.6 5028.4 4846.5 4873.8 4879.6 4892.4 4901.5 5403.9 5411.7 5420.4 5457.8 5511.8 5759.1 5827.1 5835.2 5837.3 5842.0 5861.0 5865.2 5915.6 5933.0 5970.9 5517.4 5531.4 5535.9 5541.1 5545.3 5862.2 5965.9 5992.1 6021.5 6035.0 5842.5 5846.3 5848.9 5850.9 5852.1 5928.1 5929.3 5932.8 5935.4 5937.2 5678.9 5719.9 5788.9 5798.5 5799.7 5678.2 5767.9 5810.9 5821.1 5881.6 4412.6 4422.5 4434.7 4454.2 4483.0 3845.0 3882.7 3946.0 3953.4 3981.3 5560.1 5596.6 5607.6 5610.9 5613.1 5817.7 5850.0 5885.1 5893.2 5932.9 5385.0 5569.1 5630.9 5631.5 5643.4 5057.2 5083.5 5105.2 5116.8 5121.7 5882.6 6110.3 6116.1 6132.7 6135.8 5806.7 5890.6 5921.3 5929.9 5937.2 6031.0 6037.2 6085.5 6092.2 6098.5 5668.0 5735.8 5736.7 5765.7 5779.3 5855.4 5900.1 5904.0 5932.4 5969.5 5690.3 5703.8 5719.3 5775.6 5792.4 5617.2 5644.1 5694.3 5751.1 5770.7 5541.4 5594.9 5642.0 5660.4 5718.9 5737.4 5743.8 5781.9 5788.7 5790.4 5544.7 5634.1 5668.5 5669.3 5678.6 19:23:52 INFO - PROCESS | 3414 | 19:23:52 INFO - PROCESS | 3414 | [#1] ext.html Cycles:180 Average:59539.98 Median:41293.48 stddev:117966.33 (285.7%) stddev-sans-first:118214.15 19:23:52 INFO - PROCESS | 3414 | Values: 563.1 597.8 616.4 619.0 638.0 41670.4 42648.6 42828.6 45742.0 45937.1 43618.3 44145.8 44241.6 44554.0 44863.6 8861.4 8988.6 9017.5 9021.5 9056.5 8855.0 8858.4 8890.7 8907.2 8911.6 8919.9 8962.6 8964.8 9003.5 9036.9 8933.2 8941.3 8986.7 8998.4 9008.3 8840.5 8879.0 8892.2 8904.1 8910.2 41005.4 41011.6 41448.6 41548.8 41669.6 3296.4 3465.3 3533.1 3538.8 3646.7 28803.1 31698.0 31703.0 31732.4 31797.7 4272.5 4344.8 4434.6 4477.8 4540.8 336383.0 339593.0 340588.0 341087.0 341502.3 57992.7 58109.7 58605.7 58679.0 58755.1 34854.0 60746.7 60874.7 61290.0 61322.7 16708.9 17609.7 17694.8 17715.9 17735.1 13247.4 13353.5 13453.0 13465.7 13466.7 18974.8 19071.3 19182.0 19207.2 19241.4 6969.3 7129.8 7277.1 7296.2 7344.9 958.3 1036.4 1062.8 1091.9 1100.4 31479.0 31525.0 31788.7 31807.8 31821.2 1094.2 1140.6 1153.9 1161.2 1201.0 16645.5 16732.2 16771.2 16807.6 16903.8 540707.0 544166.0 548835.0 551092.0 553402.0 56052.0 56342.4 56550.0 56571.7 56623.2 1276.3 1299.0 1306.5 1314.8 1338.9 29807.3 30673.0 31069.8 31221.3 31432.4 49687.0 49993.5 50172.2 50173.5 50380.7 420071.4 420975.0 422573.0 422692.0 423140.0 26694.6 27310.5 27583.6 27607.3 27658.0 46117.5 46121.0 46186.8 46974.8 47542.3 39712.2 40750.8 40824.4 40953.6 41138.4 39357.6 39924.4 40019.6 40391.6 40612.2 39415.0 39729.2 40251.0 40365.4 42750.0 33680.0 37232.6 37275.8 37610.0 37675.4 27231.9 27607.6 27722.7 27790.0 27825.4 19:23:52 INFO - PROCESS | 3414 | 19:23:52 INFO - PROCESS | 3414 | [#2] jquery.html Cycles:180 Average:28900.65 Median:1653.12 stddev:80490.30 (4869.0%) stddev-sans-first:80687.63 19:23:52 INFO - PROCESS | 3414 | Values: 390.9 391.4 393.8 395.5 407.9 13835.0 18440.3 18528.9 19935.7 20008.3 18454.2 19130.4 19313.1 19398.5 19417.8 5583.2 5668.2 5755.5 5787.6 5792.1 5506.8 5658.9 5664.9 5671.9 5682.0 5455.1 5605.4 5624.0 5753.7 5764.5 5554.6 5586.4 5597.1 5607.6 5648.9 5617.4 5715.5 5735.3 5774.2 5798.8 19851.6 20889.6 22114.8 22287.9 22309.7 2279.4 2299.9 2306.1 2363.4 2915.4 9737.5 9845.5 9899.8 9975.7 10042.6 1827.7 1909.8 1913.8 1929.6 1935.1 78494.6 81393.2 81434.0 82522.0 82887.0 10409.6 10795.5 11005.6 11138.8 11518.1 15131.9 15201.2 15252.1 15280.3 15305.0 8150.0 8226.3 8317.2 8326.2 8343.7 7862.0 7864.0 7891.9 8079.2 8092.7 4642.3 4661.4 4706.4 4738.8 4842.7 1951.9 1976.4 2001.6 2028.4 2040.6 868.6 910.6 936.3 994.7 1007.8 18328.6 18389.8 18799.9 19256.2 19541.0 1003.3 1005.2 1010.3 1014.8 1020.7 10259.1 10620.6 10675.3 10697.5 10720.5 478981.0 485490.0 487732.0 488188.0 496171.0 77683.6 87036.0 97000.5 98291.0 101989.0 1042.6 1044.3 1048.5 1049.0 1052.6 17231.7 17238.7 17677.4 17801.5 17902.3 42915.0 42975.8 43778.1 43897.0 44012.8 61382.5 61862.4 62075.0 62910.7 63131.4 8059.0 8147.6 8248.1 8317.3 8521.8 12233.3 12685.5 12942.2 13423.4 13588.8 10087.3 10246.2 10323.4 10342.4 10389.5 11501.6 11876.0 12008.7 12037.2 12373.8 10244.6 10276.7 10286.5 10476.3 10538.7 8531.8 8673.8 8706.4 8785.0 8832.2 9703.4 9915.8 10299.3 10302.2 10339.8 19:23:52 INFO - PROCESS | 3414 | 19:23:52 INFO - PROCESS | 3414 | [#3] mootools.html Cycles:180 Average:5739.41 Median:4772.84 stddev:3250.32 (68.1%) stddev-sans-first:3243.62 19:23:52 INFO - PROCESS | 3414 | Values: 1472.5 1507.2 1613.5 1779.4 1783.8 7738.3 8437.1 8484.7 8923.4 9025.7 8544.0 8717.3 8809.3 8824.9 8832.9 2300.5 2328.4 2340.6 2344.4 2344.7 2300.4 2323.4 2332.4 2343.1 2345.3 2304.1 2307.3 2320.0 2347.3 2347.4 2281.5 2287.8 2292.5 2298.0 2301.5 2237.6 2245.6 2249.2 2257.4 2265.3 8687.3 8760.4 8778.5 8828.4 8840.1 5150.5 5254.5 5299.0 5305.7 5317.2 3089.0 3148.7 3199.3 3207.3 3209.3 1062.7 1067.2 1077.4 1087.0 1115.3 11926.3 11980.8 12040.3 12042.5 12063.8 4458.8 4500.6 4684.5 4692.5 4704.4 9655.8 9656.8 9671.3 9681.6 9705.0 5222.8 5238.8 5254.2 5262.6 5281.5 4213.5 4677.6 4841.2 4848.2 4873.3 4010.7 4032.1 4088.5 4137.5 4141.3 1248.3 1320.9 1328.5 1336.1 1338.2 895.5 982.8 986.6 994.8 1012.1 5970.3 6117.5 6140.0 6185.4 6197.8 435.7 435.7 438.6 440.8 451.0 3973.0 4062.3 4104.1 4117.2 4145.8 10658.0 10813.3 10819.7 10912.0 10919.2 10743.7 10779.7 10811.6 10831.1 10833.6 7828.3 8169.8 8193.4 8279.4 8283.0 5845.9 6132.2 6150.7 6167.0 6277.8 9700.4 10058.2 10080.2 10148.3 10181.1 9984.8 10070.8 10105.2 10124.7 10129.8 6968.1 7546.6 7736.6 7812.8 7961.7 8457.5 8472.2 8521.2 8533.7 8549.0 7292.3 7527.0 7556.6 7602.5 7689.5 7389.2 7429.4 7492.9 7549.1 7639.1 6809.5 6810.8 6883.0 6890.6 6899.6 5157.4 5168.9 5218.9 5221.6 5387.1 5187.4 5409.2 5442.1 5445.9 5529.1 19:23:52 INFO - PROCESS | 3414 | 19:23:52 INFO - PROCESS | 3414 | [#4] prototype.html Cycles:180 Average:4896.72 Median:5523.86 stddev:1455.28 (26.3%) stddev-sans-first:1418.03 19:23:52 INFO - PROCESS | 3414 | Values: 308.8 321.1 323.5 323.8 327.4 5506.6 5629.6 5663.2 5749.6 5785.9 5654.3 5702.9 5710.6 5728.3 5751.4 4397.0 4439.0 4444.6 4453.1 4460.0 4342.7 4403.4 4413.7 4416.0 4442.7 4344.4 4388.6 4400.1 4400.2 4413.8 4404.8 4407.6 4412.2 4419.6 4424.5 3758.5 3824.5 3869.1 3881.7 3886.0 5575.2 5583.6 5592.0 5607.6 5643.5 5007.5 5056.1 5084.1 5091.4 5097.6 5733.3 5980.6 5998.3 5998.7 6015.1 4253.0 4269.2 4275.7 4276.2 4284.5 6166.0 6271.4 6290.3 6299.7 6321.2 4189.8 4291.7 4309.5 4322.7 4334.8 4337.2 4351.0 4355.2 4375.6 4394.4 5005.0 5021.4 5040.9 5050.5 5079.3 5595.0 5800.9 5952.5 6050.5 6065.9 1429.0 1450.5 1450.8 1451.3 1456.8 906.7 927.1 936.9 941.4 950.8 5101.2 5103.9 5111.0 5179.8 5215.8 5405.2 5458.7 5489.5 5526.9 5531.8 4942.5 5013.9 5158.6 5181.9 5184.3 2889.9 2941.9 2948.9 2951.9 2955.9 5541.3 5556.6 5585.5 5594.9 5696.4 5319.0 5426.6 5520.9 5555.5 5602.4 5611.3 5640.4 5650.0 5651.3 5666.5 5315.7 5379.8 5456.9 5481.2 5742.8 6126.0 6135.2 6145.9 6159.0 6184.8 6366.8 6421.3 6470.3 6476.3 6488.8 4188.0 4292.7 4312.6 4325.2 4330.8 5954.3 6062.8 6253.8 6260.4 6275.4 5988.0 6023.2 6045.9 6062.8 6066.4 6040.3 6046.8 6051.3 6077.4 6086.6 5749.7 6004.3 6006.5 6016.2 6048.9 6115.3 6115.8 6120.3 6125.5 6134.6 5561.6 5938.5 5947.6 5991.1 5994.6 19:23:52 INFO - PROCESS | 3414 | 19:23:52 INFO - PROCESS | 3414 | [#5] yui.html Cycles:180 Average:19716.13 Median:5029.26 stddev:27514.75 (547.1%) stddev-sans-first:27554.99 19:23:52 INFO - PROCESS | 3414 | Values: 725.4 737.5 781.8 820.7 852.3 14364.9 15643.1 15765.6 15797.4 15887.2 13378.3 13486.5 13517.9 13524.7 13529.5 633.4 760.7 768.3 790.4 799.2 774.3 781.5 784.4 785.9 786.4 838.5 848.5 850.7 855.3 855.3 836.1 840.4 841.6 843.0 843.7 610.0 616.6 618.3 620.5 621.0 13641.2 13673.6 13786.7 13787.0 13804.7 14855.5 14873.3 14890.3 15094.8 15162.6 12203.1 12216.8 12363.3 12567.6 12584.4 3941.5 3996.7 4075.7 4159.4 4165.5 72124.3 75458.0 76220.0 76345.6 76592.0 11764.5 11784.0 12051.8 12229.3 12238.1 21949.9 22234.8 22396.3 22397.6 22450.1 8783.5 9138.7 9168.4 9203.7 9207.1 4871.9 5007.3 5051.2 5177.4 5187.1 3212.3 3381.3 3411.5 3413.6 3416.1 587.6 590.2 602.3 607.7 609.8 726.0 732.9 754.3 769.9 791.9 9546.4 9630.2 9757.7 9780.2 10328.5 707.6 735.2 754.4 765.5 770.7 4829.5 4852.4 4893.6 4907.0 4954.9 61610.0 61846.0 75422.0 111465.0 112446.0 94377.5 96423.5 97062.0 97883.0 98069.0 84471.6 85041.6 85361.0 85714.0 86130.6 9188.4 9298.5 9422.7 9432.4 9447.5 49595.0 51493.5 51971.7 52506.1 53694.0 67793.7 73066.0 73680.6 75021.0 76147.0 11612.9 11790.7 12045.4 12726.8 13348.5 13283.5 13332.8 13431.6 13670.2 13689.2 12021.4 12311.4 12403.9 12897.5 12964.4 12594.6 12664.4 13078.8 13312.1 13423.7 12558.7 13005.5 13064.2 13469.0 13482.6 10295.3 10690.3 10853.9 10948.8 11261.7 10627.5 10711.6 10764.5 10870.5 10899.7 19:23:52 INFO - PROCESS | 3414 | -------- Summary: end -------- 19:23:52 INFO - PROCESS | 3414 | 19:23:52 INFO - TEST-INFO | 3414: exit 0 19:23:53 INFO - TEST-OK | dromaeo_css | took 1112586ms 19:23:53 INFO - TEST-START | kraken 19:23:53 INFO - operating with platform_type : linux_ 19:23:53 INFO - Initialising browser for kraken test... 19:23:53 INFO - TEST-INFO | started process 3660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Iu3KZ/profile http://localhost:48934/getInfo.html) 19:23:57 INFO - PROCESS | 3660 | __metrics Screen width/height:1600/1200 19:23:57 INFO - PROCESS | 3660 | colorDepth:24 19:23:57 INFO - PROCESS | 3660 | Browser inner width/height: 1024/697 19:23:57 INFO - PROCESS | 3660 | __metrics 19:23:58 ERROR - PROCESS | 3660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 19:23:58 INFO - TEST-INFO | 3660: exit 0 19:23:58 INFO - Browser initialized. 19:23:58 INFO - Running cycle 1/1 for kraken test... 19:23:58 INFO - TEST-INFO | started process 3781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Iu3KZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:10 INFO - PROCESS | 3781 | RSS: Main: 168153088 19:24:10 INFO - PROCESS | 3781 | 19:24:13 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:48934/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48934/tests/kraken/driver.html?testName=audio-beat-detection) 19:24:14 INFO - PROCESS | 3781 | RSS: Main: 173776896 19:24:14 INFO - PROCESS | 3781 | 19:24:16 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:48934/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48934/tests/kraken/driver.html?testName=audio-dft) 19:24:17 INFO - PROCESS | 3781 | RSS: Main: 173768704 19:24:17 INFO - PROCESS | 3781 | 19:24:20 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:48934/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48934/tests/kraken/driver.html?testName=audio-fft) 19:24:21 INFO - PROCESS | 3781 | RSS: Main: 168501248 19:24:21 INFO - PROCESS | 3781 | 19:24:23 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:48934/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48934/tests/kraken/driver.html?testName=audio-oscillator) 19:24:23 INFO - PROCESS | 3781 | RSS: Main: 169086976 19:24:23 INFO - PROCESS | 3781 | 19:24:25 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:48934/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48934/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:24:26 INFO - PROCESS | 3781 | RSS: Main: 169467904 19:24:26 INFO - PROCESS | 3781 | 19:24:29 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:48934/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48934/tests/kraken/driver.html?testName=imaging-darkroom) 19:24:30 INFO - PROCESS | 3781 | RSS: Main: 169316352 19:24:30 INFO - PROCESS | 3781 | 19:24:33 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:48934/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48934/tests/kraken/driver.html?testName=imaging-desaturate) 19:24:34 INFO - PROCESS | 3781 | RSS: Main: 167419904 19:24:34 INFO - PROCESS | 3781 | 19:24:37 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:48934/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48934/tests/kraken/driver.html?testName=json-parse-financial) 19:24:37 INFO - PROCESS | 3781 | RSS: Main: 168845312 19:24:37 INFO - PROCESS | 3781 | 19:24:39 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:48934/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48934/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:24:39 INFO - PROCESS | 3781 | RSS: Main: 168919040 19:24:39 INFO - PROCESS | 3781 | 19:24:41 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:48934/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48934/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:24:42 INFO - PROCESS | 3781 | RSS: Main: 169181184 19:24:42 INFO - PROCESS | 3781 | 19:24:44 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:48934/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48934/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:24:45 INFO - PROCESS | 3781 | RSS: Main: 169623552 19:24:45 INFO - PROCESS | 3781 | 19:24:47 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:48934/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:24:48 INFO - PROCESS | 3781 | RSS: Main: 169943040 19:24:48 INFO - PROCESS | 3781 | 19:24:51 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:48934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:24:51 INFO - PROCESS | 3781 | RSS: Main: 169758720 19:24:51 INFO - PROCESS | 3781 | 19:24:53 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:48934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48934/tests/kraken/driver.html?testName=ai-astar) 19:24:54 INFO - PROCESS | 3781 | RSS: Main: 170631168 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - PROCESS | 3781 | __start_tp_report 19:24:54 INFO - PROCESS | 3781 | _x_x_mozilla_page_load 19:24:54 INFO - PROCESS | 3781 | _x_x_mozilla_page_load_details 19:24:54 INFO - PROCESS | 3781 | |i|pagename|runs| 19:24:54 INFO - PROCESS | 3781 | |0;ai-astar;104;111;106;112;112;113;113;112;111;111 19:24:54 INFO - PROCESS | 3781 | |1;audio-beat-detection;151;123;147;167;117;149;150;122;171;120 19:24:54 INFO - PROCESS | 3781 | |2;audio-dft;162;163;161;160;164;165;167;167;161;160 19:24:54 INFO - PROCESS | 3781 | |3;audio-fft;74;74;86;163;75;76;75;75;171;76 19:24:54 INFO - PROCESS | 3781 | |4;audio-oscillator;84;85;151;84;85;85;139;84;84;159 19:24:54 INFO - PROCESS | 3781 | |5;imaging-gaussian-blur;118;117;117;117;117;118;117;117;118;117 19:24:54 INFO - PROCESS | 3781 | |6;imaging-darkroom;147;147;148;148;147;148;147;147;147;149 19:24:54 INFO - PROCESS | 3781 | |7;imaging-desaturate;95;96;96;96;96;95;96;97;96;96 19:24:54 INFO - PROCESS | 3781 | |8;json-parse-financial;53;55;55;56;61;56;56;54;55;53 19:24:54 INFO - PROCESS | 3781 | |9;json-stringify-tinderbox;61;62;62;62;61;62;61;60;64;61 19:24:54 INFO - PROCESS | 3781 | |10;stanford-crypto-aes;76;81;76;78;74;76;75;74;79;79 19:24:54 INFO - PROCESS | 3781 | |11;stanford-crypto-ccm;123;127;124;123;120;130;136;128;162;123 19:24:54 INFO - PROCESS | 3781 | |12;stanford-crypto-pbkdf2;161;162;163;159;167;160;167;160;160;162 19:24:54 INFO - PROCESS | 3781 | |13;stanford-crypto-sha256-iterative;64;63;64;64;66;63;64;64;63;66 19:24:54 INFO - PROCESS | 3781 | __end_tp_report 19:24:54 INFO - PROCESS | 3781 | __start_cc_report 19:24:54 INFO - PROCESS | 3781 | _x_x_mozilla_cycle_collect,953 19:24:54 INFO - PROCESS | 3781 | __end_cc_report 19:24:54 INFO - PROCESS | 3781 | __startTimestamp1467771894015__endTimestamp 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - PROCESS | 3781 | ------- Summary: start ------- 19:24:54 INFO - PROCESS | 3781 | Number of tests: 14 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - PROCESS | 3781 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.03 (2.7%) stddev-sans-first:2.11 19:24:54 INFO - PROCESS | 3781 | Values: 104.0 111.0 106.0 112.0 112.0 113.0 113.0 112.0 111.0 111.0 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - PROCESS | 3781 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:149.50 stddev:19.87 (13.3%) stddev-sans-first:20.79 19:24:54 INFO - PROCESS | 3781 | Values: 151.0 123.0 147.0 167.0 117.0 149.0 150.0 122.0 171.0 120.0 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - PROCESS | 3781 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.50 stddev:2.67 (1.6%) stddev-sans-first:2.80 19:24:54 INFO - PROCESS | 3781 | Values: 162.0 163.0 161.0 160.0 164.0 165.0 167.0 167.0 161.0 160.0 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - PROCESS | 3781 | [#3] audio-fft Cycles:10 Average:94.50 Median:75.00 stddev:38.42 (51.2%) stddev-sans-first:40.02 19:24:54 INFO - PROCESS | 3781 | Values: 74.0 74.0 86.0 163.0 75.0 76.0 75.0 75.0 171.0 76.0 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - PROCESS | 3781 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:84.00 stddev:31.87 (37.9%) stddev-sans-first:32.97 19:24:54 INFO - PROCESS | 3781 | Values: 84.0 85.0 151.0 84.0 85.0 85.0 139.0 84.0 84.0 159.0 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - PROCESS | 3781 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 19:24:54 INFO - PROCESS | 3781 | Values: 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - PROCESS | 3781 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 19:24:54 INFO - PROCESS | 3781 | Values: 147.0 147.0 148.0 148.0 147.0 148.0 147.0 147.0 147.0 149.0 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - PROCESS | 3781 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 19:24:54 INFO - PROCESS | 3781 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 96.0 97.0 96.0 96.0 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - PROCESS | 3781 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:2.27 (4.1%) stddev-sans-first:2.24 19:24:54 INFO - PROCESS | 3781 | Values: 53.0 55.0 55.0 56.0 61.0 56.0 56.0 54.0 55.0 53.0 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - PROCESS | 3781 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:1.07 (1.7%) stddev-sans-first:1.12 19:24:54 INFO - PROCESS | 3781 | Values: 61.0 62.0 62.0 62.0 61.0 62.0 61.0 60.0 64.0 61.0 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - PROCESS | 3781 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:77.00 stddev:2.35 (3.0%) stddev-sans-first:2.47 19:24:54 INFO - PROCESS | 3781 | Values: 76.0 81.0 76.0 78.0 74.0 76.0 75.0 74.0 79.0 79.0 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - PROCESS | 3781 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:127.50 stddev:12.27 (9.6%) stddev-sans-first:12.78 19:24:54 INFO - PROCESS | 3781 | Values: 123.0 127.0 124.0 123.0 120.0 130.0 136.0 128.0 162.0 123.0 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - PROCESS | 3781 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:162.00 stddev:2.85 (1.8%) stddev-sans-first:2.99 19:24:54 INFO - PROCESS | 3781 | Values: 161.0 162.0 163.0 159.0 167.0 160.0 167.0 160.0 160.0 162.0 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - PROCESS | 3781 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 19:24:54 INFO - PROCESS | 3781 | Values: 64.0 63.0 64.0 64.0 66.0 63.0 64.0 64.0 63.0 66.0 19:24:54 INFO - PROCESS | 3781 | -------- Summary: end -------- 19:24:54 INFO - PROCESS | 3781 | 19:24:54 INFO - TEST-INFO | 3781: exit 0 19:24:54 INFO - TEST-OK | kraken | took 61986ms 19:24:54 INFO - SUITE-END | took 1174s 19:24:55 INFO - Completed test suite (00:19:34) 19:24:55 INFO - javascript benchmark 19:24:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7251.700462672665, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.114757294171, 3177.38041081989, 3189.6331921828983, 3194.4729119695253, 3200.2799370141706, 5418.133098704208, 5443.292371991641, 5456.918146227805, 5525.723713814304, 5590.776368945248, 5291.3385826771655, 5385.434529374418, 5418.8916221675545, 5422.53908417784, 5481.260029895963, 4917.852464426064, 4947.8268260610885, 5027.648064635477, 5071.518205770446, 5110.565601923841, 885.5664547426943, 4966.428860681014, 5086.6693664911845, 5092.770825312851, 5117.385913690344, 4916.803327866917, 4949.752512374367, 4963.578095861838, 4968.205087186051, 5017.974910125426, 4898.363212782351, 4963.354763880709, 4970.378702662168, 5013.573846223076, 5028.446870844205, 4846.466888642247, 4873.80504779812, 4879.560839524424, 4892.412910450733, 4901.50984901507, 5403.945960540384, 5411.675299482004, 5420.376656684492, 5457.808976685837, 5511.751971161268, 5759.136129580596, 5827.096799996008, 5835.212246346731, 5837.270341207349, 5842.0, 5860.970695146497, 5865.237519122529, 5915.556333275022, 5933.0, 5970.850728731773, 5517.393086760453, 5531.446855314477, 5535.889282214373, 5541.113421852484, 5545.279113715232, 5862.237909071793, 5965.910511342333, 5992.0712289595185, 6021.488173505213, 6035.0, 5842.503387212049, 5846.269216347957, 5848.912266316009, 5850.912236316459, 5852.063669812809, 5928.051511758098, 5929.258842644669, 5932.7923522677365, 5935.436133567304, 5937.198478205473, 5678.949394361974, 5719.885602287931, 5788.942110578924, 5798.536117110621, 5799.710014499258, 5678.205051292823, 5767.88464230713, 5810.912836307459, 5821.09772985188, 5881.558883083786, 4412.558744125562, 4422.491413487426, 4434.667399944952, 4454.1982443159895, 4483.0, 3845.0, 3882.6699730523223, 3946.0134966258433, 3953.4267531207815, 3981.3231750602467, 5560.082586373203, 5596.608237423341, 5607.635503692247, 5610.943890561124, 5613.101903695389, 5817.7382017809305, 5849.976254155506, 5885.058390657474, 5893.204417403681, 5932.881342373128, 5385.0, 5569.081101618269, 5630.859228519238, 5631.521320687705, 5643.40744221859, 5057.241413787961, 5083.517065878736, 5105.2086926526445, 5116.8209112681625, 5121.718305493234, 5882.588218824641, 6110.29731580865, 6116.082587611894, 6132.6933653317155, 6135.815925522242, 5806.709664516758, 5890.646561206341, 5921.289445266423, 5929.881402371842, 5937.198478205387, 6031.035034394651, 6037.154798328325, 6085.4523092921845, 6092.208012958287, 6098.451139397475, 5668.0, 5735.770569177186, 5736.741846616996, 5765.682887441231, 5779.306483222041, 5855.414458554281, 5900.085486749561, 5903.970480147572, 5932.377100404396, 5969.462748352669, 5690.260266165372, 5703.771849125988, 5719.256496655408, 5775.595708300379, 5792.362840087671, 5617.185508101221, 5644.068728659725, 5694.259746232963, 5751.1085781703905, 5770.711464426846, 5541.3904470507405, 5594.86012849682, 5641.971790141187, 5660.405657405913, 5718.914216286676, 5737.397573254748, 5743.770249189985, 5781.913271300849, 5788.710564471844, 5790.39200883918, 5544.667319960815, 5634.126710359901, 5668.51817595509, 5669.34802497718, 5678.574106941914], "value": 5370.9932230019795, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.124341648736, 597.766870920341, 616.4421198815071, 619.0250355689786, 637.9585326953745, 41670.37494437586, 42648.573514264885, 42828.57171428285, 45742.0, 45937.0812583749, 43618.34572481416, 44145.7792711036, 44241.55758442423, 44554.0, 44863.551364486346, 8861.37970342078, 8988.59551320192, 9017.45895246284, 9021.503817290046, 9056.547172641342, 8854.981677107118, 8858.424202426853, 8890.73327800167, 8907.153820387086, 8911.643534258621, 8919.910800891972, 8962.641494340218, 8964.775880602972, 9003.5048072356, 9036.915570131594, 8933.19601235892, 8941.284697224239, 8986.68546600869, 8998.415103018282, 9008.279337652972, 8840.469571825712, 8878.955605221998, 8892.15524525169, 8904.065073167354, 8910.19808217257, 41005.38491922594, 41011.58988410138, 41448.585514144776, 41548.79225603853, 41669.583304166874, 3296.3572103439838, 3465.2722928185112, 3533.116720819795, 3538.840752166133, 3646.6535679110443, 28803.135905922856, 31698.0, 31703.0, 31732.365352692817, 31797.682023179936, 4272.487301523837, 4344.7827608619755, 4434.578715022068, 4477.843275485375, 4540.841070562515, 336383.0, 339593.0, 340588.0, 341087.0, 341502.2924885384, 57992.71003644955, 58109.70945145247, 58605.70697146487, 58679.0, 58755.118673219935, 34854.0, 60746.69626651927, 60874.69562652247, 61290.0, 61322.693386533676, 16708.916455417646, 17609.7358539622, 17694.823051769574, 17715.911420442815, 17735.113244337732, 13247.403866826016, 13353.532626358225, 13453.0, 13465.730685386237, 13466.730665386833, 18974.810251897303, 19071.332503362315, 19182.0, 19207.231710731692, 19241.4227573173, 6969.2682268361095, 7129.7861064168155, 7277.126744790659, 7296.197418283985, 7344.889826652605, 958.3483231402713, 1036.4092467293722, 1062.792755412687, 1091.8689757229183, 1100.3782862682558, 31479.0, 31525.0, 31788.682113179035, 31807.84096079505, 31821.20446988844, 1094.195766111907, 1140.5950887434842, 1153.8673052599058, 1161.233585833363, 1200.9759804803855, 16645.50063498097, 16732.16339183036, 16771.2452939618, 16807.579810504834, 16903.81983327112, 540707.0, 544166.0, 548835.0, 551092.0, 553402.0, 56052.0, 56342.436575634536, 56550.0, 56571.717141414854, 56623.150652740245, 1276.304414094321, 1298.9740205195844, 1306.4839388441512, 1314.8290722206052, 1338.9330533473287, 29807.254818629706, 30673.0, 31069.844650776602, 31221.253449585285, 31432.37135257236, 49687.0, 49993.50006500034, 50172.247416289516, 50173.498265018345, 50380.74809625928, 420071.3942884501, 420975.0, 422573.0, 422692.0, 423140.0, 26694.59958100591, 27310.45379092447, 27583.586246206723, 27607.30981725473, 27658.031968881798, 46117.53882461132, 46121.0, 46186.769066154455, 46974.76512617415, 47542.28686569774, 39712.20575588414, 40750.79624601858, 40824.38763418492, 40953.59046409498, 41138.38292425556, 39357.606423935395, 39924.40113398359, 40019.599804001584, 40391.596084038785, 40612.18775624412, 39415.0, 39729.205415890945, 40251.0, 40365.39451908282, 42750.0, 33680.0, 37232.62767372291, 37275.81362093281, 37610.0, 37675.43486847645, 27231.86384068146, 27607.58588621132, 27722.722772772013, 27790.0, 27825.44349113047], "value": 20004.27774832756, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.8592906553642, 391.3835708758705, 393.7834191194842, 395.5075930466569, 407.93880917862316, 13835.0, 18440.262389504438, 18528.90735546322, 19935.700964485528, 20008.29970951017, 18454.16956236969, 19130.426087217405, 19313.130909109088, 19398.515037124078, 19417.805821941776, 5583.218349431083, 5668.206451096849, 5755.510781583571, 5787.623804452718, 5792.073268277077, 5506.834794956138, 5658.886822263552, 5664.915026274609, 5671.886562268752, 5682.034054210794, 5455.072637651609, 5605.383407825136, 5623.971880140593, 5753.741081651336, 5764.452377024176, 5554.583406244547, 5586.41342659021, 5597.104463285875, 5607.607467477278, 5648.9152662709685, 5617.382087970361, 5715.514181294595, 5735.283089613798, 5774.162746401748, 5798.768049278024, 19851.602967940704, 20889.5822083559, 22114.778852211595, 22287.888560557254, 22309.665355019686, 2279.3959600705825, 2299.9310020699404, 2306.0660432524855, 2363.3973336799177, 2915.3731947631363, 9737.513124343825, 9845.45849978251, 9899.80200395988, 9975.650852220137, 10042.648507302209, 1827.7075667893073, 1909.809019098093, 1913.7703475583019, 1929.5754933914516, 1935.0808366026024, 78494.60752696257, 81393.18606813916, 81434.0, 82522.0, 82887.0, 10409.5836166554, 10795.46022698862, 11005.559777608805, 11138.832917506244, 11518.136139789549, 15131.924340378448, 15201.163935983406, 15252.084874907541, 15280.31238594266, 15305.0, 8149.959250203711, 8226.341892648574, 8317.20986506293, 8326.209010144026, 8343.749687509384, 7862.0, 7864.033991502124, 7891.881621775678, 8079.192080791874, 8092.71675491355, 4642.280446530793, 4661.440627124767, 4706.42334817833, 4738.8341408050555, 4842.7336496493035, 1951.9024048797503, 1976.416956997689, 2001.599680063964, 2028.3813436901592, 2040.5918816236813, 868.561376504861, 910.5765818894114, 936.279065119854, 994.7065615643403, 1007.7531004903846, 18328.633427331377, 18389.81610183881, 18799.90600046991, 19256.22975081009, 19541.0, 1003.3027046202965, 1005.1958433253515, 1010.3382284603597, 1014.8477728340808, 1020.7039958412125, 10259.127974122133, 10620.628278010387, 10675.25273230882, 10697.465126743631, 10720.46397680113, 478981.0, 485490.0, 487732.0, 488188.0, 496171.0, 77683.61158194173, 87036.0, 97000.54499182518, 98291.0, 101989.0, 1042.6402891002592, 1044.2585764107569, 1048.5229220704562, 1048.99475502622, 1052.6052730226165, 17231.655366892843, 17238.655226895644, 17677.38129165473, 17801.46595602134, 17902.28390864351, 42915.0, 42975.785121074194, 43778.12443751171, 43897.0, 44012.779936100116, 61382.541829051326, 61862.381376185665, 62075.0, 62910.685446572475, 63131.36868631255, 8059.0, 8147.63335649909, 8248.092709802037, 8317.293030092267, 8521.786955326166, 12233.26600403943, 12685.492580296685, 12942.223466592035, 13423.395947182595, 13588.796168057685, 10087.29388942767, 10246.231532634933, 10323.432211228455, 10342.37945723259, 10389.480525973822, 11501.597444089752, 11876.0, 12008.699782505508, 12037.217580857216, 12373.814392783936, 10244.64143754965, 10276.743081423025, 10286.485675716334, 10476.266661333633, 10538.683839484827, 8531.786705332417, 8673.783155420913, 8706.434081784664, 8784.956075219583, 8832.160944710242, 9703.369280996712, 9915.801683966136, 10299.330543514947, 10302.175825934057, 10339.84490232632], "value": 9107.362595126113, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1472.477270568948, 1507.1861194954724, 1613.50788009657, 1779.4127937780543, 1783.8126996665342, 7738.303552680258, 8437.071922088566, 8484.745457636282, 8923.419977701453, 9025.729228123151, 8543.957280213606, 8717.259032982203, 8809.339299552526, 8824.91175088249, 8832.867506987384, 2300.5283916797057, 2328.441174118208, 2340.578695834749, 2344.3904584807988, 2344.6834677318598, 2300.3559003479054, 2323.361075704178, 2332.3819187915215, 2343.0979073056824, 2345.319857241398, 2304.089884495623, 2307.3424074138875, 2320.0, 2347.295811256625, 2347.4131467133216, 2281.5208806150727, 2287.8284128690416, 2292.4727312718087, 2298.0463107810324, 2301.4821665125296, 2237.630790919496, 2245.6070187717246, 2249.201533455616, 2257.413072601119, 2265.286434773058, 8687.348448866298, 8760.4305720128, 8778.473291602524, 8828.382013259074, 8840.071792461764, 5150.510701483353, 5254.474552544753, 5299.046171689094, 5305.65513241638, 5317.229001794757, 3088.984555077233, 3148.6536480987074, 3199.2641692410875, 3207.262329664167, 3209.3420848725955, 1062.718379629399, 1067.210264404343, 1077.3912739302268, 1087.0162502934857, 1115.275071203716, 11926.284422934565, 11980.760384792255, 12040.337781422018, 12042.458089385998, 12063.758724825455, 4458.799354029076, 4500.594946454835, 4684.484706682262, 4692.4603670577635, 4704.435467743824, 9655.758606034764, 9656.75858103553, 9671.274654400948, 9681.564329605184, 9704.951475242578, 5222.791088356499, 5238.842834714965, 5254.2118682197215, 5262.631615786858, 5281.524662780292, 4213.4522512073845, 4677.649176311722, 4841.249606310957, 4848.200046992207, 4873.31773551703, 4010.7393019453643, 4032.0927791247323, 4088.509378874554, 4137.46212992309, 4141.275276826544, 1248.3259040118417, 1320.8679132086716, 1328.5018118205674, 1336.0580790542645, 1338.1903948111446, 895.5298468304062, 982.7887253679222, 986.605357856863, 994.8109859126743, 1012.0638409471356, 5970.283565972024, 6117.480014198754, 6139.969300153471, 6185.41238582334, 6197.845053873689, 435.6514788169515, 435.72331569453627, 438.64469779478725, 440.8479074719217, 451.04603763040933, 3972.980135099306, 4062.289099407592, 4104.117614712851, 4117.21772863155, 4145.834166633361, 10658.0, 10813.297135686313, 10819.675409737563, 10912.0, 10919.181061420426, 10743.677689669323, 10779.676609701564, 10811.6215932442, 10831.079358254636, 10833.620823271147, 7828.334591559781, 8169.836603267901, 8193.385496087818, 8279.420440569102, 8283.0, 5845.883082338414, 6132.202813634199, 6150.661713605795, 6167.0, 6277.811665650038, 9700.417974921245, 10058.19534437258, 10080.193584513074, 10148.289619726844, 10181.083702466814, 9984.800303994025, 10070.848937266093, 10105.19158467306, 10124.746881328027, 10129.848052279074, 6968.128983877015, 7546.584937828472, 7736.613169341623, 7812.765617031499, 7961.681532738626, 8457.492550446992, 8472.152784721478, 8521.233089022018, 8533.74398768013, 8548.957255213933, 7292.307230813064, 7527.0, 7556.584387858501, 7602.50583712057, 7689.538627682357, 7389.224131466119, 7429.368503677248, 7492.925070749223, 7549.0563679540055, 7639.083310002835, 6809.489288303496, 6810.761623343159, 6883.0, 6890.586564806128, 6899.586024838526, 5157.355330583677, 5168.922466163086, 5218.869528261824, 5221.556167725786, 5387.084195686664, 5187.403448603459, 5409.215663728816, 5442.074847275893, 5445.891082178414, 5529.115341545334], "value": 4524.784489591551, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.81008179969314, 321.06089687663587, 323.5324955439391, 323.83969934882236, 327.43844307013467, 5506.614536982413, 5629.6340737852115, 5663.225019740328, 5749.597528173024, 5785.942140578598, 5654.349749778777, 5702.857428564288, 5710.628809127404, 5728.25532680752, 5751.367349591542, 4396.978015109928, 4438.979034821993, 4444.555544445546, 4453.109378124372, 4460.0, 4342.717723347972, 4403.4495688039, 4413.735175889441, 4415.955840441603, 4442.733435993835, 4344.370066340379, 4388.583084606973, 4400.119976004796, 4400.227856450431, 4413.823447062114, 4404.8458303959205, 4407.581279778416, 4412.205802955451, 4419.602235798778, 4424.469063712343, 3758.5113935188524, 3824.541055073409, 3869.052082239841, 3881.7088718346236, 3885.9805700971597, 5575.191597218381, 5583.553315734772, 5592.049351610236, 5607.57943154261, 5643.520300774439, 5007.522780779679, 5056.115179843549, 5084.084864724348, 5091.414487333967, 5097.617678674114, 5733.283339582552, 5980.611260268069, 5998.28020637522, 5998.730057147439, 6015.127806468037, 4252.978735106305, 4269.210196113729, 4275.657947364203, 4276.23027854986, 4284.479009951454, 6165.969170154121, 6271.404216599416, 6290.276618188921, 6299.7085597452415, 6321.209848768904, 4189.769562674082, 4291.6566674665955, 4309.482862056573, 4322.7190232634775, 4334.804933777988, 4337.240982827992, 4351.0210202704775, 4355.237833379146, 4375.606195442426, 4394.406755088086, 5004.974975125101, 5021.372328458942, 5040.949590504121, 5050.49495050492, 5079.263506791494, 5594.9720251398485, 5800.88398232033, 5952.464278214981, 6050.515958723292, 6065.939340606626, 1428.992855035718, 1450.4995776457106, 1450.7751298548742, 1451.3468938977503, 1456.7960485532035, 906.7143849687327, 927.096081320707, 936.8735220745249, 941.4492521874643, 950.8383574792164, 5101.163581110797, 5103.87240318995, 5110.958979407247, 5179.792808287626, 5215.844414129473, 5405.243265942771, 5458.6724796512335, 5489.533389661844, 5526.861828454321, 5531.806386776443, 4942.5057494251005, 5013.874653133628, 5158.555604430765, 5181.859990802018, 5184.274201611777, 2889.942201155965, 2941.911742647724, 2948.8967886123883, 2951.896683616063, 2955.9110729287945, 5541.337598720368, 5556.555475561945, 5585.497305242548, 5594.888102237933, 5696.430356964353, 5319.0, 5426.647267927572, 5520.861978450571, 5555.50000499957, 5602.411746766531, 5611.3266408031295, 5640.379558248589, 5650.039493286234, 5651.2935883014625, 5666.546676265889, 5315.654482458628, 5379.784808607768, 5456.890862182655, 5481.232627432242, 5742.799002034909, 6126.0, 6135.171751813448, 6145.907811382922, 6159.0, 6184.845378865564, 6366.77716279928, 6421.261554921244, 6470.320616335217, 6476.255230648536, 6488.826243208578, 4188.036751547223, 4292.720973136736, 4312.633426158812, 4325.178216138924, 4330.761808100585, 5954.285485741739, 6062.787802426894, 6253.78111766086, 6260.373962603885, 6275.403836635513, 5988.0, 6023.186869772525, 6045.939540604713, 6062.848428789315, 6066.3630318815885, 6040.335563088145, 6046.758129674764, 6051.33435322123, 6077.392260774064, 6086.60437071589, 5749.7125143741805, 6004.339522652417, 6006.489448396936, 6016.187814645142, 6048.879022419439, 6115.296740874856, 6115.785947491817, 6120.296165940796, 6125.509959203164, 6134.631922084689, 5561.610687251854, 5938.524918006463, 5947.583669143119, 5991.131285963598, 5994.580379373402], "value": 4418.3604187506235, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.4414101142117, 737.5095561451634, 781.7928249014009, 820.7414664380723, 852.2755657690964, 14364.928175359122, 15643.061416315, 15765.60585985351, 15797.447089351876, 15887.205639718011, 13378.264195469244, 13486.527971520998, 13517.864821351783, 13524.661883452918, 13529.526466573672, 633.3792882974687, 760.6653072648045, 768.2893323675605, 790.4032455496092, 799.2327365728908, 774.2992591704516, 781.5349866829256, 784.3607459920147, 785.9253370929781, 786.4455558831011, 838.5010918503481, 848.4697064334791, 850.6554845287668, 855.2730179347567, 855.3072011670566, 836.1429534726893, 840.4369072721291, 841.5834162089743, 843.026304618167, 843.7089204224533, 610.0270069239556, 616.5899676714979, 618.2951435363689, 620.534599050712, 620.9906851397233, 13641.181529108286, 13673.589792306248, 13786.724265514735, 13787.0, 13804.723905521832, 14855.48005819802, 14873.256337183206, 14890.329935152944, 15094.849051509564, 15162.620934476616, 12203.095443678618, 12216.816747748791, 12363.258204507758, 12567.622971310875, 12584.370781460982, 3941.5365396627108, 3996.72022958393, 4075.673946084306, 4159.396887451303, 4165.500139983191, 72124.2787572128, 75458.0, 76220.0, 76345.61827190884, 76592.0, 11764.529418823322, 11784.0, 12051.819222711667, 12229.327386993622, 12238.143329966995, 21949.890250548644, 22234.77765222327, 22396.328110156723, 22397.552048959256, 22450.10199591998, 8783.516906570072, 9138.725838224864, 9168.404053736485, 9203.677871274473, 9207.125323094295, 4871.853844384674, 5007.349044624176, 5051.166557517969, 5177.430482646906, 5187.118189907649, 3212.277237621563, 3381.3406385754542, 3411.4712219606, 3413.5562376890844, 3416.0947348952545, 587.6356658871441, 590.2179612014098, 602.3314121325326, 607.7022259093101, 609.823151286131, 725.9582499113789, 732.9047223860971, 754.294734423316, 769.8798248548349, 791.9010123734533, 9546.42721436716, 9630.229581633592, 9757.707268781947, 9780.217582593517, 10328.483575821328, 707.604515568788, 735.198633489499, 754.4153281207108, 765.4527013185487, 770.6570576093696, 4829.517048295143, 4852.393450818648, 4893.632977526629, 4906.975465122651, 4954.900901982012, 61610.0, 61846.0, 75422.0, 111465.0, 112446.0, 94377.528112359, 96423.51788241154, 97062.0, 97883.0, 98069.0, 84471.5776421114, 85041.57479212564, 85360.99999999876, 85714.0, 86130.56934715286, 9188.448693078437, 9298.488583127722, 9422.670206542738, 9432.386894851812, 9447.52762361893, 49595.0, 51493.48506514887, 51971.74014129905, 52506.062045345985, 53694.0, 67793.66103169453, 73066.0, 73680.63159684167, 75021.0, 76147.0, 11612.94193529027, 11790.72726549773, 12045.397730113635, 12726.755246640669, 13348.466061357436, 13283.535076272285, 13332.800007999695, 13431.597052088453, 13670.17978921268, 13689.24709140967, 12021.402265304412, 12311.384430778604, 12403.875961240272, 12897.548585799452, 12964.416601252778, 12594.559190428292, 12664.366781660696, 13078.803817942548, 13312.134711243738, 13423.731525369243, 12558.748825023631, 13005.544805931748, 13064.21614703121, 13469.0, 13482.595522134352, 10295.330803497749, 10690.25168238247, 10853.891461085288, 10948.781024379627, 11261.66215013551, 10627.521761520904, 10711.625093121704, 10764.46177691128, 10870.510827012646, 10899.727506812393], "value": 7433.03847545522, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.9999999999995, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 106.0, 112.0, 112.0, 113.0, 113.0, 112.0, 111.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 147.0, 167.0, 117.0, 149.0, 150.0, 122.0, 171.0, 120.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 160.0, 164.0, 165.0, 167.0, 167.0, 161.0, 160.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 86.0, 163.0, 75.0, 76.0, 75.0, 75.0, 171.0, 76.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 151.0, 84.0, 85.0, 85.0, 139.0, 84.0, 84.0, 159.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 149.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 56.0, 61.0, 56.0, 56.0, 54.0, 55.0, 53.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 61.0, 62.0, 61.0, 60.0, 64.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 76.0, 78.0, 74.0, 76.0, 75.0, 74.0, 79.0, 79.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 127.0, 124.0, 123.0, 120.0, 130.0, 136.0, 128.0, 162.0, 123.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 159.0, 167.0, 160.0, 167.0, 160.0, 160.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 66.0, 63.0, 64.0, 64.0, 63.0, 66.0], "value": 64.1, "unit": "score"}]}]} 19:24:55 INFO - Return code: 0 19:24:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:24:55 ERROR - # TBPL SUCCESS # 19:24:55 INFO - Running post-action listener: _resource_record_post_action 19:24:55 INFO - ##### 19:24:55 INFO - ##### Finished run-tests step (success) 19:24:55 INFO - ##### 19:24:55 INFO - Running post-run listener: _resource_record_post_run 19:24:55 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7811072; Write bytes: 479891456; Read time: 1328; Write time: 409552 19:24:55 INFO - TinderboxPrint: CPU usage
13.4% 19:24:55 INFO - TinderboxPrint: I/O read bytes / time
7,811,072 / 1,328 19:24:55 INFO - TinderboxPrint: I/O write bytes / time
479,891,456 / 409,552 19:24:55 INFO - TinderboxPrint: CPU idle
8,239.9 (86.6%) 19:24:55 INFO - TinderboxPrint: CPU user
1,214.7 (12.8%) 19:24:55 INFO - TinderboxPrint: Swap in / out
0 / 0 19:24:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 54353920; Read time: 0; Write time: 19752 19:24:55 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 5570560; Write bytes: 373276672; Read time: 1168; Write time: 342912 19:24:55 INFO - Running post-run listener: _upload_blobber_files 19:24:55 INFO - Blob upload gear active. 19:24:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:24:55 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 19:24:55 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'] 19:24:55 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 19:24:56 INFO - (blobuploader) - INFO - Open directory for files ... 19:24:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:24:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:24:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:57 INFO - (blobuploader) - INFO - Done attempting. 19:24:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:24:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:25:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:01 INFO - (blobuploader) - INFO - Done attempting. 19:25:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:25:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:25:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:02 INFO - (blobuploader) - INFO - Done attempting. 19:25:02 INFO - (blobuploader) - INFO - Iteration through files over. 19:25:02 INFO - Return code: 0 19:25:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:25:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:25:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a3caee0e41cdb0738918bdf4dafa1f4f4f6ed7fb9d23f3ad6573d30e6186ef724cecc0e46e9cb1e7cf2a2895b1e898d1c0d0ac4f76c3f91f003d08010793bc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/097acdc45043716f3b02af01119e4f27eeec460e988adacb8974d490a6a467ece9b5c63e05796bd14d34137d0b64a75b81c4c336719285dcdef0336e0553c787", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5582abdda30273a1cdebb82a5983eb491e7617e72d2e9b2ad7b82a71757557e88a743a3635bfb5f26600a1d316abfa3a1216c5a28c4b910726ec158a8d546c2e"} 19:25:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:25:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:25:02 INFO - Contents: 19:25:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a3caee0e41cdb0738918bdf4dafa1f4f4f6ed7fb9d23f3ad6573d30e6186ef724cecc0e46e9cb1e7cf2a2895b1e898d1c0d0ac4f76c3f91f003d08010793bc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/097acdc45043716f3b02af01119e4f27eeec460e988adacb8974d490a6a467ece9b5c63e05796bd14d34137d0b64a75b81c4c336719285dcdef0336e0553c787", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5582abdda30273a1cdebb82a5983eb491e7617e72d2e9b2ad7b82a71757557e88a743a3635bfb5f26600a1d316abfa3a1216c5a28c4b910726ec158a8d546c2e"} 19:25:02 INFO - Running post-run listener: copy_logs_to_upload_dir 19:25:02 INFO - Copying logs to upload dir... 19:25:02 INFO - mkdir: /builds/slave/test/build/upload/logs 19:25:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.598231 ========= master_lag: -0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-05 19:25:01.980674) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 19:25:01.984720) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594 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/1a3caee0e41cdb0738918bdf4dafa1f4f4f6ed7fb9d23f3ad6573d30e6186ef724cecc0e46e9cb1e7cf2a2895b1e898d1c0d0ac4f76c3f91f003d08010793bc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/097acdc45043716f3b02af01119e4f27eeec460e988adacb8974d490a6a467ece9b5c63e05796bd14d34137d0b64a75b81c4c336719285dcdef0336e0553c787", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5582abdda30273a1cdebb82a5983eb491e7617e72d2e9b2ad7b82a71757557e88a743a3635bfb5f26600a1d316abfa3a1216c5a28c4b910726ec158a8d546c2e"} build_url:https://queue.taskcluster.net/v1/task/IYco3xR4S3ew0u5cels8WQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010991 build_url: 'https://queue.taskcluster.net/v1/task/IYco3xR4S3ew0u5cels8WQ/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/1a3caee0e41cdb0738918bdf4dafa1f4f4f6ed7fb9d23f3ad6573d30e6186ef724cecc0e46e9cb1e7cf2a2895b1e898d1c0d0ac4f76c3f91f003d08010793bc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/097acdc45043716f3b02af01119e4f27eeec460e988adacb8974d490a6a467ece9b5c63e05796bd14d34137d0b64a75b81c4c336719285dcdef0336e0553c787", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5582abdda30273a1cdebb82a5983eb491e7617e72d2e9b2ad7b82a71757557e88a743a3635bfb5f26600a1d316abfa3a1216c5a28c4b910726ec158a8d546c2e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 19:25:02.011230) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:25:02.011588) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467770362.252072-1183674594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:25:02.094539) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 19:25:02.094904) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 19:25:02.095283) ========= ========= Total master_lag: 0.02 =========