builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1467733263.59 results: success (0) buildid: 20160705070425 builduid: 2fd3ad30233b4024ac7b02eb38056bd3 revision: dbb31bcad5a1f60a35b5600ea1578d9b9fa55237 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 08:41:03.588672) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 08:41:03.589133) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 08:41:03.589425) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 08:41:03.604237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:41:03.604623) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 08:41:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.5M=0s 2016-07-05 08:41:03 (70.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110022 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:41:03.729270) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:41:03.729590) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016608 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:41:03.779168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:41:03.779536) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dbb31bcad5a1f60a35b5600ea1578d9b9fa55237 --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 dbb31bcad5a1f60a35b5600ea1578d9b9fa55237 --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=8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 08:41:03,975 truncating revision to first 12 chars 2016-07-05 08:41:03,975 Setting DEBUG logging. 2016-07-05 08:41:03,975 attempt 1/10 2016-07-05 08:41:03,975 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dbb31bcad5a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 08:41:04,448 unpacking tar archive at: mozilla-central-dbb31bcad5a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.811014 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:41:04.604314) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 08:41:04.604640) ========= script_repo_revision: dbb31bcad5a1f60a35b5600ea1578d9b9fa55237 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 08:41:04.605038) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 08:41:04.605323) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 08:41:04.615915) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-05 08:41:04.616331) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:41:04 INFO - MultiFileLogger online at 20160705 08:41:04 in /builds/slave/test 08:41:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:41:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:41:04 INFO - {'append_to_log': False, 08:41:04 INFO - 'base_work_dir': '/builds/slave/test', 08:41:04 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:41:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:41:04 INFO - 'branch': 'Firefox-Non-PGO', 08:41:04 INFO - 'buildbot_json_path': 'buildprops.json', 08:41:04 INFO - 'config_files': ('talos/linux_config.py',), 08:41:04 INFO - 'default_actions': ('clobber', 08:41:04 INFO - 'read-buildbot-config', 08:41:04 INFO - 'download-and-extract', 08:41:04 INFO - 'populate-webroot', 08:41:04 INFO - 'create-virtualenv', 08:41:04 INFO - 'install', 08:41:04 INFO - 'run-tests'), 08:41:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:41:04 INFO - 'download_minidump_stackwalk': True, 08:41:04 INFO - 'download_symbols': 'ondemand', 08:41:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:41:04 INFO - 'tooltool.py': '/tools/tooltool.py', 08:41:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:41:04 INFO - '/tools/misc-python/virtualenv.py')}, 08:41:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:41:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:41:04 INFO - 'installer_path': 'installer.exe', 08:41:04 INFO - 'log_level': 'info', 08:41:04 INFO - 'log_name': 'talos', 08:41:04 INFO - 'log_to_console': True, 08:41:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:41:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:41:04 INFO - 'opt_config_files': (), 08:41:04 INFO - 'pip_index': False, 08:41:04 INFO - 'sps_profile': False, 08:41:04 INFO - 'sps_profile_interval': 0, 08:41:04 INFO - 'suite': 'dromaeojs-e10s', 08:41:04 INFO - 'system_bits': '32', 08:41:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:41:04 INFO - 'title': 'talos-linux64-ix-001', 08:41:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:41:04 INFO - 'use_talos_json': True, 08:41:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:41:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:41:04 INFO - 'work_dir': 'build'} 08:41:04 INFO - ##### 08:41:04 INFO - ##### Running clobber step. 08:41:04 INFO - ##### 08:41:04 INFO - Running pre-action listener: _resource_record_pre_action 08:41:04 INFO - Running main action method: clobber 08:41:04 INFO - rmtree: /builds/slave/test/build 08:41:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:41:05 INFO - Running post-action listener: _resource_record_post_action 08:41:05 INFO - ##### 08:41:05 INFO - ##### Finished clobber step (success) 08:41:05 INFO - ##### 08:41:05 INFO - ##### 08:41:05 INFO - ##### Running read-buildbot-config step. 08:41:05 INFO - ##### 08:41:05 INFO - Running pre-action listener: _resource_record_pre_action 08:41:05 INFO - Running main action method: read_buildbot_config 08:41:05 INFO - Using buildbot properties: 08:41:05 INFO - { 08:41:05 INFO - "project": "", 08:41:05 INFO - "product": "firefox", 08:41:05 INFO - "script_repo_revision": "production", 08:41:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:41:05 INFO - "repository": "", 08:41:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:41:05 INFO - "buildid": "20160705070425", 08:41:05 INFO - "pgo_build": "False", 08:41:05 INFO - "basedir": "/builds/slave/test", 08:41:05 INFO - "buildnumber": 97, 08:41:05 INFO - "slavename": "talos-linux64-ix-001", 08:41:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:41:05 INFO - "platform": "ubuntu64_hw", 08:41:05 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:41:05 INFO - "branch": "mozilla-central", 08:41:05 INFO - "repo_path": "mozilla-central", 08:41:05 INFO - "revision": "dbb31bcad5a1f60a35b5600ea1578d9b9fa55237", 08:41:05 INFO - "stage_platform": "linux64", 08:41:05 INFO - "builduid": "2fd3ad30233b4024ac7b02eb38056bd3", 08:41:05 INFO - "slavebuilddir": "test" 08:41:05 INFO - } 08:41:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:41:05 INFO - Running post-action listener: _resource_record_post_action 08:41:05 INFO - ##### 08:41:05 INFO - ##### Finished read-buildbot-config step (success) 08:41:05 INFO - ##### 08:41:05 INFO - ##### 08:41:05 INFO - ##### Running download-and-extract step. 08:41:05 INFO - ##### 08:41:05 INFO - Running pre-action listener: _resource_record_pre_action 08:41:05 INFO - Running main action method: download_and_extract 08:41:05 INFO - mkdir: /builds/slave/test/build/tests 08:41:05 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')]} 08:41:05 INFO - https://queue.taskcluster.net/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:41:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:41:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:41:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/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 08:41:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/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 08:41:06 INFO - Downloaded 1361 bytes. 08:41:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:41:06 INFO - Using the following test package requirements: 08:41:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:41:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:41:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:41:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:06 INFO - u'jsshell-linux-x86_64.zip'], 08:41:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:41:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:41:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:41:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:41:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:41:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:41:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:41:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:41:06 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')]} 08:41:06 INFO - https://queue.taskcluster.net/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:41:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:41:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:41:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/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 08:41:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/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 08:41:07 INFO - Downloaded 22729955 bytes. 08:41:07 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'] 08:41:07 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 08:41:08 INFO - Return code: 0 08:41:08 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 08:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:41:08 INFO - https://queue.taskcluster.net/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:41:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:41:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:41:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/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 08:41:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/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 08:41:10 INFO - Downloaded 22729955 bytes. 08:41:10 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'] 08:41:10 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 08:41:11 INFO - Return code: 0 08:41: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')]} 08:41:11 INFO - https://queue.taskcluster.net/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:41:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:41:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:41:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/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 08:41:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/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 08:41:12 INFO - Downloaded 14403333 bytes. 08:41:12 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'] 08:41:12 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 08:41:12 INFO - Return code: 0 08:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:12 INFO - https://queue.taskcluster.net/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:41:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:41:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:41:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/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 08:41:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0jN7oznRfCHtV_2u3-18g/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 08:41:14 INFO - Downloaded 56499521 bytes. 08:41:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:41:14 INFO - mkdir: /builds/slave/test/properties 08:41:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:41:14 INFO - Writing to file /builds/slave/test/properties/build_url 08:41:14 INFO - Contents: 08:41:14 INFO - build_url:https://queue.taskcluster.net/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:41:14 INFO - Running post-action listener: _resource_record_post_action 08:41:14 INFO - Running post-action listener: set_extra_try_arguments 08:41:14 INFO - ##### 08:41:14 INFO - ##### Finished download-and-extract step (success) 08:41:14 INFO - ##### 08:41:14 INFO - ##### 08:41:14 INFO - ##### Running populate-webroot step. 08:41:14 INFO - ##### 08:41:14 INFO - Running pre-action listener: _resource_record_pre_action 08:41:14 INFO - Running main action method: populate_webroot 08:41:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:41:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:41:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:41:14 INFO - '--tppagecycles', 08:41:14 INFO - '7'], 08:41:14 INFO - 'tests': ['tsvgm']}}, 08:41:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:41:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:41:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:41:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:41:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:41:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:41:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:14 INFO - 'talos_options': ['--disable-e10s'], 08:41:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:14 INFO - 'talos_options': ['--disable-e10s'], 08:41:14 INFO - 'tests': ['damp', 'tps']}, 08:41:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:14 INFO - 'tests': ['damp', 'tps']}, 08:41:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:41:14 INFO - 'tests': ['dromaeo_dom']}, 08:41:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:41:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:41:14 INFO - 'tests': ['basic_compositor_video']}, 08:41:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:41:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:41:14 INFO - 'tests': ['a11yr', 08:41:14 INFO - 'ts_paint', 08:41:14 INFO - 'tpaint', 08:41:14 INFO - 'sessionrestore', 08:41:14 INFO - 'sessionrestore_no_auto_restore', 08:41:14 INFO - 'tabpaint']}, 08:41:14 INFO - 'other-e10s': {'tests': ['a11yr', 08:41:14 INFO - 'ts_paint', 08:41:14 INFO - 'tpaint', 08:41:14 INFO - 'sessionrestore', 08:41:14 INFO - 'sessionrestore_no_auto_restore', 08:41:14 INFO - 'tabpaint']}, 08:41:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:41:14 INFO - 'ts_paint', 08:41:14 INFO - 'tpaint', 08:41:14 INFO - 'sessionrestore', 08:41:14 INFO - 'sessionrestore_no_auto_restore', 08:41:14 INFO - 'tabpaint']}, 08:41:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:41:14 INFO - 'ts_paint', 08:41:14 INFO - 'tpaint', 08:41:14 INFO - 'sessionrestore', 08:41:14 INFO - 'sessionrestore_no_auto_restore', 08:41:14 INFO - 'tabpaint']}, 08:41:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:41:14 INFO - 'tests': ['a11yr', 08:41:14 INFO - 'ts_paint', 08:41:14 INFO - 'tpaint', 08:41:14 INFO - 'sessionrestore', 08:41:14 INFO - 'sessionrestore_no_auto_restore', 08:41:14 INFO - 'tabpaint']}, 08:41:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:41:14 INFO - 'tests': ['a11yr', 08:41:14 INFO - 'ts_paint', 08:41:14 INFO - 'tpaint', 08:41:14 INFO - 'sessionrestore', 08:41:14 INFO - 'sessionrestore_no_auto_restore', 08:41:14 INFO - 'tabpaint']}, 08:41:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:41:14 INFO - 'tests': ['tsvgx', 08:41:14 INFO - 'tsvgr_opacity', 08:41:14 INFO - 'tart', 08:41:14 INFO - 'tscrollx', 08:41:14 INFO - 'cart']}, 08:41:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:41:14 INFO - 'tsvgr_opacity', 08:41:14 INFO - 'tart', 08:41:14 INFO - 'tscrollx', 08:41:14 INFO - 'cart']}, 08:41:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:14 INFO - 'talos_options': ['--disable-e10s'], 08:41:14 INFO - 'tests': ['tp5o']}, 08:41:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:14 INFO - 'tests': ['tp5o']}, 08:41:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:14 INFO - 'talos_options': ['--disable-e10s', 08:41:14 INFO - '--xperf_path', 08:41:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:14 INFO - 'tests': ['tp5n']}, 08:41:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:14 INFO - 'talos_options': ['--xperf_path', 08:41:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:14 INFO - 'tests': ['tp5n']}}, 08:41:14 INFO - 'talos.zip': {'path': '', 08:41:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:41:14 INFO - Running post-action listener: _resource_record_post_action 08:41:14 INFO - ##### 08:41:14 INFO - ##### Finished populate-webroot step (success) 08:41:14 INFO - ##### 08:41:14 INFO - ##### 08:41:14 INFO - ##### Running create-virtualenv step. 08:41:14 INFO - ##### 08:41:14 INFO - Running pre-action listener: _resource_record_pre_action 08:41:14 INFO - Running main action method: create_virtualenv 08:41:14 INFO - Creating virtualenv /builds/slave/test/build/venv 08:41:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:41:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:41:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:41:14 INFO - Using real prefix '/usr' 08:41:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:41:15 INFO - Installing distribute.............................................................................................................................................................................................done. 08:41:17 INFO - Installing pip.................done. 08:41:17 INFO - Return code: 0 08:41:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', '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 08:41:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:41:17 INFO - Using env: {'DISPLAY': ':0', 08:41:17 INFO - 'HOME': '/home/cltbld', 08:41:17 INFO - 'LANG': 'en_US.UTF-8', 08:41:17 INFO - 'LANGUAGE': 'en_US:en', 08:41:17 INFO - 'LOGNAME': 'cltbld', 08:41:17 INFO - 'MAIL': '/var/mail/cltbld', 08:41:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:17 INFO - 'MOZ_NO_REMOTE': '1', 08:41:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:17 INFO - 'NO_EM_RESTART': '1', 08:41:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:17 INFO - 'PWD': '/builds/slave/test', 08:41:17 INFO - 'SHELL': '/bin/bash', 08:41:17 INFO - 'SHLVL': '1', 08:41:17 INFO - 'TERM': 'linux', 08:41:17 INFO - 'TMOUT': '86400', 08:41:17 INFO - 'USER': 'cltbld', 08:41:17 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', 08:41:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:17 INFO - '_': '/tools/buildbot/bin/python'} 08:41:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:41:17 INFO - Cleaning up... 08:41:17 INFO - Return code: 0 08:41:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', '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 08:41:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:41:17 INFO - Using env: {'DISPLAY': ':0', 08:41:17 INFO - 'HOME': '/home/cltbld', 08:41:17 INFO - 'LANG': 'en_US.UTF-8', 08:41:17 INFO - 'LANGUAGE': 'en_US:en', 08:41:17 INFO - 'LOGNAME': 'cltbld', 08:41:17 INFO - 'MAIL': '/var/mail/cltbld', 08:41:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:17 INFO - 'MOZ_NO_REMOTE': '1', 08:41:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:17 INFO - 'NO_EM_RESTART': '1', 08:41:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:17 INFO - 'PWD': '/builds/slave/test', 08:41:17 INFO - 'SHELL': '/bin/bash', 08:41:17 INFO - 'SHLVL': '1', 08:41:17 INFO - 'TERM': 'linux', 08:41:17 INFO - 'TMOUT': '86400', 08:41:17 INFO - 'USER': 'cltbld', 08:41:17 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', 08:41:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:17 INFO - '_': '/tools/buildbot/bin/python'} 08:41:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:17 INFO - Downloading/unpacking psutil>=3.1.1 08:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:41:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:19 INFO - Installing collected packages: psutil 08:41:19 INFO - Running setup.py install for psutil 08:41:19 INFO - building 'psutil._psutil_linux' extension 08:41:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:41:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:41:20 INFO - building 'psutil._psutil_posix' extension 08:41:20 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 08:41:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:41:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:20 INFO - Successfully installed psutil 08:41:20 INFO - Cleaning up... 08:41:20 INFO - Return code: 0 08:41:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', '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 08:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:41:20 INFO - Using env: {'DISPLAY': ':0', 08:41:20 INFO - 'HOME': '/home/cltbld', 08:41:20 INFO - 'LANG': 'en_US.UTF-8', 08:41:20 INFO - 'LANGUAGE': 'en_US:en', 08:41:20 INFO - 'LOGNAME': 'cltbld', 08:41:20 INFO - 'MAIL': '/var/mail/cltbld', 08:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:20 INFO - 'MOZ_NO_REMOTE': '1', 08:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:20 INFO - 'NO_EM_RESTART': '1', 08:41:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:20 INFO - 'PWD': '/builds/slave/test', 08:41:20 INFO - 'SHELL': '/bin/bash', 08:41:20 INFO - 'SHLVL': '1', 08:41:20 INFO - 'TERM': 'linux', 08:41:20 INFO - 'TMOUT': '86400', 08:41:20 INFO - 'USER': 'cltbld', 08:41:20 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', 08:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:20 INFO - '_': '/tools/buildbot/bin/python'} 08:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:41:22 INFO - Installing collected packages: mozsystemmonitor 08:41:22 INFO - Running setup.py install for mozsystemmonitor 08:41:22 INFO - Successfully installed mozsystemmonitor 08:41:22 INFO - Cleaning up... 08:41:22 INFO - Return code: 0 08:41:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', '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 08:41:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:41:22 INFO - Using env: {'DISPLAY': ':0', 08:41:22 INFO - 'HOME': '/home/cltbld', 08:41:22 INFO - 'LANG': 'en_US.UTF-8', 08:41:22 INFO - 'LANGUAGE': 'en_US:en', 08:41:22 INFO - 'LOGNAME': 'cltbld', 08:41:22 INFO - 'MAIL': '/var/mail/cltbld', 08:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:22 INFO - 'MOZ_NO_REMOTE': '1', 08:41:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:22 INFO - 'NO_EM_RESTART': '1', 08:41:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:22 INFO - 'PWD': '/builds/slave/test', 08:41:22 INFO - 'SHELL': '/bin/bash', 08:41:22 INFO - 'SHLVL': '1', 08:41:22 INFO - 'TERM': 'linux', 08:41:22 INFO - 'TMOUT': '86400', 08:41:22 INFO - 'USER': 'cltbld', 08:41:22 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', 08:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:22 INFO - '_': '/tools/buildbot/bin/python'} 08:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:22 INFO - Downloading/unpacking jsonschema==2.5.1 08:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:41:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:25 INFO - Downloading functools32-3.2.3-2.tar.gz 08:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:41:25 INFO - warning: no files found matching '*.txt' 08:41:25 INFO - no previously-included directories found matching 'build' 08:41:25 INFO - no previously-included directories found matching 'dist' 08:41:25 INFO - no previously-included directories found matching '.git*' 08:41:25 INFO - Installing collected packages: jsonschema, functools32 08:41:25 INFO - Running setup.py install for functools32 08:41:25 INFO - warning: no files found matching '*.txt' 08:41:25 INFO - no previously-included directories found matching 'build' 08:41:25 INFO - no previously-included directories found matching 'dist' 08:41:25 INFO - no previously-included directories found matching '.git*' 08:41:25 INFO - Successfully installed jsonschema functools32 08:41:25 INFO - Cleaning up... 08:41:25 INFO - Return code: 0 08:41:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', '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 08:41:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:41:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:41:25 INFO - Using env: {'DISPLAY': ':0', 08:41:25 INFO - 'HOME': '/home/cltbld', 08:41:25 INFO - 'LANG': 'en_US.UTF-8', 08:41:25 INFO - 'LANGUAGE': 'en_US:en', 08:41:25 INFO - 'LOGNAME': 'cltbld', 08:41:25 INFO - 'MAIL': '/var/mail/cltbld', 08:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:25 INFO - 'MOZ_NO_REMOTE': '1', 08:41:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:25 INFO - 'NO_EM_RESTART': '1', 08:41:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:25 INFO - 'PWD': '/builds/slave/test', 08:41:25 INFO - 'SHELL': '/bin/bash', 08:41:25 INFO - 'SHLVL': '1', 08:41:25 INFO - 'TERM': 'linux', 08:41:25 INFO - 'TMOUT': '86400', 08:41:25 INFO - 'USER': 'cltbld', 08:41:25 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', 08:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:25 INFO - '_': '/tools/buildbot/bin/python'} 08:41:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:25 INFO - Downloading/unpacking blobuploader==1.2.4 08:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:27 INFO - Downloading blobuploader-1.2.4.tar.gz 08:41:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:41:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:41:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:28 INFO - Downloading docopt-0.6.1.tar.gz 08:41:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:28 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:28 INFO - Running setup.py install for blobuploader 08:41:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:28 INFO - Running setup.py install for requests 08:41:28 INFO - Running setup.py install for docopt 08:41:28 INFO - Successfully installed blobuploader requests docopt 08:41:28 INFO - Cleaning up... 08:41:28 INFO - Return code: 0 08:41:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', '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 08:41:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:28 INFO - Using env: {'DISPLAY': ':0', 08:41:28 INFO - 'HOME': '/home/cltbld', 08:41:28 INFO - 'LANG': 'en_US.UTF-8', 08:41:28 INFO - 'LANGUAGE': 'en_US:en', 08:41:28 INFO - 'LOGNAME': 'cltbld', 08:41:28 INFO - 'MAIL': '/var/mail/cltbld', 08:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:28 INFO - 'MOZ_NO_REMOTE': '1', 08:41:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:28 INFO - 'NO_EM_RESTART': '1', 08:41:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:28 INFO - 'PWD': '/builds/slave/test', 08:41:28 INFO - 'SHELL': '/bin/bash', 08:41:28 INFO - 'SHLVL': '1', 08:41:28 INFO - 'TERM': 'linux', 08:41:28 INFO - 'TMOUT': '86400', 08:41:28 INFO - 'USER': 'cltbld', 08:41:28 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', 08:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:28 INFO - '_': '/tools/buildbot/bin/python'} 08:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:29 INFO - Running setup.py (path:/tmp/pip-FuFsPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:29 INFO - Running setup.py (path:/tmp/pip-2DXjML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:29 INFO - Running setup.py (path:/tmp/pip-a4A0AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:29 INFO - Running setup.py (path:/tmp/pip-gl0bML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:29 INFO - Running setup.py (path:/tmp/pip-BQX08_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:29 INFO - Running setup.py (path:/tmp/pip-k4kDOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:29 INFO - Running setup.py (path:/tmp/pip-UMOasX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:29 INFO - Running setup.py (path:/tmp/pip-J5xKO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:29 INFO - Running setup.py (path:/tmp/pip-1QM5p2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:29 INFO - Running setup.py (path:/tmp/pip-QyPL7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:29 INFO - Running setup.py (path:/tmp/pip-cX9ju8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:29 INFO - Running setup.py (path:/tmp/pip-JmPftE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:29 INFO - Running setup.py (path:/tmp/pip-i5JAu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:29 INFO - Running setup.py (path:/tmp/pip-4M4H9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:30 INFO - Running setup.py (path:/tmp/pip-vtKLY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:30 INFO - Running setup.py (path:/tmp/pip-WmGC2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:30 INFO - Running setup.py (path:/tmp/pip-CsxihQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:30 INFO - Running setup.py install for manifestparser 08:41:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:30 INFO - Running setup.py install for mozcrash 08:41:30 INFO - Running setup.py install for mozdebug 08:41:30 INFO - Running setup.py install for mozdevice 08:41:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:41:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:30 INFO - Running setup.py install for mozfile 08:41:30 INFO - Running setup.py install for mozhttpd 08:41:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:30 INFO - Running setup.py install for mozinfo 08:41:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:30 INFO - Running setup.py install for mozInstall 08:41:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:31 INFO - Running setup.py install for mozleak 08:41:31 INFO - Running setup.py install for mozlog 08:41:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:31 INFO - Running setup.py install for moznetwork 08:41:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:31 INFO - Running setup.py install for mozprocess 08:41:31 INFO - Running setup.py install for mozprofile 08:41:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:41:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:41:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:41:31 INFO - Running setup.py install for mozrunner 08:41:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:41:31 INFO - Running setup.py install for mozscreenshot 08:41:31 INFO - Running setup.py install for moztest 08:41:31 INFO - Running setup.py install for mozversion 08:41:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:41:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:32 INFO - Cleaning up... 08:41:32 INFO - Return code: 0 08:41:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', '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 08:41:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:32 INFO - Using env: {'DISPLAY': ':0', 08:41:32 INFO - 'HOME': '/home/cltbld', 08:41:32 INFO - 'LANG': 'en_US.UTF-8', 08:41:32 INFO - 'LANGUAGE': 'en_US:en', 08:41:32 INFO - 'LOGNAME': 'cltbld', 08:41:32 INFO - 'MAIL': '/var/mail/cltbld', 08:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:32 INFO - 'MOZ_NO_REMOTE': '1', 08:41:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:32 INFO - 'NO_EM_RESTART': '1', 08:41:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:32 INFO - 'PWD': '/builds/slave/test', 08:41:32 INFO - 'SHELL': '/bin/bash', 08:41:32 INFO - 'SHLVL': '1', 08:41:32 INFO - 'TERM': 'linux', 08:41:32 INFO - 'TMOUT': '86400', 08:41:32 INFO - 'USER': 'cltbld', 08:41:32 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', 08:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:32 INFO - '_': '/tools/buildbot/bin/python'} 08:41:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:32 INFO - Running setup.py (path:/tmp/pip-V4u4UC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:32 INFO - Running setup.py (path:/tmp/pip-W9UmYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:32 INFO - Running setup.py (path:/tmp/pip-glPz08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:32 INFO - Running setup.py (path:/tmp/pip-tpSog0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:32 INFO - Running setup.py (path:/tmp/pip-BjyFBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:32 INFO - Running setup.py (path:/tmp/pip-g9vKxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:32 INFO - Running setup.py (path:/tmp/pip-D8ivzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:32 INFO - Running setup.py (path:/tmp/pip-2qVxQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:32 INFO - Running setup.py (path:/tmp/pip-PhXQ80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:32 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)) 08:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:32 INFO - Running setup.py (path:/tmp/pip-cI399j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:32 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)) 08:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:32 INFO - Running setup.py (path:/tmp/pip-Rgu5Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:33 INFO - Running setup.py (path:/tmp/pip-2ukbYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:33 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)) 08:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:33 INFO - Running setup.py (path:/tmp/pip-g9LZ76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:33 INFO - Running setup.py (path:/tmp/pip-JVqGfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:33 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)) 08:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:33 INFO - Running setup.py (path:/tmp/pip-CnMYwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:33 INFO - Running setup.py (path:/tmp/pip-i81beL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:33 INFO - Running setup.py (path:/tmp/pip-4cuAdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:35 INFO - Downloading blessings-1.6.tar.gz 08:41:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:35 INFO - Installing collected packages: blessings 08:41:35 INFO - Running setup.py install for blessings 08:41:35 INFO - Successfully installed blessings 08:41:35 INFO - Cleaning up... 08:41:35 INFO - Return code: 0 08:41:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:41:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:35 INFO - Reading from file tmpfile_stdout 08:41:35 INFO - Current package versions: 08:41:35 INFO - argparse == 1.2.1 08:41:35 INFO - blessings == 1.6 08:41:35 INFO - blobuploader == 1.2.4 08:41:35 INFO - docopt == 0.6.1 08:41:35 INFO - functools32 == 3.2.3-2 08:41:35 INFO - jsonschema == 2.5.1 08:41:35 INFO - manifestparser == 1.1 08:41:35 INFO - mozInstall == 1.12 08:41:35 INFO - mozcrash == 0.17 08:41:35 INFO - mozdebug == 0.1 08:41:35 INFO - mozdevice == 0.48 08:41:35 INFO - mozfile == 1.2 08:41:35 INFO - mozhttpd == 0.7 08:41:35 INFO - mozinfo == 0.9 08:41:35 INFO - mozleak == 0.1 08:41:35 INFO - mozlog == 3.2 08:41:35 INFO - moznetwork == 0.27 08:41:35 INFO - mozprocess == 0.22 08:41:35 INFO - mozprofile == 0.28 08:41:35 INFO - mozrunner == 6.11 08:41:35 INFO - mozscreenshot == 0.1 08:41:35 INFO - mozsystemmonitor == 0.3 08:41:35 INFO - moztest == 0.7 08:41:35 INFO - mozversion == 1.4 08:41:35 INFO - psutil == 3.1.1 08:41:35 INFO - requests == 1.2.3 08:41:35 INFO - wsgiref == 0.1.2 08:41:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', '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 08:41:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:35 INFO - Using env: {'DISPLAY': ':0', 08:41:35 INFO - 'HOME': '/home/cltbld', 08:41:35 INFO - 'LANG': 'en_US.UTF-8', 08:41:35 INFO - 'LANGUAGE': 'en_US:en', 08:41:35 INFO - 'LOGNAME': 'cltbld', 08:41:35 INFO - 'MAIL': '/var/mail/cltbld', 08:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:35 INFO - 'MOZ_NO_REMOTE': '1', 08:41:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:35 INFO - 'NO_EM_RESTART': '1', 08:41:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:35 INFO - 'PWD': '/builds/slave/test', 08:41:35 INFO - 'SHELL': '/bin/bash', 08:41:35 INFO - 'SHLVL': '1', 08:41:35 INFO - 'TERM': 'linux', 08:41:35 INFO - 'TMOUT': '86400', 08:41:35 INFO - 'USER': 'cltbld', 08:41:35 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', 08:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:35 INFO - '_': '/tools/buildbot/bin/python'} 08:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:36 INFO - Cleaning up... 08:41:36 INFO - Return code: 0 08:41:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', '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 08:41:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:41:36 INFO - Using env: {'DISPLAY': ':0', 08:41:36 INFO - 'HOME': '/home/cltbld', 08:41:36 INFO - 'LANG': 'en_US.UTF-8', 08:41:36 INFO - 'LANGUAGE': 'en_US:en', 08:41:36 INFO - 'LOGNAME': 'cltbld', 08:41:36 INFO - 'MAIL': '/var/mail/cltbld', 08:41:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:36 INFO - 'MOZ_NO_REMOTE': '1', 08:41:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:36 INFO - 'NO_EM_RESTART': '1', 08:41:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:36 INFO - 'PWD': '/builds/slave/test', 08:41:36 INFO - 'SHELL': '/bin/bash', 08:41:36 INFO - 'SHLVL': '1', 08:41:36 INFO - 'TERM': 'linux', 08:41:36 INFO - 'TMOUT': '86400', 08:41:36 INFO - 'USER': 'cltbld', 08:41:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', 08:41:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:36 INFO - '_': '/tools/buildbot/bin/python'} 08:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:41:36 INFO - Cleaning up... 08:41:36 INFO - Return code: 0 08:41:36 INFO - Running post-action listener: _resource_record_post_action 08:41:36 INFO - Running post-action listener: _start_resource_monitoring 08:41:36 INFO - Starting resource monitoring. 08:41:36 INFO - ##### 08:41:36 INFO - ##### Finished create-virtualenv step (success) 08:41:36 INFO - ##### 08:41:36 INFO - ##### 08:41:36 INFO - ##### Running install step. 08:41:36 INFO - ##### 08:41:36 INFO - Running pre-action listener: _resource_record_pre_action 08:41:36 INFO - Running main action method: install 08:41:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:36 INFO - Reading from file tmpfile_stdout 08:41:36 INFO - Detecting whether we're running mozinstall >=1.0... 08:41:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:41:36 INFO - Reading from file tmpfile_stdout 08:41:36 INFO - Output received: 08:41:36 INFO - Usage: mozinstall [options] installer 08:41:36 INFO - Options: 08:41:36 INFO - -h, --help show this help message and exit 08:41:36 INFO - -d DEST, --destination=DEST 08:41:36 INFO - Directory to install application into. [default: 08:41:36 INFO - "/builds/slave/test"] 08:41:36 INFO - --app=APP Application being installed. [default: firefox] 08:41:36 INFO - mkdir: /builds/slave/test/build/application 08:41:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:41:52 INFO - Reading from file tmpfile_stdout 08:41:52 INFO - Output received: 08:41:52 INFO - /builds/slave/test/build/application/firefox/firefox 08:41:52 INFO - Running post-action listener: _resource_record_post_action 08:41:52 INFO - ##### 08:41:52 INFO - ##### Finished install step (success) 08:41:52 INFO - ##### 08:41:52 INFO - ##### 08:41:52 INFO - ##### Running run-tests step. 08:41:52 INFO - ##### 08:41:52 INFO - Running pre-action listener: _resource_record_pre_action 08:41:52 INFO - Running main action method: run_tests 08:41:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:52 INFO - Python 2.7.3 08:41:52 INFO - Return code: 0 08:41:52 INFO - grabbing minidump binary from tooltool 08:41:52 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')]} 08:41:52 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 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:52 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 08:41:52 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 08:41:52 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 08:41:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:52 INFO - Return code: 0 08:41:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:41:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:41:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 08:41:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 08:41:53 INFO - Using env: {'DISPLAY': ':0', 08:41:53 INFO - 'HOME': '/home/cltbld', 08:41:53 INFO - 'LANG': 'en_US.UTF-8', 08:41:53 INFO - 'LANGUAGE': 'en_US:en', 08:41:53 INFO - 'LOGNAME': 'cltbld', 08:41:53 INFO - 'MAIL': '/var/mail/cltbld', 08:41:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:53 INFO - 'MOZ_NO_REMOTE': '1', 08:41:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:53 INFO - 'NO_EM_RESTART': '1', 08:41:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:53 INFO - 'PWD': '/builds/slave/test', 08:41:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:53 INFO - 'SHELL': '/bin/bash', 08:41:53 INFO - 'SHLVL': '1', 08:41:53 INFO - 'TERM': 'linux', 08:41:53 INFO - 'TMOUT': '86400', 08:41:53 INFO - 'USER': 'cltbld', 08:41:53 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438', 08:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:53 INFO - '_': '/tools/buildbot/bin/python'} 08:41:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 08:41:53 INFO - mozversion application_buildid: 20160705070425 08:41:53 INFO - mozversion application_changeset: dbb31bcad5a1f60a35b5600ea1578d9b9fa55237 08:41:53 INFO - mozversion application_display_name: Nightly 08:41:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:53 INFO - mozversion application_name: Firefox 08:41:53 INFO - mozversion application_remotingname: firefox 08:41:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:41:53 INFO - mozversion application_vendor: Mozilla 08:41:53 INFO - mozversion application_version: 50.0a1 08:41:53 INFO - mozversion platform_buildid: 20160705070425 08:41:53 INFO - mozversion platform_changeset: dbb31bcad5a1f60a35b5600ea1578d9b9fa55237 08:41:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:41:53 INFO - mozversion platform_version: 50.0a1 08:41:53 INFO - using testdate: 1467733313 08:41:53 INFO - actual date: 1467733313 08:41:53 INFO - starting webserver on 'localhost:36253' 08:41:53 INFO - SUITE-START | Running 2 tests 08:41:53 INFO - TEST-START | dromaeo_css 08:41:53 INFO - operating with platform_type : linux_ 08:41:53 INFO - Initialising browser for dromaeo_css test... 08:41:53 INFO - TEST-INFO | started process 15595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpza_TiL/profile http://localhost:36253/getInfo.html) 08:41:58 INFO - PROCESS | 15595 | __metrics Screen width/height:1600/1200 08:41:58 INFO - PROCESS | 15595 | colorDepth:24 08:41:58 INFO - PROCESS | 15595 | Browser inner width/height: 1024/697 08:41:58 INFO - PROCESS | 15595 | __metrics 08:41:58 ERROR - PROCESS | 15595 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:41:59 INFO - TEST-INFO | 15595: exit 0 08:41:59 INFO - Browser initialized. 08:41:59 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:59 INFO - TEST-INFO | started process 15712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpza_TiL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:11 INFO - PROCESS | 15712 | RSS: Main: 169992192 08:42:11 INFO - PROCESS | 15712 | 08:43:01 INFO - PROCESS | 15712 | 1467733381397 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] 08:45:13 INFO - PROCESS | 15712 | Cycle 1(1): loaded http://localhost:36253/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36253/tests/dromaeo/cssquery-ext.html) 08:45:14 INFO - PROCESS | 15712 | RSS: Main: 172580864 08:45:14 INFO - PROCESS | 15712 | 08:48:17 INFO - PROCESS | 15712 | Cycle 1(1): loaded http://localhost:36253/tests/dromaeo/cssquery-ext.html (next: http://localhost:36253/tests/dromaeo/cssquery-jquery.html) 08:48:17 INFO - PROCESS | 15712 | RSS: Main: 169299968 08:48:17 INFO - PROCESS | 15712 | 08:51:19 INFO - PROCESS | 15712 | Cycle 1(1): loaded http://localhost:36253/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36253/tests/dromaeo/cssquery-mootools.html) 08:51:20 INFO - PROCESS | 15712 | RSS: Main: 172228608 08:51:20 INFO - PROCESS | 15712 | 08:54:22 INFO - PROCESS | 15712 | Cycle 1(1): loaded http://localhost:36253/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36253/tests/dromaeo/cssquery-prototype.html) 08:54:22 INFO - PROCESS | 15712 | RSS: Main: 167677952 08:54:22 INFO - PROCESS | 15712 | 08:57:25 INFO - PROCESS | 15712 | Cycle 1(1): loaded http://localhost:36253/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36253/tests/dromaeo/cssquery-yui.html) 08:57:26 INFO - PROCESS | 15712 | RSS: Main: 170065920 08:57:26 INFO - PROCESS | 15712 | 09:00:28 INFO - PROCESS | 15712 | Cycle 1(1): loaded http://localhost:36253/tests/dromaeo/cssquery-yui.html (next: http://localhost:36253/tests/dromaeo/cssquery-dojo.html) 09:00:29 INFO - PROCESS | 15712 | RSS: Main: 171122688 09:00:29 INFO - PROCESS | 15712 | 09:00:29 INFO - PROCESS | 15712 | __start_tp_report 09:00:29 INFO - PROCESS | 15712 | _x_x_mozilla_page_load 09:00:29 INFO - PROCESS | 15712 | _x_x_mozilla_page_load_details 09:00:29 INFO - PROCESS | 15712 | |i|pagename|runs| 09:00:29 INFO - PROCESS | 15712 | |0;dojo.html;2604.348912771807;2659.6276521287023;2664.72020437854;2679.236417620977;2682.14171465131;4695.765211739412;4721.150192965265;4743.928841067383;4830.686005409655;4872.585830204437;4634.374359461472;4706.247000479924;4718.056388722252;4743.501932297111;4750.691205071668;4302.462192225972;4377.47470303564;4438.156750217465;4456.264716321819;4462.263726485126;616.4975143702181;4269.423627810253;4306.892327691801;4386.298192289234;4388.934165987513;4377.47470303564;4416.712913660602;4447.466304043503;4485.842995495174;4494.73031618104;4441.089576636782;4448.666350023729;4450.4881938577155;4463.642908567307;4495.887602809923;4303.397524346594;4347.673924455678;4371.846985355497;4375.168717943612;4385.364122202294;4687.789049492781;4717.796961774726;4752.928706069411;4754.405699287589;4804.039192161546;5057.595392368638;5072.822451214227;5089.6691715038405;5099.107656160157;5151.768170432302;5002.299678045077;5057.039162559102;5098.413682426494;5121.078205922932;5133.383993920716;4767.417490843361;4769.594584460325;4771.976140119277;4775.976120119377;4818.204996175662;5104.795808167706;5186.066508028515;5243.764030618631;5244.9737751310995;5304.761285742151;4944.134776414113;4948.960718249136;4962.007598480318;4968.677035992721;4999.600031997432;5037.29477873098;5071.2139618359215;5102.08162530748;5105.2342148678;5156.690598564098;5011.373578302712;5026.170681837529;5031.547160755476;5050.242463630485;5064.822731204464;5031.069252188357;5043.899122017539;5046.44489106198;5054.620903432184;5098;4197.4753155855515;4231.915361692811;4236.449261596034;4271.188474189956;4272.764997925082;3663.084228942764;3679.7792132472136;3703.777773333609;3707.647773461517;3737.7757334560015;4299.161663475655;4324.048709283952;4329.567043295709;4383.408239887638;4410.823567057346;5073.061483625467;5100.464451232641;5107.61692873036;5108.821191258288;5117.181250999822;4325.697201195949;4347.260965635849;4381.233284175257;4383.320585309282;4383.62739167168;4463.308187230984;4480.148771733426;4484.686071974996;4513.187626227245;4559.703619264737;4728.550787675165;4767.785449654843;4784.856454306377;4793.257045158006;4811.27830825372;5104.106781313181;5163.845084647466;5173.870653233699;5177.145770947752;5228.816991405282;4811.975940120277;4858.5384388483035;4875.219964805614;4893.070316639827;4918.95081049185;4853.102176097434;4930.901381972269;4967.254911763264;5041.873953151054;5111.667741596784;5061.898762024813;5089;5089.414717307557;5121.385433747974;5123.436421993503;4968.925466118083;4992.126377883928;4995.8001679932395;5003.674761140514;5006.5994720423005;4865.294532292868;4903.60771138301;4934.851954441372;4944.604431645388;4963;4881.243407271879;4883.614332974622;4908.386451693538;4921.089598424303;4943.925841112315;5007.324011258579;5036.697798132123;5042.117629414764;5043.84868453947;5094.5160209780015;4781.545753153445;4881.438634557071;4909.656324057281;4940.2342636891335;4979.502049794992 09:00:29 INFO - PROCESS | 15712 | |1;ext.html;570.4837122404224;577.6851615869351;577.6938222741945;588.961717488363;632.7532262417656;35839.64160358399;39602.40596391049;39608.405873911914;39609.20781584366;39910.40134397983;39299.21401571974;39551.40672889902;39582.8020859896;39649.801750991275;39770.204595908064;7664.118626357957;7774.339181169607;7831.2560306770765;7837.647305871221;7857.8035549111155;7827.491213071161;7883.960580197091;7925.524468531907;7949.841003179933;7970.163132871023;7932.524048557105;7953.562554059525;7970.840583188333;7985.840283194332;8011.118776934532;7849.68601255949;7903;7949.0858551266765;7965.64154613038;7968.641411136513;7873.291403773688;7887.487313324616;7901.920980790176;7922.841543169105;7924.960375198145;37634.62365376366;37705;37853.62146378528;37893.62106378929;37925.62074379248;2905.956410653842;2931.736143747073;3041.574179614856;3064.6628870824193;3207.5349074384085;29681.70318296811;29695;30027.549586756217;30311.848440757876;31213.375732485223;3372.5109859070544;3430.9313813723834;3442.913927151816;3460.463628137643;3464.3937310970477;253948;254051;254646;257354;258528.9999999981;31267.68732312693;32457.188570285933;51850.48149518532;52394;52479.212811807854;33653.495197572054;33756.49365259523;33819;33870.49194262088;33900.49149262763;12368.628941131781;12500.062495312888;12537.498500059895;12578.433970471351;12621;10180.949095254624;10182.23633227511;10250.897491025144;10285.382877027403;10296.536655850505;7850.8429831403055;7854.450188486751;7891.526508409399;7935.603219838985;7977.60111994398;3053.450378931769;3055.5569442430724;3069.048594935577;3094.798838075518;3117.6258848938273;893.1470445724318;898.4654130792168;956.8803899512561;957.066859811692;970.1753509516855;27942.86028569844;28726.569101463494;29113.85443072771;29158.09864401703;29447;884.8672699095188;938.1462868789505;951.8762560867043;958.520739630185;959.7600599850037;14666.120032798066;14778.852211477963;14948.626284342978;15117.622059448382;15263.542093737206;398437;402254;404121;404830;405412;50633.746831265606;50704;50785.42931136215;50927;51077;1192.0940085535055;1195.1872726545857;1202.3507306054807;1206.70702287569;1246.7506498700295;25165.87417062903;27707.307317317227;27727.722722772512;27827.16518504448;28093;42735.3589696161;43075.35386969135;43658.78170609254;43763;43772.56227437685;357742;360204;360334;360895;361110;25367.492650147262;25499.87250063738;25741.099061532757;25769.742302576735;25810.61284080778;40027.59972400355;40259;40482.39276410797;40652.1869562613;43312.566874330856;34941.825290873385;38564.6143538561;38815;39247.41128883126;39599;38254;38301.808490957366;38900.41649375318;39403.21193576055;39616.80191599023;36136.27727445489;36615.63384366122;37296.25407491889;37471.62528374681;40371.192576147725;31116.844415778683;34062.829685851415;34082.675797727556;34300.31399372048;34725.30549389048;26199.738002620492;26378;26405.735942640327;26597.601035984088;26846.59730104011 09:00:29 INFO - PROCESS | 15712 | |2;jquery.html;373.1231605726543;374.2683054628202;376.1442717816966;378.45691432793933;391.27028092607276;16107.194640267984;17793.822061779363;17961.191746371413;18005.549861253476;18162.909185454086;16350.83649163511;16798;16963.900795322224;17060.914695426505;17088.145592720375;5174.042802081608;5351.197320401951;5359.812406565771;5363.168708850135;5366.141417373221;3803.2773772983182;5320.733963301839;5964.582479226434;6266.122742816009;6270.937290627081;6245.0320200369015;6313.77901773438;6322.873542529147;6334.588251763644;6350;6161.19904412428;6238.4697300729495;6256.249250090018;6299.65351905645;6300.24397072352;5443.2107344435235;5472.972635136839;5473.28847249859;5477.75350109246;5498.752556134984;20975.5804883903;20993.16027358919;21351.466213344636;21665.133394664354;21685.566288674137;1908.9809101909082;1945.066368143285;2067.9689804652944;2535.1760677779794;2558.040734724478;13813;14115.717685646332;14130.71738565223;14319;14410.207438590873;1817.9091045447808;1839.1815642039298;1840.6134711710422;1840.723891416285;1843.317972350239;67478.66260668714;67634.66182669056;67650.66174669145;67656;68205.31794682039;9470.90529094714;9502.572384242725;9759.804803903882;9929.30494865367;10056.195504359634;13249.536266230829;13266.734665306833;13288.402021909038;13433.529826456028;13465.596032119052;6939.028536004963;6939.340762627542;7004.789856304319;7162.713491460283;7206.06321178254;6384.170057892445;6433.228012638419;6516.902246466307;6553.606783593;6559.868802623921;6086;6093.26880774301;6104.877902441926;6174.197354343996;6237.688115594202;1626.487656388234;1716.8111507734138;1798.4245041586828;1799.9910000450177;1806.8102849200907;809.8218391953761;885.8892638420198;897.9865302020474;918.8024574716468;939.5020639061308;17205.22576484036;17372.739408908878;17656.55858603545;18052.54868628295;18155.273789048555;860.4278155026963;869.5261082709939;892.3396686451979;909.2771246858763;919.3013309884536;9810.509474526245;10274.691759247235;10307.536160872778;10334.483275836179;10419.635312764018;351227.43862806755;353142;354886;355577;359097;64353.356466435675;67695.3230467689;68640;69196.30803691898;71099.64450177716;906.6645341223658;920.9171174594319;940.1115945431502;940.5438362394233;942.1755963531909;15227.771583426478;15728.134952577719;15815;15933.601659958595;16151.353945842035;34613;35129;35357.11607209737;35557.28885422329;36025.0993725159;43535;46515.53484465247;46732.53267467282;46753.76623116863;46913;7715.704808546339;7908.169642187488;7912.802179945547;7925.128235893932;7947.483413578099;11716.414179291172;11780.410979451164;12109.878901211228;12171.817422738843;12381.071419643742;9923.156531694598;10167.237457190593;10423.68728938133;10721.249512534048;10911.945440273066;10365.06714395708;10586.947065264625;10600.893991060299;10616.681499555025;10663.466826658481;10274.845877311696;10435.16518678519;10522.21083418762;10565.63020294286;10573.682789516326;7693.846123077619;7731.8840217395655;7736.071671399243;7796.961015194887;7863.017122859643;9994.650187243411;10233.590656373959;10285.43430111351;10386.480675966322;10405.739856503345 09:00:29 INFO - PROCESS | 15712 | |3;mootools.html;1374.4364810427726;1393.2754967416943;1508.8189417269923;1699.677061358341;1713.0578181999897;6919.100516932805;7520.88718669219;7595.46831721779;8195.672173113076;8210.548419836914;7658.463907526475;7883.724069657549;7933.76198714038;7934.127246002935;7934.3255823255095;2191.7917797809223;2260.785225403584;2262.095161935231;2263.196565219348;2271.1029143488313;2188.857724247927;2211.402921211272;2248.15694114707;2252.0653928619686;2252.853564518301;2210.8452408331423;2217.157480157538;2220.622494175994;2226.1874415838183;2275.2946586558137;2155.3103007037753;2168.620491414004;2186.431527802767;2187;2197.165077270635;2142.1645558232303;2155.6550951847785;2162.167565487299;2165.112303955371;2174.4889950861534;7879.763607091796;7933.801654958615;8003.719869804587;8021.19788021199;8027.478213916077;4445.955540444619;4548.067646132568;4559.886002849922;4564.5435456454425;4587.885302867422;2823.688045924608;2961.1116665000627;2961.585378047075;2963.955540666892;2979.19561718337;914.5564401265381;940.47333493244;956.1442508954516;963.2967933408581;973.3575839945672;10611.57553697859;10767.515461804238;10799.460026998619;10808.02727754506;10838.458077096193;4034.5561988181275;4111.753294802322;4282;4286.807093680792;4324.2648749712625;9191.540422978824;9231.261499080058;9250.074992500697;9254.676086336945;9297.953510232406;4615.30770384445;4634.930476042862;4652.581267685924;4656.0920620479355;4673.485916549177;3544.91137721559;4053.61490658387;4195.790210489463;4217.91564168721;4234.026173980002;3664.13892735207;3687.7787332759585;3707.1844194277214;3765.9058523537133;3821.6942644588366;1178.5403692559908;1204.27141579345;1205.1804772754435;1213.3690480949856;1221.773971815217;776.3944123583501;784.2040329066002;816.432579357341;820.4953953318666;832.1221111727065;5132;5132.692038477703;5172.663776854568;5203.271541984125;5333.759980800874;415.8586080732505;416.1261351162595;431.72153960695175;435.34480606686736;435.9891002724957;3586.6413358664445;3589.6948759355223;3632.400653892078;3652.8721494747556;3696.963030369716;9573.377730447637;9852.753681157885;9919.107280344804;9957.55191016406;9977.750556236007;9783.804323913482;9823.459709715891;9852.162566181954;9853.704388868346;9869.555869985868;7038.92961070393;7408.777736667908;7427.257274272638;7428.888566671612;7450.478466507292;5278.788848446019;5294.8941021180135;5345.759440825094;5361.731913404236;5444.183372493999;8917.509536975529;8926.776830579287;9062.773430664287;9071.954640226757;9073.727788166365;8967.417117887317;8992.595333210153;9129.5891684873;9363.906360936304;9388.95305523468;5996.102533353355;6648.102506161799;6837.35045170708;6864.897026544506;6987.965060174666;7655.46411751172;7690.846183076419;7707.34487568563;7725;7767.223277672414;6914.27400123;7037.190723066913;7042.260562640849;7056.964715176391;7208.819779505554;6748.831279218059;6818.215905170969;6851.246362899978;6980.511364204457;7048.718051277891;5788.392218817132;5973.074173503114;6012.218411606463;6050.30421501533;6137.6931153441255;4363.105563359567;4454.7549884756645;4497;4497.392851964943;4597.402337696078;4427.358033085249;4537.682362234612;4560.315952607136;4566.520515345974;4582.03777206777 09:00:29 INFO - PROCESS | 15712 | |4;prototype.html;293.85307346326834;295.69986463739303;298.99850500747493;312.06691990947076;312.2973310052382;4939.863186876332;5069.974650126745;5071.746412679365;5109.74451277436;5128.871778205546;4893.651047497204;5002.649814512985;5039.244113382985;5039.496050394959;5074.695518268897;3918.8439410373867;3953.4267531207956;3962.9207415851665;3968.7817170055637;3970.1464185200175;3885.32006898793;3986.2824691555506;3993.960060399402;4002.919941601166;4007.5391329996987;3901.453796468497;3932.1742434088733;3940.8374529513717;3964.405339199129;3967.4643923070303;3907.609239076098;3919.451276821247;3929.4302326162547;3935.6654684351865;3971.9007024824323;3296.9449776071665;3399.5721796845382;3407.8807241746667;3432.6052503961864;3474.704650104744;4918.8278410255825;4928.359313289286;4946.851594452172;4978.402591688984;4979.626528010377;4412.6690498212765;4414.624756895668;4444.59995101542;4461.442319710036;4470.552944705536;5136.691798492103;5291.126964050927;5299.364076310829;5360.597955153379;5365.382980957162;3695.316366472211;3695.6858667013335;3706.4810926470313;3714.7028237741188;3717.3680474319162;5514.6139770216105;5541.833744987657;5562.721863906789;5567.777288908439;5576.776928922838;3666.999488348764;3811.866584669523;3817.217470418613;3829.636184562518;3844.3656796628243;3868.4197370394104;3874.2251549690177;3895.9805200973815;3899.805009749501;3905.941410878839;4466.508684044752;4479.260921947842;4479.5744404282195;4480.238359478896;4490.842820501267;5173.068847607392;5338.3593968724;5365.356157261153;5369.060414427538;5401.838604700009;1327.621627836062;1348.3190988550718;1348.4606157536869;1349.7165595224917;1358.2325985817981;840.474703310431;843.0010437631427;857.3912522109248;863.330918538138;872.5244741615835;4160.91678166441;4188.958110418917;4192.798780640127;4195.223883581486;4218.8523401680795;4882.384369179781;4882.851545320048;4882.902341953141;4888.926666100011;4899.804007839718;4176.394422808676;4187.623113919762;4191.7275377100395;4237.279662457389;4258.063226090318;2520.7731304182344;2595.8053146014126;2613.4119823040046;2621.921342359732;2627.238100950741;4559.680822342404;4571.748553829505;4612.561806628365;4618.422697162855;4635.397398338195;4915.852524424273;4939.827106051271;4971.229459433794;5008.398992120969;5015.247712843103;4300.548442413564;4676.438827340673;4681.976590117028;4694.507076756891;4695.826043489128;4918.385201849769;4924.310596516419;4944.184209605375;4952.2819191217795;4971.9005619886675;4810.725157833247;4821.841693690638;4832.782524786463;4839.564439200489;4861.732604706775;4883.36516252899;5212.8010557571215;5232.816851410183;5244.134717771525;5244.318238628954;3635.781853088823;3743.73793834429;3849.0954625663508;3856.1323702166787;3859.208862183302;5468.1681636652165;5468.726563671721;5488.643238189665;5489.094299440548;5516.91724624139;5347.732613369239;5355.169948657965;5383.219433182245;5410.864728381822;5416.945830541802;5108.642395032312;5326.414094449685;5334.333208348957;5338.2526446298325;5353.2773075634295;5290.386432138234;5290.444503327095;5319.361676598833;5321.893562128813;5332.30680011596;5163.535281824654;5366.221897824872;5431.728413579384;5431.995080910045;5432.239486471976;5242.606804489602;5259.447757985509;5274.129768588294;5287.444818294178;5298.70857102863 09:00:29 INFO - PROCESS | 15712 | |5;yui.html;571.2915984179618;607.328901563772;607.5777334752346;637.964911929844;691.0113757996664;12348.259104453728;13144.539941102063;13242.006849486292;13278.800817987738;13357.666058348546;13504.594862154152;13966.720665586683;14030.649233769162;14062.929685351584;14109.223992680398;619.2445216835454;756.6595032235489;768.7271018788333;787.7164220880478;791.4618059719388;782.026377160436;787.3819052044147;793.1394437035823;795.0578564401175;795.1372760554776;828.1883753921161;831.2934006094802;832.4006715165071;833.3999520345342;833.8499070167368;823.983520329593;824.2787560884226;825.5129473610568;826.499967519648;828.2628460669979;603;603.4629180029777;603.9516838652942;605.1225722702055;606.2845841906549;12952;13010.674733131653;13111.344432778324;13153;13170.60488185356;12903.419346129353;13312.600621981355;13316.800247996287;13434;13535.255560944144;10334.7416314592;10384.32501887375;10433.373997560095;10614.893851061468;10841.13270938323;3282.5240340150785;3312.790831346565;3342.2312868040485;3343.6823501767294;3349.916252093693;65008;65153;66012.66993665049;67170.32829671739;67417;10640.89359106399;10650.360978341325;10691.30506517074;10710.839337409945;10822.512986915608;17205.827941720672;17494.562635933948;17720.734188987175;17757.200925958365;18889.338873139375;6024.457798798129;6102.938970610326;6119.051547010221;6138.938610613926;6266.216722909637;3642.18050938542;3644.835982380799;3654.14127679995;3662.7436079474182;3750.6436888496096;3045.9390812183633;3161.9525707114412;3164.2722173900133;3167.6990685884803;3173.666764989689;491.5035813828059;509.28699820251944;511.289307862072;511.4450820859335;513.5429467773685;506.7972810875679;540.9404965453797;545.3510322715955;548.1886807524885;550.6998685716214;7767.300942915052;7948.960255198687;8085.676572937135;8396.110875053064;8403.991521017395;498.35960790384183;572.6878851026117;577.5985689945447;579.4495229531962;582.8368056944063;3669.229461813049;3773.735838491279;3783.356829339019;3846.8653597123966;3966.781826999485;82208.58895705602;83344.58327708444;84518.57740711258;108455;112164.4391778036;49812.50187498151;82957;84188.57905710432;85436;87386;46412.30381544212;47576.762116189195;74154.25845741581;75112.62443687856;76222.23777762262;8616.569171541272;8714.302855771397;8762.912370876209;8801.867971980297;8908.821823563621;42367;42487.5751242496;42655.14689706126;42684.57315426806;42692.359614605186;64165.67917160571;65449.672751637845;65614.34385656082;65736.67131664311;66158;11427;11488.655340339803;11508.079353651856;11638.127140464669;11696.415179240834;13179.94560435182;13244.20534767917;13402.731945361233;13711.314434278445;14048.227347495576;11627.360495172508;11727;12170.817437738264;12302.569410070604;12324.137310388187;11711.941440293085;11751.529938802694;11768.35274059935;11841.64475065715;12183.025357971519;11507.942460287644;11540.480678369326;11832.112591555495;12027.45876435545;12603.621891343275;10188.847167292644;10233.385996840214;10271.84592231132;10294.279400441897;10430.478476076318;9948.502574871083;10215.336003159771;10263.640772573222;10324.122449591869;10430 09:00:29 INFO - PROCESS | 15712 | __end_tp_report 09:00:29 INFO - PROCESS | 15712 | __start_cc_report 09:00:29 INFO - PROCESS | 15712 | _x_x_mozilla_cycle_collect,388 09:00:29 INFO - PROCESS | 15712 | __end_cc_report 09:00:29 INFO - PROCESS | 15712 | __startTimestamp1467734429232__endTimestamp 09:00:29 INFO - PROCESS | 15712 | 09:00:29 INFO - PROCESS | 15712 | ------- Summary: start ------- 09:00:29 INFO - PROCESS | 15712 | Number of tests: 6 09:00:29 INFO - PROCESS | 15712 | 09:00:29 INFO - PROCESS | 15712 | [#0] dojo.html Cycles:165 Average:4678.50 Median:4865.29 stddev:592.14 (12.2%) stddev-sans-first:571.16 09:00:29 INFO - PROCESS | 15712 | Values: 2604.3 2659.6 2664.7 2679.2 2682.1 4695.8 4721.2 4743.9 4830.7 4872.6 4634.4 4706.2 4718.1 4743.5 4750.7 4302.5 4377.5 4438.2 4456.3 4462.3 616.5 4269.4 4306.9 4386.3 4388.9 4377.5 4416.7 4447.5 4485.8 4494.7 4441.1 4448.7 4450.5 4463.6 4495.9 4303.4 4347.7 4371.8 4375.2 4385.4 4687.8 4717.8 4752.9 4754.4 4804.0 5057.6 5072.8 5089.7 5099.1 5151.8 5002.3 5057.0 5098.4 5121.1 5133.4 4767.4 4769.6 4772.0 4776.0 4818.2 5104.8 5186.1 5243.8 5245.0 5304.8 4944.1 4949.0 4962.0 4968.7 4999.6 5037.3 5071.2 5102.1 5105.2 5156.7 5011.4 5026.2 5031.5 5050.2 5064.8 5031.1 5043.9 5046.4 5054.6 5098.0 4197.5 4231.9 4236.4 4271.2 4272.8 3663.1 3679.8 3703.8 3707.6 3737.8 4299.2 4324.0 4329.6 4383.4 4410.8 5073.1 5100.5 5107.6 5108.8 5117.2 4325.7 4347.3 4381.2 4383.3 4383.6 4463.3 4480.1 4484.7 4513.2 4559.7 4728.6 4767.8 4784.9 4793.3 4811.3 5104.1 5163.8 5173.9 5177.1 5228.8 4812.0 4858.5 4875.2 4893.1 4919.0 4853.1 4930.9 4967.3 5041.9 5111.7 5061.9 5089.0 5089.4 5121.4 5123.4 4968.9 4992.1 4995.8 5003.7 5006.6 4865.3 4903.6 4934.9 4944.6 4963.0 4881.2 4883.6 4908.4 4921.1 4943.9 5007.3 5036.7 5042.1 5043.8 5094.5 4781.5 4881.4 4909.7 4940.2 4979.5 09:00:29 INFO - PROCESS | 15712 | 09:00:29 INFO - PROCESS | 15712 | [#1] ext.html Cycles:180 Average:48147.65 Median:37873.62 stddev:91253.70 (240.9%) stddev-sans-first:91439.77 09:00:29 INFO - PROCESS | 15712 | Values: 570.5 577.7 577.7 589.0 632.8 35839.6 39602.4 39608.4 39609.2 39910.4 39299.2 39551.4 39582.8 39649.8 39770.2 7664.1 7774.3 7831.3 7837.6 7857.8 7827.5 7884.0 7925.5 7949.8 7970.2 7932.5 7953.6 7970.8 7985.8 8011.1 7849.7 7903.0 7949.1 7965.6 7968.6 7873.3 7887.5 7901.9 7922.8 7925.0 37634.6 37705.0 37853.6 37893.6 37925.6 2906.0 2931.7 3041.6 3064.7 3207.5 29681.7 29695.0 30027.5 30311.8 31213.4 3372.5 3430.9 3442.9 3460.5 3464.4 253948.0 254051.0 254646.0 257354.0 258529.0 31267.7 32457.2 51850.5 52394.0 52479.2 33653.5 33756.5 33819.0 33870.5 33900.5 12368.6 12500.1 12537.5 12578.4 12621.0 10180.9 10182.2 10250.9 10285.4 10296.5 7850.8 7854.5 7891.5 7935.6 7977.6 3053.5 3055.6 3069.0 3094.8 3117.6 893.1 898.5 956.9 957.1 970.2 27942.9 28726.6 29113.9 29158.1 29447.0 884.9 938.1 951.9 958.5 959.8 14666.1 14778.9 14948.6 15117.6 15263.5 398437.0 402254.0 404121.0 404830.0 405412.0 50633.7 50704.0 50785.4 50927.0 51077.0 1192.1 1195.2 1202.4 1206.7 1246.8 25165.9 27707.3 27727.7 27827.2 28093.0 42735.4 43075.4 43658.8 43763.0 43772.6 357742.0 360204.0 360334.0 360895.0 361110.0 25367.5 25499.9 25741.1 25769.7 25810.6 40027.6 40259.0 40482.4 40652.2 43312.6 34941.8 38564.6 38815.0 39247.4 39599.0 38254.0 38301.8 38900.4 39403.2 39616.8 36136.3 36615.6 37296.3 37471.6 40371.2 31116.8 34062.8 34082.7 34300.3 34725.3 26199.7 26378.0 26405.7 26597.6 26846.6 09:00:29 INFO - PROCESS | 15712 | 09:00:29 INFO - PROCESS | 15712 | [#2] jquery.html Cycles:180 Average:23214.19 Median:377.30 stddev:58448.69 (15491.3%) stddev-sans-first:58587.49 09:00:29 INFO - PROCESS | 15712 | Values: 373.1 374.3 376.1 378.5 391.3 16107.2 17793.8 17961.2 18005.5 18162.9 16350.8 16798.0 16963.9 17060.9 17088.1 5174.0 5351.2 5359.8 5363.2 5366.1 3803.3 5320.7 5964.6 6266.1 6270.9 6245.0 6313.8 6322.9 6334.6 6350.0 6161.2 6238.5 6256.2 6299.7 6300.2 5443.2 5473.0 5473.3 5477.8 5498.8 20975.6 20993.2 21351.5 21665.1 21685.6 1909.0 1945.1 2068.0 2535.2 2558.0 13813.0 14115.7 14130.7 14319.0 14410.2 1817.9 1839.2 1840.6 1840.7 1843.3 67478.7 67634.7 67650.7 67656.0 68205.3 9470.9 9502.6 9759.8 9929.3 10056.2 13249.5 13266.7 13288.4 13433.5 13465.6 6939.0 6939.3 7004.8 7162.7 7206.1 6384.2 6433.2 6516.9 6553.6 6559.9 6086.0 6093.3 6104.9 6174.2 6237.7 1626.5 1716.8 1798.4 1800.0 1806.8 809.8 885.9 898.0 918.8 939.5 17205.2 17372.7 17656.6 18052.5 18155.3 860.4 869.5 892.3 909.3 919.3 9810.5 10274.7 10307.5 10334.5 10419.6 351227.4 353142.0 354886.0 355577.0 359097.0 64353.4 67695.3 68640.0 69196.3 71099.6 906.7 920.9 940.1 940.5 942.2 15227.8 15728.1 15815.0 15933.6 16151.4 34613.0 35129.0 35357.1 35557.3 36025.1 43535.0 46515.5 46732.5 46753.8 46913.0 7715.7 7908.2 7912.8 7925.1 7947.5 11716.4 11780.4 12109.9 12171.8 12381.1 9923.2 10167.2 10423.7 10721.2 10911.9 10365.1 10586.9 10600.9 10616.7 10663.5 10274.8 10435.2 10522.2 10565.6 10573.7 7693.8 7731.9 7736.1 7797.0 7863.0 9994.7 10233.6 10285.4 10386.5 10405.7 09:00:29 INFO - PROCESS | 15712 | 09:00:29 INFO - PROCESS | 15712 | [#3] mootools.html Cycles:180 Average:5176.32 Median:5132.35 stddev:2944.50 (57.4%) stddev-sans-first:2938.90 09:00:29 INFO - PROCESS | 15712 | Values: 1374.4 1393.3 1508.8 1699.7 1713.1 6919.1 7520.9 7595.5 8195.7 8210.5 7658.5 7883.7 7933.8 7934.1 7934.3 2191.8 2260.8 2262.1 2263.2 2271.1 2188.9 2211.4 2248.2 2252.1 2252.9 2210.8 2217.2 2220.6 2226.2 2275.3 2155.3 2168.6 2186.4 2187.0 2197.2 2142.2 2155.7 2162.2 2165.1 2174.5 7879.8 7933.8 8003.7 8021.2 8027.5 4446.0 4548.1 4559.9 4564.5 4587.9 2823.7 2961.1 2961.6 2964.0 2979.2 914.6 940.5 956.1 963.3 973.4 10611.6 10767.5 10799.5 10808.0 10838.5 4034.6 4111.8 4282.0 4286.8 4324.3 9191.5 9231.3 9250.1 9254.7 9298.0 4615.3 4634.9 4652.6 4656.1 4673.5 3544.9 4053.6 4195.8 4217.9 4234.0 3664.1 3687.8 3707.2 3765.9 3821.7 1178.5 1204.3 1205.2 1213.4 1221.8 776.4 784.2 816.4 820.5 832.1 5132.0 5132.7 5172.7 5203.3 5333.8 415.9 416.1 431.7 435.3 436.0 3586.6 3589.7 3632.4 3652.9 3697.0 9573.4 9852.8 9919.1 9957.6 9977.8 9783.8 9823.5 9852.2 9853.7 9869.6 7038.9 7408.8 7427.3 7428.9 7450.5 5278.8 5294.9 5345.8 5361.7 5444.2 8917.5 8926.8 9062.8 9072.0 9073.7 8967.4 8992.6 9129.6 9363.9 9389.0 5996.1 6648.1 6837.4 6864.9 6988.0 7655.5 7690.8 7707.3 7725.0 7767.2 6914.3 7037.2 7042.3 7057.0 7208.8 6748.8 6818.2 6851.2 6980.5 7048.7 5788.4 5973.1 6012.2 6050.3 6137.7 4363.1 4454.8 4497.0 4497.4 4597.4 4427.4 4537.7 4560.3 4566.5 4582.0 09:00:29 INFO - PROCESS | 15712 | 09:00:29 INFO - PROCESS | 15712 | [#4] prototype.html Cycles:180 Average:4281.08 Median:4816.28 stddev:1252.80 (26.0%) stddev-sans-first:1220.05 09:00:29 INFO - PROCESS | 15712 | Values: 293.9 295.7 299.0 312.1 312.3 4939.9 5070.0 5071.7 5109.7 5128.9 4893.7 5002.6 5039.2 5039.5 5074.7 3918.8 3953.4 3962.9 3968.8 3970.1 3885.3 3986.3 3994.0 4002.9 4007.5 3901.5 3932.2 3940.8 3964.4 3967.5 3907.6 3919.5 3929.4 3935.7 3971.9 3296.9 3399.6 3407.9 3432.6 3474.7 4918.8 4928.4 4946.9 4978.4 4979.6 4412.7 4414.6 4444.6 4461.4 4470.6 5136.7 5291.1 5299.4 5360.6 5365.4 3695.3 3695.7 3706.5 3714.7 3717.4 5514.6 5541.8 5562.7 5567.8 5576.8 3667.0 3811.9 3817.2 3829.6 3844.4 3868.4 3874.2 3896.0 3899.8 3905.9 4466.5 4479.3 4479.6 4480.2 4490.8 5173.1 5338.4 5365.4 5369.1 5401.8 1327.6 1348.3 1348.5 1349.7 1358.2 840.5 843.0 857.4 863.3 872.5 4160.9 4189.0 4192.8 4195.2 4218.9 4882.4 4882.9 4882.9 4888.9 4899.8 4176.4 4187.6 4191.7 4237.3 4258.1 2520.8 2595.8 2613.4 2621.9 2627.2 4559.7 4571.7 4612.6 4618.4 4635.4 4915.9 4939.8 4971.2 5008.4 5015.2 4300.5 4676.4 4682.0 4694.5 4695.8 4918.4 4924.3 4944.2 4952.3 4971.9 4810.7 4821.8 4832.8 4839.6 4861.7 4883.4 5212.8 5232.8 5244.1 5244.3 3635.8 3743.7 3849.1 3856.1 3859.2 5468.2 5468.7 5488.6 5489.1 5516.9 5347.7 5355.2 5383.2 5410.9 5416.9 5108.6 5326.4 5334.3 5338.3 5353.3 5290.4 5290.4 5319.4 5321.9 5332.3 5163.5 5366.2 5431.7 5432.0 5432.2 5242.6 5259.4 5274.1 5287.4 5298.7 09:00:29 INFO - PROCESS | 15712 | 09:00:29 INFO - PROCESS | 15712 | [#5] yui.html Cycles:180 Average:17414.79 Median:23166.89 stddev:24555.17 (106.0%) stddev-sans-first:24591.48 09:00:29 INFO - PROCESS | 15712 | Values: 571.3 607.3 607.6 638.0 691.0 12348.3 13144.5 13242.0 13278.8 13357.7 13504.6 13966.7 14030.6 14062.9 14109.2 619.2 756.7 768.7 787.7 791.5 782.0 787.4 793.1 795.1 795.1 828.2 831.3 832.4 833.4 833.8 824.0 824.3 825.5 826.5 828.3 603.0 603.5 604.0 605.1 606.3 12952.0 13010.7 13111.3 13153.0 13170.6 12903.4 13312.6 13316.8 13434.0 13535.3 10334.7 10384.3 10433.4 10614.9 10841.1 3282.5 3312.8 3342.2 3343.7 3349.9 65008.0 65153.0 66012.7 67170.3 67417.0 10640.9 10650.4 10691.3 10710.8 10822.5 17205.8 17494.6 17720.7 17757.2 18889.3 6024.5 6102.9 6119.1 6138.9 6266.2 3642.2 3644.8 3654.1 3662.7 3750.6 3045.9 3162.0 3164.3 3167.7 3173.7 491.5 509.3 511.3 511.4 513.5 506.8 540.9 545.4 548.2 550.7 7767.3 7949.0 8085.7 8396.1 8404.0 498.4 572.7 577.6 579.4 582.8 3669.2 3773.7 3783.4 3846.9 3966.8 82208.6 83344.6 84518.6 108455.0 112164.4 49812.5 82957.0 84188.6 85436.0 87386.0 46412.3 47576.8 74154.3 75112.6 76222.2 8616.6 8714.3 8762.9 8801.9 8908.8 42367.0 42487.6 42655.1 42684.6 42692.4 64165.7 65449.7 65614.3 65736.7 66158.0 11427.0 11488.7 11508.1 11638.1 11696.4 13179.9 13244.2 13402.7 13711.3 14048.2 11627.4 11727.0 12170.8 12302.6 12324.1 11711.9 11751.5 11768.4 11841.6 12183.0 11507.9 11540.5 11832.1 12027.5 12603.6 10188.8 10233.4 10271.8 10294.3 10430.5 9948.5 10215.3 10263.6 10324.1 10430.0 09:00:29 INFO - PROCESS | 15712 | -------- Summary: end -------- 09:00:29 INFO - PROCESS | 15712 | 09:00:29 INFO - TEST-INFO | 15712: exit 0 09:00:30 INFO - TEST-OK | dromaeo_css | took 1116788ms 09:00:30 INFO - TEST-START | kraken 09:00:30 INFO - operating with platform_type : linux_ 09:00:30 INFO - Initialising browser for kraken test... 09:00:30 INFO - TEST-INFO | started process 15959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcjQAVl/profile http://localhost:36253/getInfo.html) 09:00:34 INFO - PROCESS | 15959 | __metrics Screen width/height:1600/1200 09:00:34 INFO - PROCESS | 15959 | colorDepth:24 09:00:34 INFO - PROCESS | 15959 | Browser inner width/height: 1024/697 09:00:34 INFO - PROCESS | 15959 | __metrics 09:00:35 ERROR - PROCESS | 15959 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:00:36 INFO - TEST-INFO | 15959: exit 0 09:00:36 INFO - Browser initialized. 09:00:36 INFO - Running cycle 1/1 for kraken test... 09:00:36 INFO - TEST-INFO | started process 16076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcjQAVl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:48 INFO - PROCESS | 16076 | RSS: Main: 169766912 09:00:48 INFO - PROCESS | 16076 | 09:00:51 INFO - PROCESS | 16076 | Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36253/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:52 INFO - PROCESS | 16076 | RSS: Main: 174198784 09:00:52 INFO - PROCESS | 16076 | 09:00:54 INFO - PROCESS | 16076 | Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36253/tests/kraken/driver.html?testName=audio-dft) 09:00:55 INFO - PROCESS | 16076 | RSS: Main: 174002176 09:00:55 INFO - PROCESS | 16076 | 09:00:58 INFO - PROCESS | 16076 | Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36253/tests/kraken/driver.html?testName=audio-fft) 09:00:59 INFO - PROCESS | 16076 | RSS: Main: 169209856 09:00:59 INFO - PROCESS | 16076 | 09:01:01 INFO - PROCESS | 16076 | Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36253/tests/kraken/driver.html?testName=audio-oscillator) 09:01:01 INFO - PROCESS | 16076 | RSS: Main: 169992192 09:01:01 INFO - PROCESS | 16076 | 09:01:04 INFO - PROCESS | 16076 | Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36253/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:01:04 INFO - PROCESS | 16076 | RSS: Main: 170229760 09:01:04 INFO - PROCESS | 16076 | 09:01:07 INFO - PROCESS | 16076 | Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36253/tests/kraken/driver.html?testName=imaging-darkroom) 09:01:08 INFO - PROCESS | 16076 | RSS: Main: 170799104 09:01:08 INFO - PROCESS | 16076 | 09:01:12 INFO - PROCESS | 16076 | Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36253/tests/kraken/driver.html?testName=imaging-desaturate) 09:01:12 INFO - PROCESS | 16076 | RSS: Main: 168321024 09:01:12 INFO - PROCESS | 16076 | 09:01:15 INFO - PROCESS | 16076 | Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36253/tests/kraken/driver.html?testName=json-parse-financial) 09:01:16 INFO - PROCESS | 16076 | RSS: Main: 169504768 09:01:16 INFO - PROCESS | 16076 | 09:01:17 INFO - PROCESS | 16076 | Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36253/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:01:18 INFO - PROCESS | 16076 | RSS: Main: 169984000 09:01:18 INFO - PROCESS | 16076 | 09:01:20 INFO - PROCESS | 16076 | Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36253/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:01:21 INFO - PROCESS | 16076 | RSS: Main: 170024960 09:01:21 INFO - PROCESS | 16076 | 09:01:23 INFO - PROCESS | 16076 | Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36253/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:01:24 INFO - PROCESS | 16076 | RSS: Main: 170627072 09:01:24 INFO - PROCESS | 16076 | 09:01:26 INFO - PROCESS | 16076 | Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:01:27 INFO - PROCESS | 16076 | RSS: Main: 170377216 09:01:27 INFO - PROCESS | 16076 | 09:01:30 INFO - PROCESS | 16076 | Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:01:30 INFO - PROCESS | 16076 | RSS: Main: 170319872 09:01:30 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | Cycle 1(1): loaded http://localhost:36253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36253/tests/kraken/driver.html?testName=ai-astar) 09:01:32 INFO - PROCESS | 16076 | RSS: Main: 171077632 09:01:32 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | __start_tp_report 09:01:32 INFO - PROCESS | 16076 | _x_x_mozilla_page_load 09:01:32 INFO - PROCESS | 16076 | _x_x_mozilla_page_load_details 09:01:32 INFO - PROCESS | 16076 | |i|pagename|runs| 09:01:32 INFO - PROCESS | 16076 | |0;ai-astar;104;112;110;114;114;116;122;115;114;115 09:01:32 INFO - PROCESS | 16076 | |1;audio-beat-detection;154;122;146;179;125;155;146;125;194;124 09:01:32 INFO - PROCESS | 16076 | |2;audio-dft;163;162;164;167;170;162;168;164;165;164 09:01:32 INFO - PROCESS | 16076 | |3;audio-fft;76;76;76;145;78;76;76;76;165;77 09:01:32 INFO - PROCESS | 16076 | |4;audio-oscillator;85;87;142;85;87;85;140;87;86;136 09:01:32 INFO - PROCESS | 16076 | |5;imaging-gaussian-blur;118;119;117;119;117;117;118;118;120;119 09:01:32 INFO - PROCESS | 16076 | |6;imaging-darkroom;149;148;150;148;148;151;149;150;149;148 09:01:32 INFO - PROCESS | 16076 | |7;imaging-desaturate;96;96;95;95;95;96;96;95;96;95 09:01:32 INFO - PROCESS | 16076 | |8;json-parse-financial;65;64;64;65;66;66;64;66;65;64 09:01:32 INFO - PROCESS | 16076 | |9;json-stringify-tinderbox;64;64;65;64;66;64;64;64;65;65 09:01:32 INFO - PROCESS | 16076 | |10;stanford-crypto-aes;78;81;82;78;80;79;85;80;84;78 09:01:32 INFO - PROCESS | 16076 | |11;stanford-crypto-ccm;140;141;137;129;134;143;131;131;163;130 09:01:32 INFO - PROCESS | 16076 | |12;stanford-crypto-pbkdf2;166;166;166;174;170;164;165;170;168;169 09:01:32 INFO - PROCESS | 16076 | |13;stanford-crypto-sha256-iterative;68;66;68;66;69;67;68;68;67;68 09:01:32 INFO - PROCESS | 16076 | __end_tp_report 09:01:32 INFO - PROCESS | 16076 | __start_cc_report 09:01:32 INFO - PROCESS | 16076 | _x_x_mozilla_cycle_collect,988 09:01:32 INFO - PROCESS | 16076 | __end_cc_report 09:01:32 INFO - PROCESS | 16076 | __startTimestamp1467734492909__endTimestamp 09:01:32 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | ------- Summary: start ------- 09:01:32 INFO - PROCESS | 16076 | Number of tests: 14 09:01:32 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.50 stddev:4.58 (4.0%) stddev-sans-first:3.28 09:01:32 INFO - PROCESS | 16076 | Values: 104.0 112.0 110.0 114.0 114.0 116.0 122.0 115.0 114.0 115.0 09:01:32 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:150.00 stddev:24.65 (16.4%) stddev-sans-first:26.02 09:01:32 INFO - PROCESS | 16076 | Values: 154.0 122.0 146.0 179.0 125.0 155.0 146.0 125.0 194.0 124.0 09:01:32 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:2.64 (1.6%) stddev-sans-first:2.71 09:01:32 INFO - PROCESS | 16076 | Values: 163.0 162.0 164.0 167.0 170.0 162.0 168.0 164.0 165.0 164.0 09:01:32 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | [#3] audio-fft Cycles:10 Average:92.10 Median:76.00 stddev:33.49 (44.1%) stddev-sans-first:35.01 09:01:32 INFO - PROCESS | 16076 | Values: 76.0 76.0 76.0 145.0 78.0 76.0 76.0 76.0 165.0 77.0 09:01:32 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:85.50 stddev:25.82 (30.2%) stddev-sans-first:26.64 09:01:32 INFO - PROCESS | 16076 | Values: 85.0 87.0 142.0 85.0 87.0 85.0 140.0 87.0 86.0 136.0 09:01:32 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.50 stddev:1.03 (0.9%) stddev-sans-first:1.09 09:01:32 INFO - PROCESS | 16076 | Values: 118.0 119.0 117.0 119.0 117.0 117.0 118.0 118.0 120.0 119.0 09:01:32 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 09:01:32 INFO - PROCESS | 16076 | Values: 149.0 148.0 150.0 148.0 148.0 151.0 149.0 150.0 149.0 148.0 09:01:32 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:01:32 INFO - PROCESS | 16076 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 09:01:32 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 09:01:32 INFO - PROCESS | 16076 | Values: 65.0 64.0 64.0 65.0 66.0 66.0 64.0 66.0 65.0 64.0 09:01:32 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 09:01:32 INFO - PROCESS | 16076 | Values: 64.0 64.0 65.0 64.0 66.0 64.0 64.0 64.0 65.0 65.0 09:01:32 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.50 stddev:2.51 (3.1%) stddev-sans-first:2.49 09:01:32 INFO - PROCESS | 16076 | Values: 78.0 81.0 82.0 78.0 80.0 79.0 85.0 80.0 84.0 78.0 09:01:32 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:138.50 stddev:10.13 (7.3%) stddev-sans-first:10.71 09:01:32 INFO - PROCESS | 16076 | Values: 140.0 141.0 137.0 129.0 134.0 143.0 131.0 131.0 163.0 130.0 09:01:32 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:168.50 stddev:3.01 (1.8%) stddev-sans-first:3.12 09:01:32 INFO - PROCESS | 16076 | Values: 166.0 166.0 166.0 174.0 170.0 164.0 165.0 170.0 168.0 169.0 09:01:32 INFO - PROCESS | 16076 | 09:01:32 INFO - PROCESS | 16076 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 09:01:32 INFO - PROCESS | 16076 | Values: 68.0 66.0 68.0 66.0 69.0 67.0 68.0 68.0 67.0 68.0 09:01:32 INFO - PROCESS | 16076 | -------- Summary: end -------- 09:01:32 INFO - PROCESS | 16076 | 09:01:33 INFO - TEST-INFO | 16076: exit 0 09:01:33 INFO - TEST-OK | kraken | took 63938ms 09:01:33 INFO - SUITE-END | took 1180s 09:01:34 INFO - Completed test suite (00:19:40) 09:01:34 INFO - javascript benchmark 09:01:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6388.66254416348, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2604.348912771807, 2659.6276521287023, 2664.72020437854, 2679.236417620977, 2682.14171465131, 4695.765211739412, 4721.150192965265, 4743.928841067383, 4830.686005409655, 4872.585830204437, 4634.374359461472, 4706.247000479924, 4718.056388722252, 4743.501932297111, 4750.691205071668, 4302.462192225972, 4377.47470303564, 4438.156750217465, 4456.264716321819, 4462.263726485126, 616.4975143702181, 4269.423627810253, 4306.892327691801, 4386.298192289234, 4388.934165987513, 4377.47470303564, 4416.712913660602, 4447.466304043503, 4485.842995495174, 4494.73031618104, 4441.089576636782, 4448.666350023729, 4450.4881938577155, 4463.642908567307, 4495.887602809923, 4303.397524346594, 4347.673924455678, 4371.846985355497, 4375.168717943612, 4385.364122202294, 4687.789049492781, 4717.796961774726, 4752.928706069411, 4754.405699287589, 4804.039192161546, 5057.595392368638, 5072.822451214227, 5089.6691715038405, 5099.107656160157, 5151.768170432302, 5002.299678045077, 5057.039162559102, 5098.413682426494, 5121.078205922932, 5133.383993920716, 4767.417490843361, 4769.594584460325, 4771.976140119277, 4775.976120119377, 4818.204996175662, 5104.795808167706, 5186.066508028515, 5243.764030618631, 5244.9737751310995, 5304.761285742151, 4944.134776414113, 4948.960718249136, 4962.007598480318, 4968.677035992721, 4999.600031997432, 5037.29477873098, 5071.2139618359215, 5102.08162530748, 5105.2342148678, 5156.690598564098, 5011.373578302712, 5026.170681837529, 5031.547160755476, 5050.242463630485, 5064.822731204464, 5031.069252188357, 5043.899122017539, 5046.44489106198, 5054.620903432184, 5098.0, 4197.4753155855515, 4231.915361692811, 4236.449261596034, 4271.188474189956, 4272.764997925082, 3663.084228942764, 3679.7792132472136, 3703.777773333609, 3707.647773461517, 3737.7757334560015, 4299.161663475655, 4324.048709283952, 4329.567043295709, 4383.408239887638, 4410.823567057346, 5073.061483625467, 5100.464451232641, 5107.61692873036, 5108.821191258288, 5117.181250999822, 4325.697201195949, 4347.260965635849, 4381.233284175257, 4383.320585309282, 4383.62739167168, 4463.308187230984, 4480.148771733426, 4484.686071974996, 4513.187626227245, 4559.703619264737, 4728.550787675165, 4767.785449654843, 4784.856454306377, 4793.257045158006, 4811.27830825372, 5104.106781313181, 5163.845084647466, 5173.870653233699, 5177.145770947752, 5228.816991405282, 4811.975940120277, 4858.5384388483035, 4875.219964805614, 4893.070316639827, 4918.95081049185, 4853.102176097434, 4930.901381972269, 4967.254911763264, 5041.873953151054, 5111.667741596784, 5061.898762024813, 5089.0, 5089.414717307557, 5121.385433747974, 5123.436421993503, 4968.925466118083, 4992.126377883928, 4995.8001679932395, 5003.674761140514, 5006.5994720423005, 4865.294532292868, 4903.60771138301, 4934.851954441372, 4944.604431645388, 4963.0, 4881.243407271879, 4883.614332974622, 4908.386451693538, 4921.089598424303, 4943.925841112315, 5007.324011258579, 5036.697798132123, 5042.117629414764, 5043.84868453947, 5094.5160209780015, 4781.545753153445, 4881.438634557071, 4909.656324057281, 4940.2342636891335, 4979.502049794992], "value": 4642.090359374308, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.4837122404224, 577.6851615869351, 577.6938222741945, 588.961717488363, 632.7532262417656, 35839.64160358399, 39602.40596391049, 39608.405873911914, 39609.20781584366, 39910.40134397983, 39299.21401571974, 39551.40672889902, 39582.8020859896, 39649.801750991275, 39770.204595908064, 7664.118626357957, 7774.339181169607, 7831.2560306770765, 7837.647305871221, 7857.8035549111155, 7827.491213071161, 7883.960580197091, 7925.524468531907, 7949.841003179933, 7970.163132871023, 7932.524048557105, 7953.562554059525, 7970.840583188333, 7985.840283194332, 8011.118776934532, 7849.68601255949, 7903.0, 7949.0858551266765, 7965.64154613038, 7968.641411136513, 7873.291403773688, 7887.487313324616, 7901.920980790176, 7922.841543169105, 7924.960375198145, 37634.62365376366, 37705.0, 37853.62146378528, 37893.62106378929, 37925.62074379248, 2905.956410653842, 2931.736143747073, 3041.574179614856, 3064.6628870824193, 3207.5349074384085, 29681.70318296811, 29695.0, 30027.549586756217, 30311.848440757876, 31213.375732485223, 3372.5109859070544, 3430.9313813723834, 3442.913927151816, 3460.463628137643, 3464.3937310970477, 253948.0, 254051.0, 254646.0, 257354.0, 258528.9999999981, 31267.68732312693, 32457.188570285933, 51850.48149518532, 52394.0, 52479.212811807854, 33653.495197572054, 33756.49365259523, 33819.0, 33870.49194262088, 33900.49149262763, 12368.628941131781, 12500.062495312888, 12537.498500059895, 12578.433970471351, 12621.0, 10180.949095254624, 10182.23633227511, 10250.897491025144, 10285.382877027403, 10296.536655850505, 7850.8429831403055, 7854.450188486751, 7891.526508409399, 7935.603219838985, 7977.60111994398, 3053.450378931769, 3055.5569442430724, 3069.048594935577, 3094.798838075518, 3117.6258848938273, 893.1470445724318, 898.4654130792168, 956.8803899512561, 957.066859811692, 970.1753509516855, 27942.86028569844, 28726.569101463494, 29113.85443072771, 29158.09864401703, 29447.0, 884.8672699095188, 938.1462868789505, 951.8762560867043, 958.520739630185, 959.7600599850037, 14666.120032798066, 14778.852211477963, 14948.626284342978, 15117.622059448382, 15263.542093737206, 398437.0, 402254.0, 404121.0, 404830.0, 405412.0, 50633.746831265606, 50704.0, 50785.42931136215, 50927.0, 51077.0, 1192.0940085535055, 1195.1872726545857, 1202.3507306054807, 1206.70702287569, 1246.7506498700295, 25165.87417062903, 27707.307317317227, 27727.722722772512, 27827.16518504448, 28093.0, 42735.3589696161, 43075.35386969135, 43658.78170609254, 43763.0, 43772.56227437685, 357742.0, 360204.0, 360334.0, 360895.0, 361110.0, 25367.492650147262, 25499.87250063738, 25741.099061532757, 25769.742302576735, 25810.61284080778, 40027.59972400355, 40259.0, 40482.39276410797, 40652.1869562613, 43312.566874330856, 34941.825290873385, 38564.6143538561, 38815.0, 39247.41128883126, 39599.0, 38254.0, 38301.808490957366, 38900.41649375318, 39403.21193576055, 39616.80191599023, 36136.27727445489, 36615.63384366122, 37296.25407491889, 37471.62528374681, 40371.192576147725, 31116.844415778683, 34062.829685851415, 34082.675797727556, 34300.31399372048, 34725.30549389048, 26199.738002620492, 26378.0, 26405.735942640327, 26597.601035984088, 26846.59730104011], "value": 16594.78926626325, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.1231605726543, 374.2683054628202, 376.1442717816966, 378.45691432793933, 391.27028092607276, 16107.194640267984, 17793.822061779363, 17961.191746371413, 18005.549861253476, 18162.909185454086, 16350.83649163511, 16798.0, 16963.900795322224, 17060.914695426505, 17088.145592720375, 5174.042802081608, 5351.197320401951, 5359.812406565771, 5363.168708850135, 5366.141417373221, 3803.2773772983182, 5320.733963301839, 5964.582479226434, 6266.122742816009, 6270.937290627081, 6245.0320200369015, 6313.77901773438, 6322.873542529147, 6334.588251763644, 6350.0, 6161.19904412428, 6238.4697300729495, 6256.249250090018, 6299.65351905645, 6300.24397072352, 5443.2107344435235, 5472.972635136839, 5473.28847249859, 5477.75350109246, 5498.752556134984, 20975.5804883903, 20993.16027358919, 21351.466213344636, 21665.133394664354, 21685.566288674137, 1908.9809101909082, 1945.066368143285, 2067.9689804652944, 2535.1760677779794, 2558.040734724478, 13813.0, 14115.717685646332, 14130.71738565223, 14319.0, 14410.207438590873, 1817.9091045447808, 1839.1815642039298, 1840.6134711710422, 1840.723891416285, 1843.317972350239, 67478.66260668714, 67634.66182669056, 67650.66174669145, 67656.0, 68205.31794682039, 9470.90529094714, 9502.572384242725, 9759.804803903882, 9929.30494865367, 10056.195504359634, 13249.536266230829, 13266.734665306833, 13288.402021909038, 13433.529826456028, 13465.596032119052, 6939.028536004963, 6939.340762627542, 7004.789856304319, 7162.713491460283, 7206.06321178254, 6384.170057892445, 6433.228012638419, 6516.902246466307, 6553.606783593, 6559.868802623921, 6086.0, 6093.26880774301, 6104.877902441926, 6174.197354343996, 6237.688115594202, 1626.487656388234, 1716.8111507734138, 1798.4245041586828, 1799.9910000450177, 1806.8102849200907, 809.8218391953761, 885.8892638420198, 897.9865302020474, 918.8024574716468, 939.5020639061308, 17205.22576484036, 17372.739408908878, 17656.55858603545, 18052.54868628295, 18155.273789048555, 860.4278155026963, 869.5261082709939, 892.3396686451979, 909.2771246858763, 919.3013309884536, 9810.509474526245, 10274.691759247235, 10307.536160872778, 10334.483275836179, 10419.635312764018, 351227.43862806755, 353142.0, 354886.0, 355577.0, 359097.0, 64353.356466435675, 67695.3230467689, 68640.0, 69196.30803691898, 71099.64450177716, 906.6645341223658, 920.9171174594319, 940.1115945431502, 940.5438362394233, 942.1755963531909, 15227.771583426478, 15728.134952577719, 15815.0, 15933.601659958595, 16151.353945842035, 34613.0, 35129.0, 35357.11607209737, 35557.28885422329, 36025.0993725159, 43535.0, 46515.53484465247, 46732.53267467282, 46753.76623116863, 46913.0, 7715.704808546339, 7908.169642187488, 7912.802179945547, 7925.128235893932, 7947.483413578099, 11716.414179291172, 11780.410979451164, 12109.878901211228, 12171.817422738843, 12381.071419643742, 9923.156531694598, 10167.237457190593, 10423.68728938133, 10721.249512534048, 10911.945440273066, 10365.06714395708, 10586.947065264625, 10600.893991060299, 10616.681499555025, 10663.466826658481, 10274.845877311696, 10435.16518678519, 10522.21083418762, 10565.63020294286, 10573.682789516326, 7693.846123077619, 7731.8840217395655, 7736.071671399243, 7796.961015194887, 7863.017122859643, 9994.650187243411, 10233.590656373959, 10285.43430111351, 10386.480675966322, 10405.739856503345], "value": 8488.8063207175, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.4364810427726, 1393.2754967416943, 1508.8189417269923, 1699.677061358341, 1713.0578181999897, 6919.100516932805, 7520.88718669219, 7595.46831721779, 8195.672173113076, 8210.548419836914, 7658.463907526475, 7883.724069657549, 7933.76198714038, 7934.127246002935, 7934.3255823255095, 2191.7917797809223, 2260.785225403584, 2262.095161935231, 2263.196565219348, 2271.1029143488313, 2188.857724247927, 2211.402921211272, 2248.15694114707, 2252.0653928619686, 2252.853564518301, 2210.8452408331423, 2217.157480157538, 2220.622494175994, 2226.1874415838183, 2275.2946586558137, 2155.3103007037753, 2168.620491414004, 2186.431527802767, 2187.0, 2197.165077270635, 2142.1645558232303, 2155.6550951847785, 2162.167565487299, 2165.112303955371, 2174.4889950861534, 7879.763607091796, 7933.801654958615, 8003.719869804587, 8021.19788021199, 8027.478213916077, 4445.955540444619, 4548.067646132568, 4559.886002849922, 4564.5435456454425, 4587.885302867422, 2823.688045924608, 2961.1116665000627, 2961.585378047075, 2963.955540666892, 2979.19561718337, 914.5564401265381, 940.47333493244, 956.1442508954516, 963.2967933408581, 973.3575839945672, 10611.57553697859, 10767.515461804238, 10799.460026998619, 10808.02727754506, 10838.458077096193, 4034.5561988181275, 4111.753294802322, 4282.0, 4286.807093680792, 4324.2648749712625, 9191.540422978824, 9231.261499080058, 9250.074992500697, 9254.676086336945, 9297.953510232406, 4615.30770384445, 4634.930476042862, 4652.581267685924, 4656.0920620479355, 4673.485916549177, 3544.91137721559, 4053.61490658387, 4195.790210489463, 4217.91564168721, 4234.026173980002, 3664.13892735207, 3687.7787332759585, 3707.1844194277214, 3765.9058523537133, 3821.6942644588366, 1178.5403692559908, 1204.27141579345, 1205.1804772754435, 1213.3690480949856, 1221.773971815217, 776.3944123583501, 784.2040329066002, 816.432579357341, 820.4953953318666, 832.1221111727065, 5132.0, 5132.692038477703, 5172.663776854568, 5203.271541984125, 5333.759980800874, 415.8586080732505, 416.1261351162595, 431.72153960695175, 435.34480606686736, 435.9891002724957, 3586.6413358664445, 3589.6948759355223, 3632.400653892078, 3652.8721494747556, 3696.963030369716, 9573.377730447637, 9852.753681157885, 9919.107280344804, 9957.55191016406, 9977.750556236007, 9783.804323913482, 9823.459709715891, 9852.162566181954, 9853.704388868346, 9869.555869985868, 7038.92961070393, 7408.777736667908, 7427.257274272638, 7428.888566671612, 7450.478466507292, 5278.788848446019, 5294.8941021180135, 5345.759440825094, 5361.731913404236, 5444.183372493999, 8917.509536975529, 8926.776830579287, 9062.773430664287, 9071.954640226757, 9073.727788166365, 8967.417117887317, 8992.595333210153, 9129.5891684873, 9363.906360936304, 9388.95305523468, 5996.102533353355, 6648.102506161799, 6837.35045170708, 6864.897026544506, 6987.965060174666, 7655.46411751172, 7690.846183076419, 7707.34487568563, 7725.0, 7767.223277672414, 6914.27400123, 7037.190723066913, 7042.260562640849, 7056.964715176391, 7208.819779505554, 6748.831279218059, 6818.215905170969, 6851.246362899978, 6980.511364204457, 7048.718051277891, 5788.392218817132, 5973.074173503114, 6012.218411606463, 6050.30421501533, 6137.6931153441255, 4363.105563359567, 4454.7549884756645, 4497.0, 4497.392851964943, 4597.402337696078, 4427.358033085249, 4537.682362234612, 4560.315952607136, 4566.520515345974, 4582.03777206777], "value": 4094.3591533763765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.85307346326834, 295.69986463739303, 298.99850500747493, 312.06691990947076, 312.2973310052382, 4939.863186876332, 5069.974650126745, 5071.746412679365, 5109.74451277436, 5128.871778205546, 4893.651047497204, 5002.649814512985, 5039.244113382985, 5039.496050394959, 5074.695518268897, 3918.8439410373867, 3953.4267531207956, 3962.9207415851665, 3968.7817170055637, 3970.1464185200175, 3885.32006898793, 3986.2824691555506, 3993.960060399402, 4002.919941601166, 4007.5391329996987, 3901.453796468497, 3932.1742434088733, 3940.8374529513717, 3964.405339199129, 3967.4643923070303, 3907.609239076098, 3919.451276821247, 3929.4302326162547, 3935.6654684351865, 3971.9007024824323, 3296.9449776071665, 3399.5721796845382, 3407.8807241746667, 3432.6052503961864, 3474.704650104744, 4918.8278410255825, 4928.359313289286, 4946.851594452172, 4978.402591688984, 4979.626528010377, 4412.6690498212765, 4414.624756895668, 4444.59995101542, 4461.442319710036, 4470.552944705536, 5136.691798492103, 5291.126964050927, 5299.364076310829, 5360.597955153379, 5365.382980957162, 3695.316366472211, 3695.6858667013335, 3706.4810926470313, 3714.7028237741188, 3717.3680474319162, 5514.6139770216105, 5541.833744987657, 5562.721863906789, 5567.777288908439, 5576.776928922838, 3666.999488348764, 3811.866584669523, 3817.217470418613, 3829.636184562518, 3844.3656796628243, 3868.4197370394104, 3874.2251549690177, 3895.9805200973815, 3899.805009749501, 3905.941410878839, 4466.508684044752, 4479.260921947842, 4479.5744404282195, 4480.238359478896, 4490.842820501267, 5173.068847607392, 5338.3593968724, 5365.356157261153, 5369.060414427538, 5401.838604700009, 1327.621627836062, 1348.3190988550718, 1348.4606157536869, 1349.7165595224917, 1358.2325985817981, 840.474703310431, 843.0010437631427, 857.3912522109248, 863.330918538138, 872.5244741615835, 4160.91678166441, 4188.958110418917, 4192.798780640127, 4195.223883581486, 4218.8523401680795, 4882.384369179781, 4882.851545320048, 4882.902341953141, 4888.926666100011, 4899.804007839718, 4176.394422808676, 4187.623113919762, 4191.7275377100395, 4237.279662457389, 4258.063226090318, 2520.7731304182344, 2595.8053146014126, 2613.4119823040046, 2621.921342359732, 2627.238100950741, 4559.680822342404, 4571.748553829505, 4612.561806628365, 4618.422697162855, 4635.397398338195, 4915.852524424273, 4939.827106051271, 4971.229459433794, 5008.398992120969, 5015.247712843103, 4300.548442413564, 4676.438827340673, 4681.976590117028, 4694.507076756891, 4695.826043489128, 4918.385201849769, 4924.310596516419, 4944.184209605375, 4952.2819191217795, 4971.9005619886675, 4810.725157833247, 4821.841693690638, 4832.782524786463, 4839.564439200489, 4861.732604706775, 4883.36516252899, 5212.8010557571215, 5232.816851410183, 5244.134717771525, 5244.318238628954, 3635.781853088823, 3743.73793834429, 3849.0954625663508, 3856.1323702166787, 3859.208862183302, 5468.1681636652165, 5468.726563671721, 5488.643238189665, 5489.094299440548, 5516.91724624139, 5347.732613369239, 5355.169948657965, 5383.219433182245, 5410.864728381822, 5416.945830541802, 5108.642395032312, 5326.414094449685, 5334.333208348957, 5338.2526446298325, 5353.2773075634295, 5290.386432138234, 5290.444503327095, 5319.361676598833, 5321.893562128813, 5332.30680011596, 5163.535281824654, 5366.221897824872, 5431.728413579384, 5431.995080910045, 5432.239486471976, 5242.606804489602, 5259.447757985509, 5274.129768588294, 5287.444818294178, 5298.70857102863], "value": 3881.8685800752855, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.2915984179618, 607.328901563772, 607.5777334752346, 637.964911929844, 691.0113757996664, 12348.259104453728, 13144.539941102063, 13242.006849486292, 13278.800817987738, 13357.666058348546, 13504.594862154152, 13966.720665586683, 14030.649233769162, 14062.929685351584, 14109.223992680398, 619.2445216835454, 756.6595032235489, 768.7271018788333, 787.7164220880478, 791.4618059719388, 782.026377160436, 787.3819052044147, 793.1394437035823, 795.0578564401175, 795.1372760554776, 828.1883753921161, 831.2934006094802, 832.4006715165071, 833.3999520345342, 833.8499070167368, 823.983520329593, 824.2787560884226, 825.5129473610568, 826.499967519648, 828.2628460669979, 603.0, 603.4629180029777, 603.9516838652942, 605.1225722702055, 606.2845841906549, 12952.0, 13010.674733131653, 13111.344432778324, 13153.0, 13170.60488185356, 12903.419346129353, 13312.600621981355, 13316.800247996287, 13434.0, 13535.255560944144, 10334.7416314592, 10384.32501887375, 10433.373997560095, 10614.893851061468, 10841.13270938323, 3282.5240340150785, 3312.790831346565, 3342.2312868040485, 3343.6823501767294, 3349.916252093693, 65008.0, 65153.0, 66012.66993665049, 67170.32829671739, 67417.0, 10640.89359106399, 10650.360978341325, 10691.30506517074, 10710.839337409945, 10822.512986915608, 17205.827941720672, 17494.562635933948, 17720.734188987175, 17757.200925958365, 18889.338873139375, 6024.457798798129, 6102.938970610326, 6119.051547010221, 6138.938610613926, 6266.216722909637, 3642.18050938542, 3644.835982380799, 3654.14127679995, 3662.7436079474182, 3750.6436888496096, 3045.9390812183633, 3161.9525707114412, 3164.2722173900133, 3167.6990685884803, 3173.666764989689, 491.5035813828059, 509.28699820251944, 511.289307862072, 511.4450820859335, 513.5429467773685, 506.7972810875679, 540.9404965453797, 545.3510322715955, 548.1886807524885, 550.6998685716214, 7767.300942915052, 7948.960255198687, 8085.676572937135, 8396.110875053064, 8403.991521017395, 498.35960790384183, 572.6878851026117, 577.5985689945447, 579.4495229531962, 582.8368056944063, 3669.229461813049, 3773.735838491279, 3783.356829339019, 3846.8653597123966, 3966.781826999485, 82208.58895705602, 83344.58327708444, 84518.57740711258, 108455.0, 112164.4391778036, 49812.50187498151, 82957.0, 84188.57905710432, 85436.0, 87386.0, 46412.30381544212, 47576.762116189195, 74154.25845741581, 75112.62443687856, 76222.23777762262, 8616.569171541272, 8714.302855771397, 8762.912370876209, 8801.867971980297, 8908.821823563621, 42367.0, 42487.5751242496, 42655.14689706126, 42684.57315426806, 42692.359614605186, 64165.67917160571, 65449.672751637845, 65614.34385656082, 65736.67131664311, 66158.0, 11427.0, 11488.655340339803, 11508.079353651856, 11638.127140464669, 11696.415179240834, 13179.94560435182, 13244.20534767917, 13402.731945361233, 13711.314434278445, 14048.227347495576, 11627.360495172508, 11727.0, 12170.817437738264, 12302.569410070604, 12324.137310388187, 11711.941440293085, 11751.529938802694, 11768.35274059935, 11841.64475065715, 12183.025357971519, 11507.942460287644, 11540.480678369326, 11832.112591555495, 12027.45876435545, 12603.621891343275, 10188.847167292644, 10233.385996840214, 10271.84592231132, 10294.279400441897, 10430.478476076318, 9948.502574871083, 10215.336003159771, 10263.640772573222, 10324.122449591869, 10430.0], "value": 6541.142791558557, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 110.0, 114.0, 114.0, 116.0, 122.0, 115.0, 114.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 146.0, 179.0, 125.0, 155.0, 146.0, 125.0, 194.0, 124.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 167.0, 170.0, 162.0, 168.0, 164.0, 165.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 145.0, 78.0, 76.0, 76.0, 76.0, 165.0, 77.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 142.0, 85.0, 87.0, 85.0, 140.0, 87.0, 86.0, 136.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 119.0, 117.0, 117.0, 118.0, 118.0, 120.0, 119.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 150.0, 148.0, 148.0, 151.0, 149.0, 150.0, 149.0, 148.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 66.0, 66.0, 64.0, 66.0, 65.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 66.0, 64.0, 64.0, 64.0, 65.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 82.0, 78.0, 80.0, 79.0, 85.0, 80.0, 84.0, 78.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 141.0, 137.0, 129.0, 134.0, 143.0, 131.0, 131.0, 163.0, 130.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 166.0, 174.0, 170.0, 164.0, 165.0, 170.0, 168.0, 169.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 66.0, 69.0, 67.0, 68.0, 68.0, 67.0, 68.0], "value": 67.5, "unit": "score"}]}]} 09:01:34 INFO - Return code: 0 09:01:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:01:34 ERROR - # TBPL SUCCESS # 09:01:34 INFO - Running post-action listener: _resource_record_post_action 09:01:34 INFO - ##### 09:01:34 INFO - ##### Finished run-tests step (success) 09:01:34 INFO - ##### 09:01:34 INFO - Running post-run listener: _resource_record_post_run 09:01:34 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 539787264; Read time: 0; Write time: 381128 09:01:34 INFO - TinderboxPrint: CPU usage
13.3% 09:01:34 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:01:34 INFO - TinderboxPrint: I/O write bytes / time
539,787,264 / 381,128 09:01:34 INFO - TinderboxPrint: CPU idle
8,275.5 (86.6%) 09:01:34 INFO - TinderboxPrint: CPU user
1,222.6 (12.8%) 09:01:34 INFO - TinderboxPrint: Swap in / out
0 / 0 09:01:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 245960704; Read time: 0; Write time: 215604 09:01:34 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 282943488; Read time: 0; Write time: 162688 09:01:34 INFO - Running post-run listener: _upload_blobber_files 09:01:34 INFO - Blob upload gear active. 09:01:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:01:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:01:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:01:35 INFO - (blobuploader) - INFO - Open directory for files ... 09:01:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:01:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:01:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:39 INFO - (blobuploader) - INFO - Done attempting. 09:01:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:01:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:01:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:39 INFO - (blobuploader) - INFO - Done attempting. 09:01:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:01:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:01:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:41 INFO - (blobuploader) - INFO - Done attempting. 09:01:41 INFO - (blobuploader) - INFO - Iteration through files over. 09:01:41 INFO - Return code: 0 09:01:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:01:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:01:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ba6b2d7825f183d648bf813293303e3e09917c2d117f7e2f59d9a1032ee9873db4663d8c2ae7844d5e2a47c47783a1cbcc86ad47ea252c74753fa8778a57d72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8bc8b9921583a53ba67e6933728a7d43d62021c94c5f19a815c109f98591cd09842349bbd1c00170b76fc207fc4438bffead1bb3083eb4ac549acb7ff19d23bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2ab1e152f5da91877de0d612443283e77129f4110f9c6f3e5a9f89feffc794365ef8f2c1eae5a39adbb979978b3b6d0350568baa1c98535132c9936b74165a7"} 09:01:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:01:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:01:41 INFO - Contents: 09:01:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ba6b2d7825f183d648bf813293303e3e09917c2d117f7e2f59d9a1032ee9873db4663d8c2ae7844d5e2a47c47783a1cbcc86ad47ea252c74753fa8778a57d72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8bc8b9921583a53ba67e6933728a7d43d62021c94c5f19a815c109f98591cd09842349bbd1c00170b76fc207fc4438bffead1bb3083eb4ac549acb7ff19d23bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2ab1e152f5da91877de0d612443283e77129f4110f9c6f3e5a9f89feffc794365ef8f2c1eae5a39adbb979978b3b6d0350568baa1c98535132c9936b74165a7"} 09:01:41 INFO - Running post-run listener: copy_logs_to_upload_dir 09:01:41 INFO - Copying logs to upload dir... 09:01:41 INFO - mkdir: /builds/slave/test/build/upload/logs 09:01:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.434565 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-05 09:01:41.067290) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 09:01:41.070397) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438 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-Non-PGO/sha512/4ba6b2d7825f183d648bf813293303e3e09917c2d117f7e2f59d9a1032ee9873db4663d8c2ae7844d5e2a47c47783a1cbcc86ad47ea252c74753fa8778a57d72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8bc8b9921583a53ba67e6933728a7d43d62021c94c5f19a815c109f98591cd09842349bbd1c00170b76fc207fc4438bffead1bb3083eb4ac549acb7ff19d23bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2ab1e152f5da91877de0d612443283e77129f4110f9c6f3e5a9f89feffc794365ef8f2c1eae5a39adbb979978b3b6d0350568baa1c98535132c9936b74165a7"} build_url:https://queue.taskcluster.net/v1/task/M0jN7oznRfCHtV_2u3-18g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/M0jN7oznRfCHtV_2u3-18g/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-Non-PGO/sha512/4ba6b2d7825f183d648bf813293303e3e09917c2d117f7e2f59d9a1032ee9873db4663d8c2ae7844d5e2a47c47783a1cbcc86ad47ea252c74753fa8778a57d72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8bc8b9921583a53ba67e6933728a7d43d62021c94c5f19a815c109f98591cd09842349bbd1c00170b76fc207fc4438bffead1bb3083eb4ac549acb7ff19d23bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2ab1e152f5da91877de0d612443283e77129f4110f9c6f3e5a9f89feffc794365ef8f2c1eae5a39adbb979978b3b6d0350568baa1c98535132c9936b74165a7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 09:01:41.095552) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:01:41.095841) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467733262.972843-283922438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:01:41.177981) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 09:01:41.178296) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 09:01:41.178572) ========= ========= Total master_lag: 0.17 =========