builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1467947252.88 results: success (0) buildid: 20160707183001 builduid: 36912eddb439489281feac71fdad589d revision: be469964755162110602a8690cc9e7034fd3981b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 20:07:32.879543) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 20:07:32.880000) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 20:07:32.880327) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 20:07:32.913675) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:07:32.913936) ========= 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=7de08804244eb36560b44971000001c3-1467946881.67455-1017688133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 20:07:33-- 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% 11.4M=0.001s 2016-07-07 20:07:33 (11.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099540 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:07:33.030499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:07:33.030851) ========= 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=7de08804244eb36560b44971000001c3-1467946881.67455-1017688133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020436 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:07:33.088537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:07:33.088876) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev be469964755162110602a8690cc9e7034fd3981b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev be469964755162110602a8690cc9e7034fd3981b --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=7de08804244eb36560b44971000001c3-1467946881.67455-1017688133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 20:07:33,472 truncating revision to first 12 chars 2016-07-07 20:07:33,472 Setting DEBUG logging. 2016-07-07 20:07:33,472 attempt 1/10 2016-07-07 20:07:33,472 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/be4699647551?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 20:07:33,796 unpacking tar archive at: autoland-be4699647551/testing/mozharness/ program finished with exit code 0 elapsedTime=0.746331 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:07:33.848845) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 20:07:33.849159) ========= script_repo_revision: be469964755162110602a8690cc9e7034fd3981b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 20:07:33.849533) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 20:07:33.849863) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 20:07:33.858971) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-07 20:07:33.859316) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=7de08804244eb36560b44971000001c3-1467946881.67455-1017688133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:07:34 INFO - MultiFileLogger online at 20160707 20:07:34 in /builds/slave/test 20:07:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 20:07:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:07:34 INFO - {'append_to_log': False, 20:07:34 INFO - 'base_work_dir': '/builds/slave/test', 20:07:34 INFO - 'blob_upload_branch': 'Autoland', 20:07:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:07:34 INFO - 'branch': 'Autoland', 20:07:34 INFO - 'buildbot_json_path': 'buildprops.json', 20:07:34 INFO - 'config_files': ('talos/linux_config.py',), 20:07:34 INFO - 'default_actions': ('clobber', 20:07:34 INFO - 'read-buildbot-config', 20:07:34 INFO - 'download-and-extract', 20:07:34 INFO - 'populate-webroot', 20:07:34 INFO - 'create-virtualenv', 20:07:34 INFO - 'install', 20:07:34 INFO - 'run-tests'), 20:07:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:07:34 INFO - 'download_minidump_stackwalk': True, 20:07:34 INFO - 'download_symbols': 'ondemand', 20:07:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:07:34 INFO - 'tooltool.py': '/tools/tooltool.py', 20:07:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:07:34 INFO - '/tools/misc-python/virtualenv.py')}, 20:07:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:07:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:07:34 INFO - 'installer_path': 'installer.exe', 20:07:34 INFO - 'log_level': 'info', 20:07:34 INFO - 'log_name': 'talos', 20:07:34 INFO - 'log_to_console': True, 20:07:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:07:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:07:34 INFO - 'opt_config_files': (), 20:07:34 INFO - 'pip_index': False, 20:07:34 INFO - 'sps_profile': False, 20:07:34 INFO - 'sps_profile_interval': 0, 20:07:34 INFO - 'suite': 'dromaeojs-e10s', 20:07:34 INFO - 'system_bits': '32', 20:07:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:07:34 INFO - 'title': 'talos-linux64-ix-003', 20:07:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:07:34 INFO - 'use_talos_json': True, 20:07:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:07:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:07:34 INFO - 'work_dir': 'build'} 20:07:34 INFO - ##### 20:07:34 INFO - ##### Running clobber step. 20:07:34 INFO - ##### 20:07:34 INFO - Running pre-action listener: _resource_record_pre_action 20:07:34 INFO - Running main action method: clobber 20:07:34 INFO - rmtree: /builds/slave/test/build 20:07:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:07:34 INFO - Running post-action listener: _resource_record_post_action 20:07:34 INFO - ##### 20:07:34 INFO - ##### Finished clobber step (success) 20:07:34 INFO - ##### 20:07:34 INFO - ##### 20:07:34 INFO - ##### Running read-buildbot-config step. 20:07:34 INFO - ##### 20:07:34 INFO - Running pre-action listener: _resource_record_pre_action 20:07:34 INFO - Running main action method: read_buildbot_config 20:07:34 INFO - Using buildbot properties: 20:07:34 INFO - { 20:07:34 INFO - "project": "", 20:07:34 INFO - "product": "firefox", 20:07:34 INFO - "script_repo_revision": "production", 20:07:34 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 20:07:34 INFO - "repository": "", 20:07:34 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 20:07:34 INFO - "buildid": "20160707183001", 20:07:34 INFO - "pgo_build": "True", 20:07:34 INFO - "basedir": "/builds/slave/test", 20:07:34 INFO - "buildnumber": 17, 20:07:34 INFO - "slavename": "talos-linux64-ix-003", 20:07:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:07:34 INFO - "platform": "ubuntu64_hw", 20:07:34 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 20:07:34 INFO - "branch": "autoland", 20:07:34 INFO - "repo_path": "integration/autoland", 20:07:34 INFO - "revision": "be469964755162110602a8690cc9e7034fd3981b", 20:07:34 INFO - "stage_platform": "linux64-pgo", 20:07:34 INFO - "builduid": "36912eddb439489281feac71fdad589d", 20:07:34 INFO - "slavebuilddir": "test" 20:07:34 INFO - } 20:07:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:07:34 INFO - Running post-action listener: _resource_record_post_action 20:07:34 INFO - ##### 20:07:34 INFO - ##### Finished read-buildbot-config step (success) 20:07:34 INFO - ##### 20:07:34 INFO - ##### 20:07:34 INFO - ##### Running download-and-extract step. 20:07:34 INFO - ##### 20:07:34 INFO - Running pre-action listener: _resource_record_pre_action 20:07:34 INFO - Running main action method: download_and_extract 20:07:34 INFO - mkdir: /builds/slave/test/build/tests 20:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:07:34 INFO - https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:07:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:07:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:07:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/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 20:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/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 20:07:35 INFO - Downloaded 1361 bytes. 20:07:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:07:35 INFO - Using the following test package requirements: 20:07:35 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:07:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:07:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:07:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:07:35 INFO - u'jsshell-linux-x86_64.zip'], 20:07:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:07:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:07:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:07:35 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:07:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:07:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:07:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:07: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')]} 20:07:35 INFO - https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/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 20:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/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 20:07:36 INFO - Downloaded 24304293 bytes. 20:07:36 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'] 20:07:36 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 20:07:37 INFO - Return code: 0 20:07:37 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 20:07:37 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')]} 20:07:37 INFO - https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:07:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:07:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:07:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/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 20:07:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/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 20:07:40 INFO - Downloaded 24304293 bytes. 20:07:40 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'] 20:07:40 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 20:07:41 INFO - Return code: 0 20:07:41 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')]} 20:07:41 INFO - https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/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 20:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/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 20:07:42 INFO - Downloaded 14403333 bytes. 20:07:42 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'] 20:07:42 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 20:07:43 INFO - Return code: 0 20:07:43 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')]} 20:07:43 INFO - https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:07:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:07:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:07:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/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 20:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/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 20:07:44 INFO - Downloaded 60463415 bytes. 20:07:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:07:44 INFO - mkdir: /builds/slave/test/properties 20:07:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:07:44 INFO - Writing to file /builds/slave/test/properties/build_url 20:07:44 INFO - Contents: 20:07:44 INFO - build_url:https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:07:45 INFO - Running post-action listener: _resource_record_post_action 20:07:45 INFO - Running post-action listener: set_extra_try_arguments 20:07:45 INFO - ##### 20:07:45 INFO - ##### Finished download-and-extract step (success) 20:07:45 INFO - ##### 20:07:45 INFO - ##### 20:07:45 INFO - ##### Running populate-webroot step. 20:07:45 INFO - ##### 20:07:45 INFO - Running pre-action listener: _resource_record_pre_action 20:07:45 INFO - Running main action method: populate_webroot 20:07:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:07:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:07:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:07:45 INFO - '--tppagecycles', 20:07:45 INFO - '7'], 20:07:45 INFO - 'tests': ['tsvgm']}}, 20:07:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:07:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:07:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:07:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:07:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:07:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:07:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:45 INFO - 'talos_options': ['--disable-e10s'], 20:07:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:07:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:07:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:45 INFO - 'talos_options': ['--disable-e10s'], 20:07:45 INFO - 'tests': ['damp', 'tps']}, 20:07:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:45 INFO - 'tests': ['damp', 'tps']}, 20:07:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:07:45 INFO - 'tests': ['dromaeo_dom']}, 20:07:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:07:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:07:45 INFO - 'tests': ['basic_compositor_video']}, 20:07:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:07:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:07:45 INFO - 'tests': ['a11yr', 20:07:45 INFO - 'ts_paint', 20:07:45 INFO - 'tpaint', 20:07:45 INFO - 'sessionrestore', 20:07:45 INFO - 'sessionrestore_no_auto_restore', 20:07:45 INFO - 'tabpaint']}, 20:07:45 INFO - 'other-e10s': {'tests': ['a11yr', 20:07:45 INFO - 'ts_paint', 20:07:45 INFO - 'tpaint', 20:07:45 INFO - 'sessionrestore', 20:07:45 INFO - 'sessionrestore_no_auto_restore', 20:07:45 INFO - 'tabpaint']}, 20:07:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:07:45 INFO - 'ts_paint', 20:07:45 INFO - 'tpaint', 20:07:45 INFO - 'sessionrestore', 20:07:45 INFO - 'sessionrestore_no_auto_restore', 20:07:45 INFO - 'tabpaint']}, 20:07:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:07:45 INFO - 'ts_paint', 20:07:45 INFO - 'tpaint', 20:07:45 INFO - 'sessionrestore', 20:07:45 INFO - 'sessionrestore_no_auto_restore', 20:07:45 INFO - 'tabpaint']}, 20:07:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:07:45 INFO - 'tests': ['a11yr', 20:07:45 INFO - 'ts_paint', 20:07:45 INFO - 'tpaint', 20:07:45 INFO - 'sessionrestore', 20:07:45 INFO - 'sessionrestore_no_auto_restore', 20:07:45 INFO - 'tabpaint']}, 20:07:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:07:45 INFO - 'tests': ['a11yr', 20:07:45 INFO - 'ts_paint', 20:07:45 INFO - 'tpaint', 20:07:45 INFO - 'sessionrestore', 20:07:45 INFO - 'sessionrestore_no_auto_restore', 20:07:45 INFO - 'tabpaint']}, 20:07:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:07:45 INFO - 'tests': ['tsvgx', 20:07:45 INFO - 'tsvgr_opacity', 20:07:45 INFO - 'tart', 20:07:45 INFO - 'tscrollx', 20:07:45 INFO - 'cart']}, 20:07:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:07:45 INFO - 'tsvgr_opacity', 20:07:45 INFO - 'tart', 20:07:45 INFO - 'tscrollx', 20:07:45 INFO - 'cart']}, 20:07:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:45 INFO - 'talos_options': ['--disable-e10s'], 20:07:45 INFO - 'tests': ['tp5o']}, 20:07:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:45 INFO - 'tests': ['tp5o']}, 20:07:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:45 INFO - 'talos_options': ['--disable-e10s', 20:07:45 INFO - '--xperf_path', 20:07:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:07:45 INFO - 'tests': ['tp5n']}, 20:07:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:07:45 INFO - 'talos_options': ['--xperf_path', 20:07:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:07:45 INFO - 'tests': ['tp5n']}}, 20:07:45 INFO - 'talos.zip': {'path': '', 20:07:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:07:45 INFO - Running post-action listener: _resource_record_post_action 20:07:45 INFO - ##### 20:07:45 INFO - ##### Finished populate-webroot step (success) 20:07:45 INFO - ##### 20:07:45 INFO - ##### 20:07:45 INFO - ##### Running create-virtualenv step. 20:07:45 INFO - ##### 20:07:45 INFO - Running pre-action listener: _resource_record_pre_action 20:07:45 INFO - Running main action method: create_virtualenv 20:07:45 INFO - Creating virtualenv /builds/slave/test/build/venv 20:07:45 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 20:07:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:07:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:07:45 INFO - Using real prefix '/usr' 20:07:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:07:46 INFO - Installing distribute.............................................................................................................................................................................................done. 20:07:48 INFO - Installing pip.................done. 20:07:48 INFO - Return code: 0 20:07:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe10030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf3b0>, '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 0x10d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0740>, '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': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', '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 20:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:07:48 INFO - Using env: {'DISPLAY': ':0', 20:07:48 INFO - 'HOME': '/home/cltbld', 20:07:48 INFO - 'LANG': 'en_US.UTF-8', 20:07:48 INFO - 'LANGUAGE': 'en_US:en', 20:07:48 INFO - 'LOGNAME': 'cltbld', 20:07:48 INFO - 'MAIL': '/var/mail/cltbld', 20:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:48 INFO - 'MOZ_NO_REMOTE': '1', 20:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:48 INFO - 'NO_EM_RESTART': '1', 20:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:48 INFO - 'PWD': '/builds/slave/test', 20:07:48 INFO - 'SHELL': '/bin/bash', 20:07:48 INFO - 'SHLVL': '1', 20:07:48 INFO - 'TERM': 'linux', 20:07:48 INFO - 'TMOUT': '86400', 20:07:48 INFO - 'USER': 'cltbld', 20:07:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', 20:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:48 INFO - '_': '/tools/buildbot/bin/python'} 20:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:48 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 20:07:48 INFO - Cleaning up... 20:07:48 INFO - Return code: 0 20:07:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe10030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf3b0>, '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 0x10d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0740>, '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': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', '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 20:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:07:48 INFO - Using env: {'DISPLAY': ':0', 20:07:48 INFO - 'HOME': '/home/cltbld', 20:07:48 INFO - 'LANG': 'en_US.UTF-8', 20:07:48 INFO - 'LANGUAGE': 'en_US:en', 20:07:48 INFO - 'LOGNAME': 'cltbld', 20:07:48 INFO - 'MAIL': '/var/mail/cltbld', 20:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:48 INFO - 'MOZ_NO_REMOTE': '1', 20:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:48 INFO - 'NO_EM_RESTART': '1', 20:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:48 INFO - 'PWD': '/builds/slave/test', 20:07:48 INFO - 'SHELL': '/bin/bash', 20:07:48 INFO - 'SHLVL': '1', 20:07:48 INFO - 'TERM': 'linux', 20:07:48 INFO - 'TMOUT': '86400', 20:07:48 INFO - 'USER': 'cltbld', 20:07:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', 20:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:48 INFO - '_': '/tools/buildbot/bin/python'} 20:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:48 INFO - Downloading/unpacking psutil>=3.1.1 20:07:48 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 20:07:48 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 20:07:48 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 20:07:48 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 20:07:48 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 20:07:48 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 20:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:07:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:07:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:07:50 INFO - Installing collected packages: psutil 20:07:50 INFO - Running setup.py install for psutil 20:07:50 INFO - building 'psutil._psutil_linux' extension 20:07:50 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 20:07:50 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 20:07:50 INFO - building 'psutil._psutil_posix' extension 20:07:50 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 20:07:50 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 20:07:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:07:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:07:50 INFO - Successfully installed psutil 20:07:50 INFO - Cleaning up... 20:07:51 INFO - Return code: 0 20:07:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe10030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf3b0>, '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 0x10d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0740>, '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': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', '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 20:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:07:51 INFO - Using env: {'DISPLAY': ':0', 20:07:51 INFO - 'HOME': '/home/cltbld', 20:07:51 INFO - 'LANG': 'en_US.UTF-8', 20:07:51 INFO - 'LANGUAGE': 'en_US:en', 20:07:51 INFO - 'LOGNAME': 'cltbld', 20:07:51 INFO - 'MAIL': '/var/mail/cltbld', 20:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:51 INFO - 'MOZ_NO_REMOTE': '1', 20:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:51 INFO - 'NO_EM_RESTART': '1', 20:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:51 INFO - 'PWD': '/builds/slave/test', 20:07:51 INFO - 'SHELL': '/bin/bash', 20:07:51 INFO - 'SHLVL': '1', 20:07:51 INFO - 'TERM': 'linux', 20:07:51 INFO - 'TMOUT': '86400', 20:07:51 INFO - 'USER': 'cltbld', 20:07:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', 20:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:51 INFO - '_': '/tools/buildbot/bin/python'} 20:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:07:53 INFO - Installing collected packages: mozsystemmonitor 20:07:53 INFO - Running setup.py install for mozsystemmonitor 20:07:53 INFO - Successfully installed mozsystemmonitor 20:07:53 INFO - Cleaning up... 20:07:53 INFO - Return code: 0 20:07:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:53 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 0xe10030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf3b0>, '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 0x10d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0740>, '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': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', '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 20:07:53 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 20:07:53 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 20:07:53 INFO - Using env: {'DISPLAY': ':0', 20:07:53 INFO - 'HOME': '/home/cltbld', 20:07:53 INFO - 'LANG': 'en_US.UTF-8', 20:07:53 INFO - 'LANGUAGE': 'en_US:en', 20:07:53 INFO - 'LOGNAME': 'cltbld', 20:07:53 INFO - 'MAIL': '/var/mail/cltbld', 20:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:53 INFO - 'MOZ_NO_REMOTE': '1', 20:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:53 INFO - 'NO_EM_RESTART': '1', 20:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:53 INFO - 'PWD': '/builds/slave/test', 20:07:53 INFO - 'SHELL': '/bin/bash', 20:07:53 INFO - 'SHLVL': '1', 20:07:53 INFO - 'TERM': 'linux', 20:07:53 INFO - 'TMOUT': '86400', 20:07:53 INFO - 'USER': 'cltbld', 20:07:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', 20:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:53 INFO - '_': '/tools/buildbot/bin/python'} 20:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:53 INFO - Downloading/unpacking jsonschema==2.5.1 20:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:07:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:07:55 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 20:07:55 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 20:07:55 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 20:07:55 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 20:07:55 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 20:07:55 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 20:07:55 INFO - Downloading functools32-3.2.3-2.tar.gz 20:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:07:55 INFO - warning: no files found matching '*.txt' 20:07:55 INFO - no previously-included directories found matching 'build' 20:07:55 INFO - no previously-included directories found matching 'dist' 20:07:55 INFO - no previously-included directories found matching '.git*' 20:07:55 INFO - Installing collected packages: jsonschema, functools32 20:07:55 INFO - Running setup.py install for functools32 20:07:55 INFO - warning: no files found matching '*.txt' 20:07:55 INFO - no previously-included directories found matching 'build' 20:07:55 INFO - no previously-included directories found matching 'dist' 20:07:55 INFO - no previously-included directories found matching '.git*' 20:07:55 INFO - Successfully installed jsonschema functools32 20:07:55 INFO - Cleaning up... 20:07:55 INFO - Return code: 0 20:07:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:55 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 0xe10030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf3b0>, '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 0x10d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0740>, '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': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', '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 20:07:55 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 20:07:55 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 20:07:55 INFO - Using env: {'DISPLAY': ':0', 20:07:55 INFO - 'HOME': '/home/cltbld', 20:07:55 INFO - 'LANG': 'en_US.UTF-8', 20:07:55 INFO - 'LANGUAGE': 'en_US:en', 20:07:55 INFO - 'LOGNAME': 'cltbld', 20:07:55 INFO - 'MAIL': '/var/mail/cltbld', 20:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:55 INFO - 'MOZ_NO_REMOTE': '1', 20:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:55 INFO - 'NO_EM_RESTART': '1', 20:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:55 INFO - 'PWD': '/builds/slave/test', 20:07:55 INFO - 'SHELL': '/bin/bash', 20:07:55 INFO - 'SHLVL': '1', 20:07:55 INFO - 'TERM': 'linux', 20:07:55 INFO - 'TMOUT': '86400', 20:07:55 INFO - 'USER': 'cltbld', 20:07:55 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', 20:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:55 INFO - '_': '/tools/buildbot/bin/python'} 20:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:56 INFO - Downloading/unpacking blobuploader==1.2.4 20:07:56 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 20:07:56 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 20:07:56 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 20:07:56 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 20:07:56 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 20:07:56 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 20:07:58 INFO - Downloading blobuploader-1.2.4.tar.gz 20:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:07:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:07:58 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 20:07:58 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 20:07:58 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 20:07:58 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 20:07:58 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 20:07:58 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 20:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:07:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:07:58 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 20:07:58 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 20:07:58 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 20:07:58 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 20:07:58 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 20:07:58 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 20:07:58 INFO - Downloading docopt-0.6.1.tar.gz 20:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:07:58 INFO - Installing collected packages: blobuploader, requests, docopt 20:07:58 INFO - Running setup.py install for blobuploader 20:07:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:07:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:07:58 INFO - Running setup.py install for requests 20:07:59 INFO - Running setup.py install for docopt 20:07:59 INFO - Successfully installed blobuploader requests docopt 20:07:59 INFO - Cleaning up... 20:07:59 INFO - Return code: 0 20:07:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:59 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')]} 20:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:59 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')]} 20:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:59 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 0xe10030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf3b0>, '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 0x10d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0740>, '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': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', '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 20:07:59 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 20:07:59 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 20:07:59 INFO - Using env: {'DISPLAY': ':0', 20:07:59 INFO - 'HOME': '/home/cltbld', 20:07:59 INFO - 'LANG': 'en_US.UTF-8', 20:07:59 INFO - 'LANGUAGE': 'en_US:en', 20:07:59 INFO - 'LOGNAME': 'cltbld', 20:07:59 INFO - 'MAIL': '/var/mail/cltbld', 20:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:59 INFO - 'MOZ_NO_REMOTE': '1', 20:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:59 INFO - 'NO_EM_RESTART': '1', 20:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:59 INFO - 'PWD': '/builds/slave/test', 20:07:59 INFO - 'SHELL': '/bin/bash', 20:07:59 INFO - 'SHLVL': '1', 20:07:59 INFO - 'TERM': 'linux', 20:07:59 INFO - 'TMOUT': '86400', 20:07:59 INFO - 'USER': 'cltbld', 20:07:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', 20:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:59 INFO - '_': '/tools/buildbot/bin/python'} 20:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:07:59 INFO - Running setup.py (path:/tmp/pip-RwTboE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:07:59 INFO - Running setup.py (path:/tmp/pip-Tama1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:07:59 INFO - Running setup.py (path:/tmp/pip-Ooizom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:07:59 INFO - Running setup.py (path:/tmp/pip-z7gGNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:07:59 INFO - Running setup.py (path:/tmp/pip-EsPJ_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:07:59 INFO - Running setup.py (path:/tmp/pip-PefIov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:00 INFO - Running setup.py (path:/tmp/pip-Hw2DVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:00 INFO - Running setup.py (path:/tmp/pip-TbA29X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:00 INFO - Running setup.py (path:/tmp/pip-gWdzpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:00 INFO - Running setup.py (path:/tmp/pip-91qHAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:00 INFO - Running setup.py (path:/tmp/pip-7yYtDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:00 INFO - Running setup.py (path:/tmp/pip-Do6KAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:00 INFO - Running setup.py (path:/tmp/pip-tUx8fW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:00 INFO - Running setup.py (path:/tmp/pip-XkS3Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:00 INFO - Running setup.py (path:/tmp/pip-uS4FpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:00 INFO - Running setup.py (path:/tmp/pip-UyXsw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:00 INFO - Running setup.py (path:/tmp/pip-2H8kb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:08:00 INFO - Running setup.py install for manifestparser 20:08:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:08:00 INFO - Running setup.py install for mozcrash 20:08:01 INFO - Running setup.py install for mozdebug 20:08:01 INFO - Running setup.py install for mozdevice 20:08:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:08:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:08:01 INFO - Running setup.py install for mozfile 20:08:01 INFO - Running setup.py install for mozhttpd 20:08:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:08:01 INFO - Running setup.py install for mozinfo 20:08:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:08:01 INFO - Running setup.py install for mozInstall 20:08:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:08:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:08:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:08:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:08:01 INFO - Running setup.py install for mozleak 20:08:01 INFO - Running setup.py install for mozlog 20:08:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:08:01 INFO - Running setup.py install for moznetwork 20:08:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:08:01 INFO - Running setup.py install for mozprocess 20:08:02 INFO - Running setup.py install for mozprofile 20:08:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:08:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:08:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:08:02 INFO - Running setup.py install for mozrunner 20:08:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:08:02 INFO - Running setup.py install for mozscreenshot 20:08:02 INFO - Running setup.py install for moztest 20:08:02 INFO - Running setup.py install for mozversion 20:08:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:08:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:08:02 INFO - Cleaning up... 20:08:02 INFO - Return code: 0 20:08:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:02 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 0xe10030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf3b0>, '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 0x10d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0740>, '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': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', '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 20:08:02 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 20:08:02 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 20:08:02 INFO - Using env: {'DISPLAY': ':0', 20:08:02 INFO - 'HOME': '/home/cltbld', 20:08:02 INFO - 'LANG': 'en_US.UTF-8', 20:08:02 INFO - 'LANGUAGE': 'en_US:en', 20:08:02 INFO - 'LOGNAME': 'cltbld', 20:08:02 INFO - 'MAIL': '/var/mail/cltbld', 20:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:02 INFO - 'MOZ_NO_REMOTE': '1', 20:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:02 INFO - 'NO_EM_RESTART': '1', 20:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:02 INFO - 'PWD': '/builds/slave/test', 20:08:02 INFO - 'SHELL': '/bin/bash', 20:08:02 INFO - 'SHLVL': '1', 20:08:02 INFO - 'TERM': 'linux', 20:08:02 INFO - 'TMOUT': '86400', 20:08:02 INFO - 'USER': 'cltbld', 20:08:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', 20:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:02 INFO - '_': '/tools/buildbot/bin/python'} 20:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:02 INFO - Running setup.py (path:/tmp/pip-yvZjcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:02 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)) 20:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:02 INFO - Running setup.py (path:/tmp/pip-FJIXjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:02 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)) 20:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:02 INFO - Running setup.py (path:/tmp/pip-rY8yme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:03 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)) 20:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:03 INFO - Running setup.py (path:/tmp/pip-3sbGXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:03 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)) 20:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:03 INFO - Running setup.py (path:/tmp/pip-KmNWYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:03 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)) 20:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:03 INFO - Running setup.py (path:/tmp/pip-ZH8qYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:03 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)) 20:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:03 INFO - Running setup.py (path:/tmp/pip-mAUPOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:03 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)) 20:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:03 INFO - Running setup.py (path:/tmp/pip-eslSkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:03 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)) 20:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:03 INFO - Running setup.py (path:/tmp/pip-WCzpkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:03 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)) 20:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:03 INFO - Running setup.py (path:/tmp/pip-trqDNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:03 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)) 20:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:03 INFO - Running setup.py (path:/tmp/pip-jDDlT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:03 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)) 20:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:03 INFO - Running setup.py (path:/tmp/pip-LJNp5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:03 INFO - Running setup.py (path:/tmp/pip-umC__N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:03 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)) 20:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:03 INFO - Running setup.py (path:/tmp/pip-z1mMkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:03 INFO - Running setup.py (path:/tmp/pip-aEHf1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:03 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)) 20:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:03 INFO - Running setup.py (path:/tmp/pip-HuPiDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:03 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)) 20:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:03 INFO - Running setup.py (path:/tmp/pip-8Ywtgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:04 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)) 20:08:04 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)) 20:08:04 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)) 20:08:04 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)) 20:08:04 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)) 20:08:04 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)) 20:08:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:08:04 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 20:08:04 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 20:08:04 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 20:08:04 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 20:08:04 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 20:08:04 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 20:08:05 INFO - Downloading blessings-1.6.tar.gz 20:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:08:06 INFO - Installing collected packages: blessings 20:08:06 INFO - Running setup.py install for blessings 20:08:06 INFO - Successfully installed blessings 20:08:06 INFO - Cleaning up... 20:08:06 INFO - Return code: 0 20:08:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:08:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:08:06 INFO - Reading from file tmpfile_stdout 20:08:06 INFO - Current package versions: 20:08:06 INFO - argparse == 1.2.1 20:08:06 INFO - blessings == 1.6 20:08:06 INFO - blobuploader == 1.2.4 20:08:06 INFO - docopt == 0.6.1 20:08:06 INFO - functools32 == 3.2.3-2 20:08:06 INFO - jsonschema == 2.5.1 20:08:06 INFO - manifestparser == 1.1 20:08:06 INFO - mozInstall == 1.12 20:08:06 INFO - mozcrash == 0.17 20:08:06 INFO - mozdebug == 0.1 20:08:06 INFO - mozdevice == 0.48 20:08:06 INFO - mozfile == 1.2 20:08:06 INFO - mozhttpd == 0.7 20:08:06 INFO - mozinfo == 0.9 20:08:06 INFO - mozleak == 0.1 20:08:06 INFO - mozlog == 3.2 20:08:06 INFO - moznetwork == 0.27 20:08:06 INFO - mozprocess == 0.23 20:08:06 INFO - mozprofile == 0.28 20:08:06 INFO - mozrunner == 6.12 20:08:06 INFO - mozscreenshot == 0.1 20:08:06 INFO - mozsystemmonitor == 0.3 20:08:06 INFO - moztest == 0.7 20:08:06 INFO - mozversion == 1.4 20:08:06 INFO - psutil == 3.1.1 20:08:06 INFO - requests == 1.2.3 20:08:06 INFO - wsgiref == 0.1.2 20:08:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08: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')]} 20:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:06 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 0xe10030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf3b0>, '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 0x10d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0740>, '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': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', '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 20:08:06 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 20:08:06 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 20:08:06 INFO - Using env: {'DISPLAY': ':0', 20:08:06 INFO - 'HOME': '/home/cltbld', 20:08:06 INFO - 'LANG': 'en_US.UTF-8', 20:08:06 INFO - 'LANGUAGE': 'en_US:en', 20:08:06 INFO - 'LOGNAME': 'cltbld', 20:08:06 INFO - 'MAIL': '/var/mail/cltbld', 20:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:06 INFO - 'MOZ_NO_REMOTE': '1', 20:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:06 INFO - 'NO_EM_RESTART': '1', 20:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:06 INFO - 'PWD': '/builds/slave/test', 20:08:06 INFO - 'SHELL': '/bin/bash', 20:08:06 INFO - 'SHLVL': '1', 20:08:06 INFO - 'TERM': 'linux', 20:08:06 INFO - 'TMOUT': '86400', 20:08:06 INFO - 'USER': 'cltbld', 20:08:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', 20:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:06 INFO - '_': '/tools/buildbot/bin/python'} 20:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:06 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)) 20:08:06 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)) 20:08:06 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)) 20:08:06 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)) 20:08:06 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)) 20:08:06 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)) 20:08:06 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)) 20:08:06 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)) 20:08:06 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)) 20:08:06 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)) 20:08:06 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)) 20:08:06 INFO - Cleaning up... 20:08:06 INFO - Return code: 0 20:08:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:08: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')]} 20:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:06 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 0xe10030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf3b0>, '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 0x10d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0740>, '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': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', '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 20:08:06 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 20:08:06 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 20:08:06 INFO - Using env: {'DISPLAY': ':0', 20:08:06 INFO - 'HOME': '/home/cltbld', 20:08:06 INFO - 'LANG': 'en_US.UTF-8', 20:08:06 INFO - 'LANGUAGE': 'en_US:en', 20:08:06 INFO - 'LOGNAME': 'cltbld', 20:08:06 INFO - 'MAIL': '/var/mail/cltbld', 20:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:06 INFO - 'MOZ_NO_REMOTE': '1', 20:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:06 INFO - 'NO_EM_RESTART': '1', 20:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:06 INFO - 'PWD': '/builds/slave/test', 20:08:06 INFO - 'SHELL': '/bin/bash', 20:08:06 INFO - 'SHLVL': '1', 20:08:06 INFO - 'TERM': 'linux', 20:08:06 INFO - 'TMOUT': '86400', 20:08:06 INFO - 'USER': 'cltbld', 20:08:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', 20:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:06 INFO - '_': '/tools/buildbot/bin/python'} 20:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:08:06 INFO - Cleaning up... 20:08:06 INFO - Return code: 0 20:08:06 INFO - Running post-action listener: _resource_record_post_action 20:08:06 INFO - Running post-action listener: _start_resource_monitoring 20:08:06 INFO - Starting resource monitoring. 20:08:06 INFO - ##### 20:08:06 INFO - ##### Finished create-virtualenv step (success) 20:08:06 INFO - ##### 20:08:06 INFO - ##### 20:08:06 INFO - ##### Running install step. 20:08:06 INFO - ##### 20:08:06 INFO - Running pre-action listener: _resource_record_pre_action 20:08:06 INFO - Running main action method: install 20:08:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:08:07 INFO - Reading from file tmpfile_stdout 20:08:07 INFO - Detecting whether we're running mozinstall >=1.0... 20:08:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:08:07 INFO - Reading from file tmpfile_stdout 20:08:07 INFO - Output received: 20:08:07 INFO - Usage: mozinstall [options] installer 20:08:07 INFO - Options: 20:08:07 INFO - -h, --help show this help message and exit 20:08:07 INFO - -d DEST, --destination=DEST 20:08:07 INFO - Directory to install application into. [default: 20:08:07 INFO - "/builds/slave/test"] 20:08:07 INFO - --app=APP Application being installed. [default: firefox] 20:08:07 INFO - mkdir: /builds/slave/test/build/application 20:08:07 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'] 20:08:07 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 20:08:24 INFO - Reading from file tmpfile_stdout 20:08:24 INFO - Output received: 20:08:24 INFO - /builds/slave/test/build/application/firefox/firefox 20:08:24 INFO - Running post-action listener: _resource_record_post_action 20:08:24 INFO - ##### 20:08:24 INFO - ##### Finished install step (success) 20:08:24 INFO - ##### 20:08:24 INFO - ##### 20:08:24 INFO - ##### Running run-tests step. 20:08:24 INFO - ##### 20:08:24 INFO - Running pre-action listener: _resource_record_pre_action 20:08:24 INFO - Running main action method: run_tests 20:08:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:08:24 INFO - Python 2.7.3 20:08:24 INFO - Return code: 0 20:08:24 INFO - grabbing minidump binary from tooltool 20:08:24 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')]} 20:08:24 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 0x10cf3b0>, '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 0x10d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:08:24 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 20:08:24 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 20:08:24 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 20:08:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:08:24 INFO - Return code: 0 20:08:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:08:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:08:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:08:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:08:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:08:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 20:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 20:08:24 INFO - Using env: {'DISPLAY': ':0', 20:08:24 INFO - 'HOME': '/home/cltbld', 20:08:24 INFO - 'LANG': 'en_US.UTF-8', 20:08:24 INFO - 'LANGUAGE': 'en_US:en', 20:08:24 INFO - 'LOGNAME': 'cltbld', 20:08:24 INFO - 'MAIL': '/var/mail/cltbld', 20:08:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:08:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:24 INFO - 'MOZ_NO_REMOTE': '1', 20:08:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:08:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:24 INFO - 'NO_EM_RESTART': '1', 20:08:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:24 INFO - 'PWD': '/builds/slave/test', 20:08:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:08:24 INFO - 'SHELL': '/bin/bash', 20:08:24 INFO - 'SHLVL': '1', 20:08:24 INFO - 'TERM': 'linux', 20:08:24 INFO - 'TMOUT': '86400', 20:08:24 INFO - 'USER': 'cltbld', 20:08:24 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467946881.67455-1017688133', 20:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:24 INFO - '_': '/tools/buildbot/bin/python'} 20:08:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 20:08:24 INFO - mozversion application_buildid: 20160707183001 20:08:24 INFO - mozversion application_changeset: be469964755162110602a8690cc9e7034fd3981b 20:08:24 INFO - mozversion application_display_name: Nightly 20:08:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:08:24 INFO - mozversion application_name: Firefox 20:08:24 INFO - mozversion application_remotingname: firefox 20:08:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:08:24 INFO - mozversion application_vendor: Mozilla 20:08:24 INFO - mozversion application_version: 50.0a1 20:08:24 INFO - mozversion platform_buildid: 20160707183001 20:08:24 INFO - mozversion platform_changeset: be469964755162110602a8690cc9e7034fd3981b 20:08:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:08:24 INFO - mozversion platform_version: 50.0a1 20:08:24 INFO - using testdate: 1467947304 20:08:24 INFO - actual date: 1467947304 20:08:24 INFO - starting webserver on 'localhost:42873' 20:08:24 INFO - SUITE-START | Running 2 tests 20:08:24 INFO - TEST-START | dromaeo_css 20:08:24 INFO - operating with platform_type : linux_ 20:08:24 INFO - Initialising browser for dromaeo_css test... 20:08:24 INFO - TEST-INFO | started process 17614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZZPQz0/profile http://localhost:42873/getInfo.html) 20:08:29 INFO - PROCESS | 17614 | __metrics Screen width/height:1600/1200 20:08:29 INFO - PROCESS | 17614 | colorDepth:24 20:08:29 INFO - PROCESS | 17614 | Browser inner width/height: 1024/697 20:08:29 INFO - PROCESS | 17614 | __metrics 20:08:30 ERROR - PROCESS | 17614 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 20:08:31 INFO - TEST-INFO | 17614: exit 0 20:08:31 INFO - Browser initialized. 20:08:31 INFO - Running cycle 1/1 for dromaeo_css test... 20:08:31 INFO - TEST-INFO | started process 17735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZZPQz0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:08:42 INFO - PROCESS | 17735 | RSS: Main: 167333888 20:08:42 INFO - PROCESS | 17735 | 20:09:32 INFO - PROCESS | 17735 | 1467947372492 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] 20:11:41 INFO - PROCESS | 17735 | Cycle 1(1): loaded http://localhost:42873/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42873/tests/dromaeo/cssquery-ext.html) 20:11:42 INFO - PROCESS | 17735 | RSS: Main: 171188224 20:11:42 INFO - PROCESS | 17735 | 20:14:44 INFO - PROCESS | 17735 | Cycle 1(1): loaded http://localhost:42873/tests/dromaeo/cssquery-ext.html (next: http://localhost:42873/tests/dromaeo/cssquery-jquery.html) 20:14:45 INFO - PROCESS | 17735 | RSS: Main: 167059456 20:14:45 INFO - PROCESS | 17735 | 20:17:46 INFO - PROCESS | 17735 | Cycle 1(1): loaded http://localhost:42873/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42873/tests/dromaeo/cssquery-mootools.html) 20:17:47 INFO - PROCESS | 17735 | RSS: Main: 170950656 20:17:47 INFO - PROCESS | 17735 | 20:20:49 INFO - PROCESS | 17735 | Cycle 1(1): loaded http://localhost:42873/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42873/tests/dromaeo/cssquery-prototype.html) 20:20:49 INFO - PROCESS | 17735 | RSS: Main: 166936576 20:20:49 INFO - PROCESS | 17735 | 20:23:52 INFO - PROCESS | 17735 | Cycle 1(1): loaded http://localhost:42873/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42873/tests/dromaeo/cssquery-yui.html) 20:23:53 INFO - PROCESS | 17735 | RSS: Main: 168579072 20:23:53 INFO - PROCESS | 17735 | 20:26:56 INFO - PROCESS | 17735 | Cycle 1(1): loaded http://localhost:42873/tests/dromaeo/cssquery-yui.html (next: http://localhost:42873/tests/dromaeo/cssquery-dojo.html) 20:26:56 INFO - PROCESS | 17735 | RSS: Main: 169463808 20:26:56 INFO - PROCESS | 17735 | 20:26:56 INFO - PROCESS | 17735 | __start_tp_report 20:26:56 INFO - PROCESS | 17735 | _x_x_mozilla_page_load 20:26:56 INFO - PROCESS | 17735 | _x_x_mozilla_page_load_details 20:26:56 INFO - PROCESS | 17735 | |i|pagename|runs| 20:26:56 INFO - PROCESS | 17735 | |0;dojo.html;3075.507918733003;3101.3177101037777;3113.175008622715;3147.937041259176;3156.5423013663035;5401.3248343957;5509.173623956403;5542.7782888684505;5547.273479685087;5551.278333816604;5346.679199248048;5478.315210598676;5522.779088836452;5525.475079867406;5557.472040156189;4931.063098011385;4992.67547609406;5065.834857982666;5070.163423035195;5194.610404219679;5078.466760990098;5082.898342033157;5155.226715992593;5176.094183517888;5209.557187639055;4929.137400954836;4997.800087996476;5037.899242015176;5064.493550644943;5073.289739436482;5054.721990290533;5070.138076527;5081;5082.08522465956;5088.542031217171;4894.535019173173;4995.425526064513;5026.497350264981;5041.697498150123;5042.974785126051;5399.055165346049;5479.0959491683825;5493.945060549383;5532.253145825302;5540.473655002768;5841.299044114691;5845.97695403307;5848.67832269225;5856.795012174553;5872.031114866085;5748.770049198027;5813.157092221604;5834.970825145847;5873.882522349529;5886.264216972879;5440.646357986719;5446.945530544684;5454.427285135043;5472.972635136878;5508.4491550845;5966.224390829165;5975.820725378246;5981.431763982415;5988.760449581968;5992.34084250732;5704.942950570524;5706.543476521868;5733.254676892061;5733.283339582552;5784.045632470596;5821.15593238978;5847.970760146257;5848.444397782204;5856.824295271149;5898.734556944862;5754.99287624664;5840.3575606683235;5849.473547380671;5850.824475265749;5905.379935106838;5609.859753506195;5775.075987842009;5782.797602083907;5860.677662728591;5877.353491115974;4493.640508759357;4494.101179763995;4494.887627809266;4509.88725281864;4543.023250001265;3977.7215594908657;4002.69979751514;4007.8196481158416;4031.9798401007806;4052.3718823581803;5456.945430545723;5638.323401191801;5647.1529270609735;5686.0333743263745;5737.110747834093;5929.762809487658;5972.761089556456;5998.760049598054;6008.068749343859;6009.1587177795145;5462.371827239839;5695.629784064023;5707.514861236841;5715.399883012307;5717.599768016282;5044.848654540369;5073.985202959423;5085.338905942278;5089.262057001714;5110.514501122388;6094.299155597075;6112.235970503687;6124.418180272867;6127.5404344674325;6160.7535698571555;5739.942600573941;5911.290645122613;5919.082542205965;5941.7623295067715;5946.851328716817;6105;6189.381061893775;6190.783322583688;6198.72105755233;6200.534959878118;5872.119182122545;5913.6747478887355;5917.554848000063;5928.318243402064;5966.105084237225;5592.105263157875;5855.473007429352;5895.469407753323;6005.549583781147;6017.608855424383;5581.581381396492;5705.914411283751;5732.398098199629;5754.280714910637;5856.238688970407;5779.133130030529;5796.739146738491;5801.593888427769;5805;5806.9419305806405;5550.666959982414;5631.605787594993;5668.943310567007;5706.172604972338;5735.971320143372;5794.565407594363;5802.506786923159;5803.709814509342;5854.531637468907;5859.121131830089;5725.141228815711;5730.484256416942;5732.799352022659;5740.569457290803;5752.626079305 20:26:56 INFO - PROCESS | 17735 | |1;ext.html;556.8322432384655;581.0992960910587;597.2236093078997;599.0923750517966;604.5043064686955;41772;42826.57173428269;42835;42960;45909.77045114778;43799.34300985488;44006.339904901455;44254.55745442545;44336.77831610837;44476;8846.5134417607;9057.682981095662;9062.592183351731;9080;9089;8988.910110898905;9054.502002389865;9056.547172641374;9056.728298151065;9064.229540489066;9072;9104.45373277602;9104.63581456741;9114.58984345706;9128.041555636662;8972.685955991574;9008.819823603557;9010.18908298253;9034.096590340947;9076.137766912132;8892.421992570462;8932.64269429222;9007.549622518913;9010.639574417015;9014.684486043023;43095.784521077505;43643.78178109089;43678;43699.34450983238;43769.78115109436;3620.2035552178477;3772.2078363543687;4272.786360681985;4359.564043595647;4472.753998530079;32594;33150.668493315;33561;33633.663663363295;34578.82710586456;4420.808699010648;4577.198990176706;4579.061292435043;4604.700694454849;4685.3440518327125;342191;342641;342810;344197;346377;57106;58155.418445815;58199;58230.12654810181;58297;60304.39695603075;60380.39619603835;60445.395546043976;60472.697636512414;60756.696216518634;16739.916300418663;16840.663186736198;16888.15559222034;16891.408800691916;17003.659926801396;13319.667008324675;13325.466981320833;13368.732625347438;13370.39833207508;13400.262985535694;14756.704865902622;15986.200689965455;16014.439494617633;16074.919625401799;16212.918935405483;6103.755849766048;6283.37166283368;6293.559450838489;6301.684915754194;6315.400036996478;998.7003898830321;1046.9738256543494;1061.9044286014296;1119.8936101070385;1120.1095129372168;33359;33435.250905841865;33451;33841.49237761386;34057.829710851285;1060.9522571484301;1148.3683973814368;1153.7288737146764;1170.7307319316606;1174.5360582569838;17393.478195654152;17451.389201378144;17612;17613.38353157633;17671.469855904343;525391;528645;528906;531240;532245;58467.122993155135;58940.7052964741;59218.40781592215;59329.110063349086;59401;1365.4196966289287;1395.0513650717407;1396.5949874536677;1396.6648004478852;1400.6288333591606;30889.798529581138;33198.5020224692;33379.83310083434;33452.330953381286;33517;50989.745051274505;51065;51526;51537.22694159666;51541.226881597555;445600;451915;452904;453469;455756;41077.589224107374;41081.1783764329;41394.172116558104;41636;42311;47880.2817957724;48443.757781210865;48714;49136.508634913196;49457.50542494529;42379.15241695087;42854.571454285055;43261.78369108134;43450.78274608733;44195.55804442043;42316.78841605772;42875.510700509534;43013.78493107514;43018.78490607527;43101.35347969846;41972.3704144432;42421;42871.14257714766;43073.78463107665;45264.77367613141;35026;37672.62327376691;37971.62028379681;38274.617253827106;38536.229275414895;28819.711802882543;28837;28860.27849303784;29253.122406326995;29368.70631293745 20:26:56 INFO - PROCESS | 17735 | |2;jquery.html;381.74995378027404;386.1098693808978;390.59378246623504;392.50544314164165;408.43023981545747;19526.414207573776;20455;20489.180432782672;20536.89731551342;20982.58034839302;19716.552099401466;19894.50263743407;20117.792932424065;20123.29568465104;20384.286549970755;5586.608937374385;5707.77168913244;5889.234399528055;5890.469857712805;5981.760729570834;5800.216970708942;5824.30108386992;5873.647581145124;5895.498882594985;5966.67183304918;6082.270127584696;6088.847778805521;6094.969525152368;6097.603655762384;6143.907841382383;5876.882462350751;5977.551683623702;6066.363031881633;6071.908921366183;6103.511719062487;4932.506749325074;5922.7038648067855;5923.111533270044;5937.584369094165;5964.97017514914;13497.797533037012;13613.183209007491;14002.089864158797;14020.649483762885;14035.1578905265;2321.7097862767155;2381.6903802505735;2690.636764036869;2873.094975082842;2903.5209190483547;9702.563384647638;9884;9920.751981200456;10165.59337626494;10514.053735163796;1722.181963567308;1823.4073925974112;1879.285871368871;1888.4712280561328;1913.7129430585385;79411.60294198492;83370.58314708449;83722.99999999939;84269.57865210634;84601.57699211527;10663.253572249869;10714.41070741101;10755.300905441121;11016.283941543774;11178.776424471465;14360.353784079742;14493.420263189566;14545.127292362493;14621.561353159423;14752.55742327732;8247.257746802696;8338.749837504763;8492.40553161285;8594.656213751505;8598.78503037429;8165.265126138676;8212;8277.255047045795;8358.080611132771;8412.242898139197;4287.957120428819;4441.666874984389;4475.373447717322;4494.303382975644;4580.885477863014;1877.1083735225932;1885.5474686075518;1934.2069751401857;1968.9803101969082;1983.7817840037585;422.2736892544818;430.90520085581124;441.5099239843771;457.3688310132063;893.1202765276198;12182.512699492097;12268.141230113984;12475.438605262603;12622.116451848466;12654.746905062031;448.26037038886096;459.0955817040425;468.6485136147889;473.79389965365175;474.7460108841753;6570.77002304917;6723.159605049369;6728.899066514006;6764.898526522008;6859.279775623588;471158;471291;473735;484075;486836;58946.11580826291;73028;80858.19141808507;91538.54230728804;92154.53922730344;446.352788456739;459.91261660284437;459.94710608280474;462.11966204380707;463.55961836255693;11307.416961625215;11626.767464650491;11692.649220523397;11829.645110646694;11955.282683039046;39872.80063599663;42694;43778.562214377445;44028.33957490576;45709.54290457053;53820;59979;61932;61969.38030619636;62039.37960620336;8637.179467950535;8765.904261967255;8860.955695221483;8971.82056358856;8991.055939126298;13417.396217170446;13979.860201397856;14165.220912849893;14284.642883927985;14355.641108972359;12222.816657749963;12531.373431328215;12655.361620775906;12665.176763510342;12774.23354598727;12249.755004900031;12278.07914406441;12289.815652765394;12310.26138431697;12540;12489;12583.68540786451;12604.202067048893;12948.185341263197;12956.546520871725;7467.887981680387;7884;8451.915480845113;8665;9254.028327025566;12006.21959572625;12093.213941093802;12100.939495302468;12526.749465010831;12586.937065314614 20:26:56 INFO - PROCESS | 17735 | |3;mootools.html;1462.9634259143522;1484.3172140815223;1613.5643376288403;1761.964760704786;1762.7267773495112;7741.225877412256;8357.874631880519;8382.119877412875;8941.061188575204;8948.910510894897;8458.407911446202;8767.912320876789;8796.95601521993;8813.338999575026;8823.77940551485;2243.5288589396246;2323.571003832648;2323.604987152188;2326.546323466916;2327.278543651465;2264.230161745006;2296.5980953333183;2314.375118717945;2325.197806756666;2327.8254130940163;2262.7058482397265;2279.7492275849645;2299.620562607168;2300.0799680127916;2317.8377513574055;2257.3905045637584;2280.1905323610126;2283.794458498735;2289.954200915989;2291.3355127013147;2226.688263643075;2231.564844855254;2236.3514580771557;2237.093976939342;2240.630296001158;8612.39713220075;8744.081871403474;8753.124687531195;8811.471311721318;8834.381593288472;5049.798008079672;5141.794328226866;5143.3570803649545;5145.33110695611;5158.329417175781;3298.175456135966;3335.633080361158;3445.689887910075;3452.067941655739;3459.705924996378;1190.8630507491662;1193.0714653771413;1195.9820602690966;1196.1029228078942;1211.4306276050243;11919.463624136848;11968.521259149711;11971.580994665232;11972.401379931056;11995.400229988465;4283.421738065384;4317.740935543878;4487.573680500347;4494.820207191676;4527.683062185615;10163.94918025405;10194.490275486196;10194.796104077877;10214.233932454947;10215.693529193988;5142.717150556755;5149.639525233198;5168.793248270103;5170.3278573785165;5185.740712964337;4166.479190101238;4573.5426457354;4708.576228139415;4731.739754313477;4754;3868.5357757069332;3886.514185726784;3930.5479869814767;3975.0658595230097;4062.695297852673;1271.4087949103712;1278.5588971804711;1281.3913391139135;1285.395863943945;1294.5210272199347;865.3034307382492;960.1262850805733;995.1193194023341;1008.7074748323051;1016.8220561401725;6110.358412366726;6115.694215289218;6238.875222495615;6303.684815759194;6314.968425157845;439.246691923353;443.46340927478116;451.7447642082213;463.1986663072903;468.8921548043969;4173.91652166961;4278.336857787048;4296;4353.455818022747;4359.782010899442;10218.591256349811;10672.30630009047;10689.786204276026;10745.14038876888;10762.031417172491;10644.787104258026;10655.680329590125;10661.200409969284;10667.039966402906;10667.359958402365;7658.349040331635;8006.959965200137;8038.477498962666;8064.919350806535;8138.877916831252;6126.724297406717;6169.722362493609;6323.779505568203;6340.873182536416;6505.316941721051;9841.85237221428;9885.357451765612;10040.69877903664;10172.440515771703;10189.133923616278;9950.900490994998;10111.949440252753;10114.8482772757;10141.29010969225;10257.435841028517;6815.284395138439;7450.36671882896;7470.962645186739;7531.096268447822;7722.884156737541;8498.150184981452;8532.274756645505;8575.056743758307;8592.613332399931;8624.353173511887;7448.14346350155;7705.922940770521;7753.340966017726;7828.569428681477;7852.60736963161;7507.66215520292;7662.348700360531;7679.116901556169;7746.728864489716;7776.688932442639;7310.926890731024;7325.523840950321;7362.7423040193335;7364.742234021784;7374.225706300761;5349.598780091586;5373.570114390761;5505.834824955257;5519.806806761744;5642.85892852682;5306.097963346163;5465.726713664221;5567.415421380697;5630.239917611234;5673.546116310603 20:26:56 INFO - PROCESS | 17735 | |4;prototype.html;323.5502651314673;324.53429328913006;329.1146815067467;331.6782720760863;334.3079824762739;5628.409017053206;5674.489295963363;5690.687012214326;5695.8576035599135;5765.1352297155345;5583.553315734742;5584.581156413265;5591.552675785938;5650.29371328584;5664.830055098343;4131.380292956051;4283.100548884722;4371.409859668952;4381.904523869032;4411.757353345581;4349.847755328564;4378.190034843548;4393.2970724684055;4416.690831641787;4417.337399390085;4372.775622825598;4409.316555933835;4421.38100665907;4435.135148646015;4437.179121862449;4313.1158112586845;4325.4593175853015;4329.393884856123;4339.392485052095;4356.869293921188;3831.6934645228316;3837.7527303626152;3849.903752406184;3882.010087427716;3886.689064874803;5476.972615136939;5524.8342549723575;5524.972375138099;5549.306336707911;5551.639143455663;4882;5049.798008079709;5056.81164926242;5060.569851562622;5074.264231686385;5876.794312199096;5906.320773111104;5910.202122713422;5939.881202375971;5951.232676805306;4271.893202669927;4274.978625106885;4282.48610166782;4284.657227421799;4300.096979634281;5981.9401805981815;6115.969420152871;6121;6133.601315914496;6141.017437210025;4374.671899607542;4387.648988080946;4387.780610969438;4392.890177745582;4399.296112621965;4399.560043995639;4424.469063712375;4424.778761061934;4435.2016637005645;4442.2892337225885;4954.752262386938;5014.373203349582;5016.0971025215085;5039.69761814285;5064.696118232918;5855.912161317584;5933.317668468181;5957.940420595739;5975.267172519921;5978.282606087298;1475.4024620028906;1516.924153792306;1535.385845661722;1542.0901668015924;1543.1435553268043;954.4893481987103;975.9560819763128;991.5339790298548;1006.1950439648252;1016.6848277034143;5672.404397538282;5677.17680936262;5695.971520142372;5696.857578560569;5706.514946229617;6014.218151640346;6046.818595442144;6055.273367195965;6068.96689608986;6107.4197951194565;5562.666240025612;5798.82603521895;5822.214001109796;5835.883282334415;5882.176495290577;3271.004687140842;3296.522004309362;3300.35643049603;3307.9834600826844;3309.7848639838335;6055.394460553997;6345.936540634627;6368.235811702532;6377.362263773585;6399.584027038228;6189.195404597373;6217.875642487215;6229.56393052482;6234.314225435199;6237.563370564017;5976.432238937294;6305.716242769178;6358.33237510064;6386.16979792624;6387.872242555123;6060.545459090674;6063.8180854572665;6069.878602428015;6108.419700128481;6121.47967422774;6058.333583305921;6079.270487541523;6087.391260873877;6098.939010609837;6119.510439164945;6000.609960352563;6261.5616906816085;6355.396237357444;6387.616742995435;6443.2590252119735;4321.913561728811;4323.913521729611;4339.153864996421;4344.6089851913475;4348.608625223618;5901.793437229677;6183.752649894134;6188.845278868064;6216.502679785516;6242.687865606792;5986.341502434816;6025.216721826135;6068.150458935841;6068.21113255274;6095.75037117381;6044.607100538451;6044.727987240497;6059.6364218147055;6068.179546136053;6070.757169713339;5514.862128446821;5589.720513974204;5800.854978625568;5889.733707252961;5966.254218222723;6008.956954635445;6021.548383871314;6022.187004754477;6092.512598992159;6097.817065487865;5629.634073785354;5815.854603634773;5900.527957763455;5919.674417906885;5950.434708702666 20:26:56 INFO - PROCESS | 17735 | |5;yui.html;770.5299767142043;772.8222508822971;826.5701835045772;829.2619568583959;889.5863423508067;14204.147751134926;15020;15069.39722411105;15092.094474331534;15120.546383608496;14065.226412547307;14229.644258893533;14229.715405691906;14260;15014.774778378305;644.680882962934;792.2790260862616;811.1726039439768;811.5658122904248;811.7240138352959;794.3168874767695;795.1372760554805;802.9598520074002;804.6057431858377;804.9235322644369;827.4786884262905;830.3481766813053;831.4346244553701;834.0658462521953;836.4103307168432;827.0778082438098;827.8675411934091;830.0827585517976;832.92087251711;833.071125694852;593.8841925824466;594.9553783466214;597.0357872036673;599.3886236039216;599.8830228105521;14963.625909352244;14974.326155323037;15002;15002.399904003827;15016.399344026226;15754.606134846606;15881.205939702968;16074.678506429806;16119.597010074725;16417;12109.818352724717;12155.93922030393;12206.267623942593;12414.131010829245;12858.742825143445;3945.1320709443876;3987.4218238355566;4054.776987265699;4084.8978775530554;4090.1819636072605;78808;81304.59347703283;81369;81463.59268203621;81591.59204204;12110.576129835414;12260.877391225973;12394.75210495785;12798.16811907223;12827.166234194934;23098.65352019721;23475.295741127793;23497.17759878396;23669.408264793172;23703.525929481657;8670.86993695095;8699.826003479895;8759.386842921062;8800.339974501938;8940.955295223612;4169.082801783603;4225.471816022997;4363.410939523187;4377.146456440963;4392.121575684876;3391.6947474727394;3465.8440370183403;3501.439769636846;3507.7369197310304;3512.7365447591533;592.5822295281902;596.0850095103995;596.4810614765182;604.6432604763211;605.252513146264;730.8428687832142;738.6454501839147;763.5609524523421;776.8679324514733;779.473855147773;10190.753571037967;10685.946570267099;10789.298695584763;11348.943255283672;11843.58547450835;658.2430205263985;693.4244577001077;800.9118996910336;829.7113810887181;831.5135645647243;4957.182064959241;5104.2343648453025;5106.234064890222;5116.948830511722;5128.538431541179;120824.39587802005;121278;122136;122174.85178038059;124271;61137.69431152816;105587;106048;107139.46430267955;107906.46046769716;67488;88545.55727221322;88828.11171888327;89110;91217.08782912219;9755.902440975784;9761.9023809761;9938.403695778277;9972.30193886421;10020.498975051072;52087;54217.74693518401;54256.72871635616;54977.45022549883;55686;80823;81466;83349.16650833414;84361;84687.5765621168;12334.75330493403;12636.810447843105;12845.550405735754;12891.742165156456;13187.142835715647;14610.196439195946;14825.925870371011;14910.627234319229;15040.623984400478;15516.612084697521;12710;12750.553730619384;12829.87170128324;13004.349782511026;13389.464421423034;12983.610491685264;13544.661383465493;13551.59345219645;13617.863821362056;13726.45094196221;12679;13280.468781248643;13296.268705221306;13312.600621980968;13859.099158554662;10442.29102968861;10764.372203014309;10789.980732177413;11086.833697494705;11136;10144.847827282745;10436.478176091317;10563.63027294041;11260.38067906273;11358.886411135783 20:26:56 INFO - PROCESS | 17735 | __end_tp_report 20:26:56 INFO - PROCESS | 17735 | __start_cc_report 20:26:56 INFO - PROCESS | 17735 | _x_x_mozilla_cycle_collect,362 20:26:56 INFO - PROCESS | 17735 | __end_cc_report 20:26:56 INFO - PROCESS | 17735 | __startTimestamp1467948416256__endTimestamp 20:26:56 INFO - PROCESS | 17735 | 20:26:56 INFO - PROCESS | 17735 | ------- Summary: start ------- 20:26:56 INFO - PROCESS | 17735 | Number of tests: 6 20:26:56 INFO - PROCESS | 17735 | 20:26:56 INFO - PROCESS | 17735 | [#0] dojo.html Cycles:165 Average:5479.88 Median:5715.40 stddev:626.81 (11.0%) stddev-sans-first:599.69 20:26:56 INFO - PROCESS | 17735 | Values: 3075.5 3101.3 3113.2 3147.9 3156.5 5401.3 5509.2 5542.8 5547.3 5551.3 5346.7 5478.3 5522.8 5525.5 5557.5 4931.1 4992.7 5065.8 5070.2 5194.6 5078.5 5082.9 5155.2 5176.1 5209.6 4929.1 4997.8 5037.9 5064.5 5073.3 5054.7 5070.1 5081.0 5082.1 5088.5 4894.5 4995.4 5026.5 5041.7 5043.0 5399.1 5479.1 5493.9 5532.3 5540.5 5841.3 5846.0 5848.7 5856.8 5872.0 5748.8 5813.2 5835.0 5873.9 5886.3 5440.6 5446.9 5454.4 5473.0 5508.4 5966.2 5975.8 5981.4 5988.8 5992.3 5704.9 5706.5 5733.3 5733.3 5784.0 5821.2 5848.0 5848.4 5856.8 5898.7 5755.0 5840.4 5849.5 5850.8 5905.4 5609.9 5775.1 5782.8 5860.7 5877.4 4493.6 4494.1 4494.9 4509.9 4543.0 3977.7 4002.7 4007.8 4032.0 4052.4 5456.9 5638.3 5647.2 5686.0 5737.1 5929.8 5972.8 5998.8 6008.1 6009.2 5462.4 5695.6 5707.5 5715.4 5717.6 5044.8 5074.0 5085.3 5089.3 5110.5 6094.3 6112.2 6124.4 6127.5 6160.8 5739.9 5911.3 5919.1 5941.8 5946.9 6105.0 6189.4 6190.8 6198.7 6200.5 5872.1 5913.7 5917.6 5928.3 5966.1 5592.1 5855.5 5895.5 6005.5 6017.6 5581.6 5705.9 5732.4 5754.3 5856.2 5779.1 5796.7 5801.6 5805.0 5806.9 5550.7 5631.6 5668.9 5706.2 5736.0 5794.6 5802.5 5803.7 5854.5 5859.1 5725.1 5730.5 5732.8 5740.6 5752.6 20:26:56 INFO - PROCESS | 17735 | 20:26:56 INFO - PROCESS | 17735 | [#1] ext.html Cycles:180 Average:61072.35 Median:24001.67 stddev:118634.02 (494.3%) stddev-sans-first:118879.81 20:26:56 INFO - PROCESS | 17735 | Values: 556.8 581.1 597.2 599.1 604.5 41772.0 42826.6 42835.0 42960.0 45909.8 43799.3 44006.3 44254.6 44336.8 44476.0 8846.5 9057.7 9062.6 9080.0 9089.0 8988.9 9054.5 9056.5 9056.7 9064.2 9072.0 9104.5 9104.6 9114.6 9128.0 8972.7 9008.8 9010.2 9034.1 9076.1 8892.4 8932.6 9007.5 9010.6 9014.7 43095.8 43643.8 43678.0 43699.3 43769.8 3620.2 3772.2 4272.8 4359.6 4472.8 32594.0 33150.7 33561.0 33633.7 34578.8 4420.8 4577.2 4579.1 4604.7 4685.3 342191.0 342641.0 342810.0 344197.0 346377.0 57106.0 58155.4 58199.0 58230.1 58297.0 60304.4 60380.4 60445.4 60472.7 60756.7 16739.9 16840.7 16888.2 16891.4 17003.7 13319.7 13325.5 13368.7 13370.4 13400.3 14756.7 15986.2 16014.4 16074.9 16212.9 6103.8 6283.4 6293.6 6301.7 6315.4 998.7 1047.0 1061.9 1119.9 1120.1 33359.0 33435.3 33451.0 33841.5 34057.8 1061.0 1148.4 1153.7 1170.7 1174.5 17393.5 17451.4 17612.0 17613.4 17671.5 525391.0 528645.0 528906.0 531240.0 532245.0 58467.1 58940.7 59218.4 59329.1 59401.0 1365.4 1395.1 1396.6 1396.7 1400.6 30889.8 33198.5 33379.8 33452.3 33517.0 50989.7 51065.0 51526.0 51537.2 51541.2 445600.0 451915.0 452904.0 453469.0 455756.0 41077.6 41081.2 41394.2 41636.0 42311.0 47880.3 48443.8 48714.0 49136.5 49457.5 42379.2 42854.6 43261.8 43450.8 44195.6 42316.8 42875.5 43013.8 43018.8 43101.4 41972.4 42421.0 42871.1 43073.8 45264.8 35026.0 37672.6 37971.6 38274.6 38536.2 28819.7 28837.0 28860.3 29253.1 29368.7 20:26:56 INFO - PROCESS | 17735 | 20:26:56 INFO - PROCESS | 17735 | [#2] jquery.html Cycles:180 Average:27879.31 Median:2444.01 stddev:78731.36 (3221.4%) stddev-sans-first:78925.15 20:26:56 INFO - PROCESS | 17735 | Values: 381.7 386.1 390.6 392.5 408.4 19526.4 20455.0 20489.2 20536.9 20982.6 19716.6 19894.5 20117.8 20123.3 20384.3 5586.6 5707.8 5889.2 5890.5 5981.8 5800.2 5824.3 5873.6 5895.5 5966.7 6082.3 6088.8 6095.0 6097.6 6143.9 5876.9 5977.6 6066.4 6071.9 6103.5 4932.5 5922.7 5923.1 5937.6 5965.0 13497.8 13613.2 14002.1 14020.6 14035.2 2321.7 2381.7 2690.6 2873.1 2903.5 9702.6 9884.0 9920.8 10165.6 10514.1 1722.2 1823.4 1879.3 1888.5 1913.7 79411.6 83370.6 83723.0 84269.6 84601.6 10663.3 10714.4 10755.3 11016.3 11178.8 14360.4 14493.4 14545.1 14621.6 14752.6 8247.3 8338.7 8492.4 8594.7 8598.8 8165.3 8212.0 8277.3 8358.1 8412.2 4288.0 4441.7 4475.4 4494.3 4580.9 1877.1 1885.5 1934.2 1969.0 1983.8 422.3 430.9 441.5 457.4 893.1 12182.5 12268.1 12475.4 12622.1 12654.7 448.3 459.1 468.6 473.8 474.7 6570.8 6723.2 6728.9 6764.9 6859.3 471158.0 471291.0 473735.0 484075.0 486836.0 58946.1 73028.0 80858.2 91538.5 92154.5 446.4 459.9 459.9 462.1 463.6 11307.4 11626.8 11692.6 11829.6 11955.3 39872.8 42694.0 43778.6 44028.3 45709.5 53820.0 59979.0 61932.0 61969.4 62039.4 8637.2 8765.9 8861.0 8971.8 8991.1 13417.4 13979.9 14165.2 14284.6 14355.6 12222.8 12531.4 12655.4 12665.2 12774.2 12249.8 12278.1 12289.8 12310.3 12540.0 12489.0 12583.7 12604.2 12948.2 12956.5 7467.9 7884.0 8451.9 8665.0 9254.0 12006.2 12093.2 12100.9 12526.7 12586.9 20:26:56 INFO - PROCESS | 17735 | 20:26:56 INFO - PROCESS | 17735 | [#3] mootools.html Cycles:180 Average:5767.08 Median:2473.28 stddev:3255.12 (131.6%) stddev-sans-first:3248.18 20:26:56 INFO - PROCESS | 17735 | Values: 1463.0 1484.3 1613.6 1762.0 1762.7 7741.2 8357.9 8382.1 8941.1 8948.9 8458.4 8767.9 8797.0 8813.3 8823.8 2243.5 2323.6 2323.6 2326.5 2327.3 2264.2 2296.6 2314.4 2325.2 2327.8 2262.7 2279.7 2299.6 2300.1 2317.8 2257.4 2280.2 2283.8 2290.0 2291.3 2226.7 2231.6 2236.4 2237.1 2240.6 8612.4 8744.1 8753.1 8811.5 8834.4 5049.8 5141.8 5143.4 5145.3 5158.3 3298.2 3335.6 3445.7 3452.1 3459.7 1190.9 1193.1 1196.0 1196.1 1211.4 11919.5 11968.5 11971.6 11972.4 11995.4 4283.4 4317.7 4487.6 4494.8 4527.7 10163.9 10194.5 10194.8 10214.2 10215.7 5142.7 5149.6 5168.8 5170.3 5185.7 4166.5 4573.5 4708.6 4731.7 4754.0 3868.5 3886.5 3930.5 3975.1 4062.7 1271.4 1278.6 1281.4 1285.4 1294.5 865.3 960.1 995.1 1008.7 1016.8 6110.4 6115.7 6238.9 6303.7 6315.0 439.2 443.5 451.7 463.2 468.9 4173.9 4278.3 4296.0 4353.5 4359.8 10218.6 10672.3 10689.8 10745.1 10762.0 10644.8 10655.7 10661.2 10667.0 10667.4 7658.3 8007.0 8038.5 8064.9 8138.9 6126.7 6169.7 6323.8 6340.9 6505.3 9841.9 9885.4 10040.7 10172.4 10189.1 9950.9 10111.9 10114.8 10141.3 10257.4 6815.3 7450.4 7471.0 7531.1 7722.9 8498.2 8532.3 8575.1 8592.6 8624.4 7448.1 7705.9 7753.3 7828.6 7852.6 7507.7 7662.3 7679.1 7746.7 7776.7 7310.9 7325.5 7362.7 7364.7 7374.2 5349.6 5373.6 5505.8 5519.8 5642.9 5306.1 5465.7 5567.4 5630.2 5673.5 20:26:56 INFO - PROCESS | 17735 | 20:26:56 INFO - PROCESS | 17735 | [#4] prototype.html Cycles:180 Average:5011.52 Median:5693.27 stddev:1482.85 (26.0%) stddev-sans-first:1444.66 20:26:56 INFO - PROCESS | 17735 | Values: 323.6 324.5 329.1 331.7 334.3 5628.4 5674.5 5690.7 5695.9 5765.1 5583.6 5584.6 5591.6 5650.3 5664.8 4131.4 4283.1 4371.4 4381.9 4411.8 4349.8 4378.2 4393.3 4416.7 4417.3 4372.8 4409.3 4421.4 4435.1 4437.2 4313.1 4325.5 4329.4 4339.4 4356.9 3831.7 3837.8 3849.9 3882.0 3886.7 5477.0 5524.8 5525.0 5549.3 5551.6 4882.0 5049.8 5056.8 5060.6 5074.3 5876.8 5906.3 5910.2 5939.9 5951.2 4271.9 4275.0 4282.5 4284.7 4300.1 5981.9 6116.0 6121.0 6133.6 6141.0 4374.7 4387.6 4387.8 4392.9 4399.3 4399.6 4424.5 4424.8 4435.2 4442.3 4954.8 5014.4 5016.1 5039.7 5064.7 5855.9 5933.3 5957.9 5975.3 5978.3 1475.4 1516.9 1535.4 1542.1 1543.1 954.5 976.0 991.5 1006.2 1016.7 5672.4 5677.2 5696.0 5696.9 5706.5 6014.2 6046.8 6055.3 6069.0 6107.4 5562.7 5798.8 5822.2 5835.9 5882.2 3271.0 3296.5 3300.4 3308.0 3309.8 6055.4 6345.9 6368.2 6377.4 6399.6 6189.2 6217.9 6229.6 6234.3 6237.6 5976.4 6305.7 6358.3 6386.2 6387.9 6060.5 6063.8 6069.9 6108.4 6121.5 6058.3 6079.3 6087.4 6098.9 6119.5 6000.6 6261.6 6355.4 6387.6 6443.3 4321.9 4323.9 4339.2 4344.6 4348.6 5901.8 6183.8 6188.8 6216.5 6242.7 5986.3 6025.2 6068.2 6068.2 6095.8 6044.6 6044.7 6059.6 6068.2 6070.8 5514.9 5589.7 5800.9 5889.7 5966.3 6009.0 6021.5 6022.2 6092.5 6097.8 5629.6 5815.9 5900.5 5919.7 5950.4 20:26:56 INFO - PROCESS | 17735 | 20:26:56 INFO - PROCESS | 17735 | [#5] yui.html Cycles:180 Average:21494.83 Median:3966.28 stddev:31316.58 (789.6%) stddev-sans-first:31365.77 20:26:56 INFO - PROCESS | 17735 | Values: 770.5 772.8 826.6 829.3 889.6 14204.1 15020.0 15069.4 15092.1 15120.5 14065.2 14229.6 14229.7 14260.0 15014.8 644.7 792.3 811.2 811.6 811.7 794.3 795.1 803.0 804.6 804.9 827.5 830.3 831.4 834.1 836.4 827.1 827.9 830.1 832.9 833.1 593.9 595.0 597.0 599.4 599.9 14963.6 14974.3 15002.0 15002.4 15016.4 15754.6 15881.2 16074.7 16119.6 16417.0 12109.8 12155.9 12206.3 12414.1 12858.7 3945.1 3987.4 4054.8 4084.9 4090.2 78808.0 81304.6 81369.0 81463.6 81591.6 12110.6 12260.9 12394.8 12798.2 12827.2 23098.7 23475.3 23497.2 23669.4 23703.5 8670.9 8699.8 8759.4 8800.3 8941.0 4169.1 4225.5 4363.4 4377.1 4392.1 3391.7 3465.8 3501.4 3507.7 3512.7 592.6 596.1 596.5 604.6 605.3 730.8 738.6 763.6 776.9 779.5 10190.8 10685.9 10789.3 11348.9 11843.6 658.2 693.4 800.9 829.7 831.5 4957.2 5104.2 5106.2 5116.9 5128.5 120824.4 121278.0 122136.0 122174.9 124271.0 61137.7 105587.0 106048.0 107139.5 107906.5 67488.0 88545.6 88828.1 89110.0 91217.1 9755.9 9761.9 9938.4 9972.3 10020.5 52087.0 54217.7 54256.7 54977.5 55686.0 80823.0 81466.0 83349.2 84361.0 84687.6 12334.8 12636.8 12845.6 12891.7 13187.1 14610.2 14825.9 14910.6 15040.6 15516.6 12710.0 12750.6 12829.9 13004.3 13389.5 12983.6 13544.7 13551.6 13617.9 13726.5 12679.0 13280.5 13296.3 13312.6 13859.1 10442.3 10764.4 10790.0 11086.8 11136.0 10144.8 10436.5 10563.6 11260.4 11358.9 20:26:56 INFO - PROCESS | 17735 | -------- Summary: end -------- 20:26:56 INFO - PROCESS | 17735 | 20:26:56 INFO - TEST-INFO | 17735: exit 0 20:26:56 INFO - TEST-OK | dromaeo_css | took 1112235ms 20:26:56 INFO - TEST-START | kraken 20:26:56 INFO - operating with platform_type : linux_ 20:26:56 INFO - Initialising browser for kraken test... 20:26:56 INFO - TEST-INFO | started process 17989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRXPcXr/profile http://localhost:42873/getInfo.html) 20:27:01 INFO - PROCESS | 17989 | __metrics Screen width/height:1600/1200 20:27:01 INFO - PROCESS | 17989 | colorDepth:24 20:27:01 INFO - PROCESS | 17989 | Browser inner width/height: 1024/697 20:27:01 INFO - PROCESS | 17989 | __metrics 20:27:02 ERROR - PROCESS | 17989 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 20:27:03 INFO - TEST-INFO | 17989: exit 0 20:27:03 INFO - Browser initialized. 20:27:03 INFO - Running cycle 1/1 for kraken test... 20:27:03 INFO - TEST-INFO | started process 18112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRXPcXr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:27:15 INFO - PROCESS | 18112 | RSS: Main: 167583744 20:27:15 INFO - PROCESS | 18112 | 20:27:17 INFO - PROCESS | 18112 | Cycle 1(1): loaded http://localhost:42873/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42873/tests/kraken/driver.html?testName=audio-beat-detection) 20:27:18 INFO - PROCESS | 18112 | RSS: Main: 173215744 20:27:18 INFO - PROCESS | 18112 | 20:27:21 INFO - PROCESS | 18112 | Cycle 1(1): loaded http://localhost:42873/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42873/tests/kraken/driver.html?testName=audio-dft) 20:27:21 INFO - PROCESS | 18112 | RSS: Main: 172560384 20:27:21 INFO - PROCESS | 18112 | 20:27:24 INFO - PROCESS | 18112 | Cycle 1(1): loaded http://localhost:42873/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42873/tests/kraken/driver.html?testName=audio-fft) 20:27:25 INFO - PROCESS | 18112 | RSS: Main: 167337984 20:27:25 INFO - PROCESS | 18112 | 20:27:27 INFO - PROCESS | 18112 | Cycle 1(1): loaded http://localhost:42873/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42873/tests/kraken/driver.html?testName=audio-oscillator) 20:27:27 INFO - PROCESS | 18112 | RSS: Main: 168140800 20:27:27 INFO - PROCESS | 18112 | 20:27:30 INFO - PROCESS | 18112 | Cycle 1(1): loaded http://localhost:42873/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42873/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:27:30 INFO - PROCESS | 18112 | RSS: Main: 168697856 20:27:30 INFO - PROCESS | 18112 | 20:27:33 INFO - PROCESS | 18112 | Cycle 1(1): loaded http://localhost:42873/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42873/tests/kraken/driver.html?testName=imaging-darkroom) 20:27:34 INFO - PROCESS | 18112 | RSS: Main: 169271296 20:27:34 INFO - PROCESS | 18112 | 20:27:37 INFO - PROCESS | 18112 | Cycle 1(1): loaded http://localhost:42873/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42873/tests/kraken/driver.html?testName=imaging-desaturate) 20:27:38 INFO - PROCESS | 18112 | RSS: Main: 166318080 20:27:38 INFO - PROCESS | 18112 | 20:27:41 INFO - PROCESS | 18112 | Cycle 1(1): loaded http://localhost:42873/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42873/tests/kraken/driver.html?testName=json-parse-financial) 20:27:41 INFO - PROCESS | 18112 | RSS: Main: 167718912 20:27:41 INFO - PROCESS | 18112 | 20:27:43 INFO - PROCESS | 18112 | Cycle 1(1): loaded http://localhost:42873/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42873/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:27:44 INFO - PROCESS | 18112 | RSS: Main: 168148992 20:27:44 INFO - PROCESS | 18112 | 20:27:45 INFO - PROCESS | 18112 | Cycle 1(1): loaded http://localhost:42873/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42873/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:27:46 INFO - PROCESS | 18112 | RSS: Main: 168468480 20:27:46 INFO - PROCESS | 18112 | 20:27:48 INFO - PROCESS | 18112 | Cycle 1(1): loaded http://localhost:42873/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42873/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:27:49 INFO - PROCESS | 18112 | RSS: Main: 168914944 20:27:49 INFO - PROCESS | 18112 | 20:27:51 INFO - PROCESS | 18112 | Cycle 1(1): loaded http://localhost:42873/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42873/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:27:52 INFO - PROCESS | 18112 | RSS: Main: 169132032 20:27:52 INFO - PROCESS | 18112 | 20:27:55 INFO - PROCESS | 18112 | Cycle 1(1): loaded http://localhost:42873/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42873/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:27:55 INFO - PROCESS | 18112 | RSS: Main: 168681472 20:27:55 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | Cycle 1(1): loaded http://localhost:42873/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42873/tests/kraken/driver.html?testName=ai-astar) 20:27:57 INFO - PROCESS | 18112 | RSS: Main: 169512960 20:27:57 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | __start_tp_report 20:27:57 INFO - PROCESS | 18112 | _x_x_mozilla_page_load 20:27:57 INFO - PROCESS | 18112 | _x_x_mozilla_page_load_details 20:27:57 INFO - PROCESS | 18112 | |i|pagename|runs| 20:27:57 INFO - PROCESS | 18112 | |0;ai-astar;101;111;106;112;112;112;111;110;114;111 20:27:57 INFO - PROCESS | 18112 | |1;audio-beat-detection;153;118;142;177;120;153;147;122;186;121 20:27:57 INFO - PROCESS | 18112 | |2;audio-dft;163;166;161;164;162;164;167;171;163;163 20:27:57 INFO - PROCESS | 18112 | |3;audio-fft;75;75;75;149;77;75;86;75;165;76 20:27:57 INFO - PROCESS | 18112 | |4;audio-oscillator;87;85;150;86;87;87;142;86;85;169 20:27:57 INFO - PROCESS | 18112 | |5;imaging-gaussian-blur;118;117;121;117;118;117;119;117;118;117 20:27:57 INFO - PROCESS | 18112 | |6;imaging-darkroom;151;147;150;150;146;147;146;146;146;146 20:27:57 INFO - PROCESS | 18112 | |7;imaging-desaturate;96;95;97;100;95;95;96;96;96;95 20:27:57 INFO - PROCESS | 18112 | |8;json-parse-financial;56;54;56;54;56;57;60;53;56;57 20:27:57 INFO - PROCESS | 18112 | |9;json-stringify-tinderbox;60;60;61;60;61;61;60;60;62;60 20:27:57 INFO - PROCESS | 18112 | |10;stanford-crypto-aes;76;81;75;74;75;77;74;76;80;81 20:27:57 INFO - PROCESS | 18112 | |11;stanford-crypto-ccm;136;118;120;133;126;122;120;122;180;123 20:27:57 INFO - PROCESS | 18112 | |12;stanford-crypto-pbkdf2;156;160;156;156;157;154;161;159;163;158 20:27:57 INFO - PROCESS | 18112 | |13;stanford-crypto-sha256-iterative;65;64;66;65;67;65;64;64;63;63 20:27:57 INFO - PROCESS | 18112 | __end_tp_report 20:27:57 INFO - PROCESS | 18112 | __start_cc_report 20:27:57 INFO - PROCESS | 18112 | _x_x_mozilla_cycle_collect,918 20:27:57 INFO - PROCESS | 18112 | __end_cc_report 20:27:57 INFO - PROCESS | 18112 | __startTimestamp1467948477770__endTimestamp 20:27:57 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | ------- Summary: start ------- 20:27:57 INFO - PROCESS | 18112 | Number of tests: 14 20:27:57 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:3.77 (3.4%) stddev-sans-first:2.18 20:27:57 INFO - PROCESS | 18112 | Values: 101.0 111.0 106.0 112.0 112.0 112.0 111.0 110.0 114.0 111.0 20:27:57 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:150.00 stddev:24.25 (16.2%) stddev-sans-first:25.50 20:27:57 INFO - PROCESS | 18112 | Values: 153.0 118.0 142.0 177.0 120.0 153.0 147.0 122.0 186.0 121.0 20:27:57 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:2.91 (1.8%) stddev-sans-first:3.05 20:27:57 INFO - PROCESS | 18112 | Values: 163.0 166.0 161.0 164.0 162.0 164.0 167.0 171.0 163.0 163.0 20:27:57 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.00 stddev:34.21 (45.6%) stddev-sans-first:35.67 20:27:57 INFO - PROCESS | 18112 | Values: 75.0 75.0 75.0 149.0 77.0 75.0 86.0 75.0 165.0 76.0 20:27:57 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | [#4] audio-oscillator Cycles:10 Average:106.40 Median:86.00 stddev:33.27 (38.7%) stddev-sans-first:34.54 20:27:57 INFO - PROCESS | 18112 | Values: 87.0 85.0 150.0 86.0 87.0 87.0 142.0 86.0 85.0 169.0 20:27:57 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.29 (1.1%) stddev-sans-first:1.36 20:27:57 INFO - PROCESS | 18112 | Values: 118.0 117.0 121.0 117.0 118.0 117.0 119.0 117.0 118.0 117.0 20:27:57 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:2.01 (1.4%) stddev-sans-first:1.69 20:27:57 INFO - PROCESS | 18112 | Values: 151.0 147.0 150.0 150.0 146.0 147.0 146.0 146.0 146.0 146.0 20:27:57 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.52 (1.6%) stddev-sans-first:1.62 20:27:57 INFO - PROCESS | 18112 | Values: 96.0 95.0 97.0 100.0 95.0 95.0 96.0 96.0 96.0 95.0 20:27:57 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.97 (3.5%) stddev-sans-first:2.09 20:27:57 INFO - PROCESS | 18112 | Values: 56.0 54.0 56.0 54.0 56.0 57.0 60.0 53.0 56.0 57.0 20:27:57 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 20:27:57 INFO - PROCESS | 18112 | Values: 60.0 60.0 61.0 60.0 61.0 61.0 60.0 60.0 62.0 60.0 20:27:57 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:76.50 stddev:2.77 (3.6%) stddev-sans-first:2.92 20:27:57 INFO - PROCESS | 18112 | Values: 76.0 81.0 75.0 74.0 75.0 77.0 74.0 76.0 80.0 81.0 20:27:57 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:124.50 stddev:18.51 (14.9%) stddev-sans-first:19.50 20:27:57 INFO - PROCESS | 18112 | Values: 136.0 118.0 120.0 133.0 126.0 122.0 120.0 122.0 180.0 123.0 20:27:57 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:158.50 stddev:2.75 (1.7%) stddev-sans-first:2.82 20:27:57 INFO - PROCESS | 18112 | Values: 156.0 160.0 156.0 156.0 157.0 154.0 161.0 159.0 163.0 158.0 20:27:57 INFO - PROCESS | 18112 | 20:27:57 INFO - PROCESS | 18112 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:1.26 (1.9%) stddev-sans-first:1.33 20:27:57 INFO - PROCESS | 18112 | Values: 65.0 64.0 66.0 65.0 67.0 65.0 64.0 64.0 63.0 63.0 20:27:57 INFO - PROCESS | 18112 | -------- Summary: end -------- 20:27:57 INFO - PROCESS | 18112 | 20:27:58 INFO - TEST-INFO | 18112: exit 0 20:27:58 INFO - TEST-OK | kraken | took 61738ms 20:27:58 INFO - SUITE-END | took 1173s 20:27:58 INFO - Completed test suite (00:19:34) 20:27:58 INFO - javascript benchmark 20:27:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7279.541676080939, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.507918733003, 3101.3177101037777, 3113.175008622715, 3147.937041259176, 3156.5423013663035, 5401.3248343957, 5509.173623956403, 5542.7782888684505, 5547.273479685087, 5551.278333816604, 5346.679199248048, 5478.315210598676, 5522.779088836452, 5525.475079867406, 5557.472040156189, 4931.063098011385, 4992.67547609406, 5065.834857982666, 5070.163423035195, 5194.610404219679, 5078.466760990098, 5082.898342033157, 5155.226715992593, 5176.094183517888, 5209.557187639055, 4929.137400954836, 4997.800087996476, 5037.899242015176, 5064.493550644943, 5073.289739436482, 5054.721990290533, 5070.138076527, 5081.0, 5082.08522465956, 5088.542031217171, 4894.535019173173, 4995.425526064513, 5026.497350264981, 5041.697498150123, 5042.974785126051, 5399.055165346049, 5479.0959491683825, 5493.945060549383, 5532.253145825302, 5540.473655002768, 5841.299044114691, 5845.97695403307, 5848.67832269225, 5856.795012174553, 5872.031114866085, 5748.770049198027, 5813.157092221604, 5834.970825145847, 5873.882522349529, 5886.264216972879, 5440.646357986719, 5446.945530544684, 5454.427285135043, 5472.972635136878, 5508.4491550845, 5966.224390829165, 5975.820725378246, 5981.431763982415, 5988.760449581968, 5992.34084250732, 5704.942950570524, 5706.543476521868, 5733.254676892061, 5733.283339582552, 5784.045632470596, 5821.15593238978, 5847.970760146257, 5848.444397782204, 5856.824295271149, 5898.734556944862, 5754.99287624664, 5840.3575606683235, 5849.473547380671, 5850.824475265749, 5905.379935106838, 5609.859753506195, 5775.075987842009, 5782.797602083907, 5860.677662728591, 5877.353491115974, 4493.640508759357, 4494.101179763995, 4494.887627809266, 4509.88725281864, 4543.023250001265, 3977.7215594908657, 4002.69979751514, 4007.8196481158416, 4031.9798401007806, 4052.3718823581803, 5456.945430545723, 5638.323401191801, 5647.1529270609735, 5686.0333743263745, 5737.110747834093, 5929.762809487658, 5972.761089556456, 5998.760049598054, 6008.068749343859, 6009.1587177795145, 5462.371827239839, 5695.629784064023, 5707.514861236841, 5715.399883012307, 5717.599768016282, 5044.848654540369, 5073.985202959423, 5085.338905942278, 5089.262057001714, 5110.514501122388, 6094.299155597075, 6112.235970503687, 6124.418180272867, 6127.5404344674325, 6160.7535698571555, 5739.942600573941, 5911.290645122613, 5919.082542205965, 5941.7623295067715, 5946.851328716817, 6105.0, 6189.381061893775, 6190.783322583688, 6198.72105755233, 6200.534959878118, 5872.119182122545, 5913.6747478887355, 5917.554848000063, 5928.318243402064, 5966.105084237225, 5592.105263157875, 5855.473007429352, 5895.469407753323, 6005.549583781147, 6017.608855424383, 5581.581381396492, 5705.914411283751, 5732.398098199629, 5754.280714910637, 5856.238688970407, 5779.133130030529, 5796.739146738491, 5801.593888427769, 5805.0, 5806.9419305806405, 5550.666959982414, 5631.605787594993, 5668.943310567007, 5706.172604972338, 5735.971320143372, 5794.565407594363, 5802.506786923159, 5803.709814509342, 5854.531637468907, 5859.121131830089, 5725.141228815711, 5730.484256416942, 5732.799352022659, 5740.569457290803, 5752.626079305], "value": 5436.708578352392, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.8322432384655, 581.0992960910587, 597.2236093078997, 599.0923750517966, 604.5043064686955, 41772.0, 42826.57173428269, 42835.0, 42960.0, 45909.77045114778, 43799.34300985488, 44006.339904901455, 44254.55745442545, 44336.77831610837, 44476.0, 8846.5134417607, 9057.682981095662, 9062.592183351731, 9080.0, 9089.0, 8988.910110898905, 9054.502002389865, 9056.547172641374, 9056.728298151065, 9064.229540489066, 9072.0, 9104.45373277602, 9104.63581456741, 9114.58984345706, 9128.041555636662, 8972.685955991574, 9008.819823603557, 9010.18908298253, 9034.096590340947, 9076.137766912132, 8892.421992570462, 8932.64269429222, 9007.549622518913, 9010.639574417015, 9014.684486043023, 43095.784521077505, 43643.78178109089, 43678.0, 43699.34450983238, 43769.78115109436, 3620.2035552178477, 3772.2078363543687, 4272.786360681985, 4359.564043595647, 4472.753998530079, 32594.0, 33150.668493315, 33561.0, 33633.663663363295, 34578.82710586456, 4420.808699010648, 4577.198990176706, 4579.061292435043, 4604.700694454849, 4685.3440518327125, 342191.0, 342641.0, 342810.0, 344197.0, 346377.0, 57106.0, 58155.418445815, 58199.0, 58230.12654810181, 58297.0, 60304.39695603075, 60380.39619603835, 60445.395546043976, 60472.697636512414, 60756.696216518634, 16739.916300418663, 16840.663186736198, 16888.15559222034, 16891.408800691916, 17003.659926801396, 13319.667008324675, 13325.466981320833, 13368.732625347438, 13370.39833207508, 13400.262985535694, 14756.704865902622, 15986.200689965455, 16014.439494617633, 16074.919625401799, 16212.918935405483, 6103.755849766048, 6283.37166283368, 6293.559450838489, 6301.684915754194, 6315.400036996478, 998.7003898830321, 1046.9738256543494, 1061.9044286014296, 1119.8936101070385, 1120.1095129372168, 33359.0, 33435.250905841865, 33451.0, 33841.49237761386, 34057.829710851285, 1060.9522571484301, 1148.3683973814368, 1153.7288737146764, 1170.7307319316606, 1174.5360582569838, 17393.478195654152, 17451.389201378144, 17612.0, 17613.38353157633, 17671.469855904343, 525391.0, 528645.0, 528906.0, 531240.0, 532245.0, 58467.122993155135, 58940.7052964741, 59218.40781592215, 59329.110063349086, 59401.0, 1365.4196966289287, 1395.0513650717407, 1396.5949874536677, 1396.6648004478852, 1400.6288333591606, 30889.798529581138, 33198.5020224692, 33379.83310083434, 33452.330953381286, 33517.0, 50989.745051274505, 51065.0, 51526.0, 51537.22694159666, 51541.226881597555, 445600.0, 451915.0, 452904.0, 453469.0, 455756.0, 41077.589224107374, 41081.1783764329, 41394.172116558104, 41636.0, 42311.0, 47880.2817957724, 48443.757781210865, 48714.0, 49136.508634913196, 49457.50542494529, 42379.15241695087, 42854.571454285055, 43261.78369108134, 43450.78274608733, 44195.55804442043, 42316.78841605772, 42875.510700509534, 43013.78493107514, 43018.78490607527, 43101.35347969846, 41972.3704144432, 42421.0, 42871.14257714766, 43073.78463107665, 45264.77367613141, 35026.0, 37672.62327376691, 37971.62028379681, 38274.617253827106, 38536.229275414895, 28819.711802882543, 28837.0, 28860.27849303784, 29253.122406326995, 29368.70631293745], "value": 20630.09544991255, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.74995378027404, 386.1098693808978, 390.59378246623504, 392.50544314164165, 408.43023981545747, 19526.414207573776, 20455.0, 20489.180432782672, 20536.89731551342, 20982.58034839302, 19716.552099401466, 19894.50263743407, 20117.792932424065, 20123.29568465104, 20384.286549970755, 5586.608937374385, 5707.77168913244, 5889.234399528055, 5890.469857712805, 5981.760729570834, 5800.216970708942, 5824.30108386992, 5873.647581145124, 5895.498882594985, 5966.67183304918, 6082.270127584696, 6088.847778805521, 6094.969525152368, 6097.603655762384, 6143.907841382383, 5876.882462350751, 5977.551683623702, 6066.363031881633, 6071.908921366183, 6103.511719062487, 4932.506749325074, 5922.7038648067855, 5923.111533270044, 5937.584369094165, 5964.97017514914, 13497.797533037012, 13613.183209007491, 14002.089864158797, 14020.649483762885, 14035.1578905265, 2321.7097862767155, 2381.6903802505735, 2690.636764036869, 2873.094975082842, 2903.5209190483547, 9702.563384647638, 9884.0, 9920.751981200456, 10165.59337626494, 10514.053735163796, 1722.181963567308, 1823.4073925974112, 1879.285871368871, 1888.4712280561328, 1913.7129430585385, 79411.60294198492, 83370.58314708449, 83722.99999999939, 84269.57865210634, 84601.57699211527, 10663.253572249869, 10714.41070741101, 10755.300905441121, 11016.283941543774, 11178.776424471465, 14360.353784079742, 14493.420263189566, 14545.127292362493, 14621.561353159423, 14752.55742327732, 8247.257746802696, 8338.749837504763, 8492.40553161285, 8594.656213751505, 8598.78503037429, 8165.265126138676, 8212.0, 8277.255047045795, 8358.080611132771, 8412.242898139197, 4287.957120428819, 4441.666874984389, 4475.373447717322, 4494.303382975644, 4580.885477863014, 1877.1083735225932, 1885.5474686075518, 1934.2069751401857, 1968.9803101969082, 1983.7817840037585, 422.2736892544818, 430.90520085581124, 441.5099239843771, 457.3688310132063, 893.1202765276198, 12182.512699492097, 12268.141230113984, 12475.438605262603, 12622.116451848466, 12654.746905062031, 448.26037038886096, 459.0955817040425, 468.6485136147889, 473.79389965365175, 474.7460108841753, 6570.77002304917, 6723.159605049369, 6728.899066514006, 6764.898526522008, 6859.279775623588, 471158.0, 471291.0, 473735.0, 484075.0, 486836.0, 58946.11580826291, 73028.0, 80858.19141808507, 91538.54230728804, 92154.53922730344, 446.352788456739, 459.91261660284437, 459.94710608280474, 462.11966204380707, 463.55961836255693, 11307.416961625215, 11626.767464650491, 11692.649220523397, 11829.645110646694, 11955.282683039046, 39872.80063599663, 42694.0, 43778.562214377445, 44028.33957490576, 45709.54290457053, 53820.0, 59979.0, 61932.0, 61969.38030619636, 62039.37960620336, 8637.179467950535, 8765.904261967255, 8860.955695221483, 8971.82056358856, 8991.055939126298, 13417.396217170446, 13979.860201397856, 14165.220912849893, 14284.642883927985, 14355.641108972359, 12222.816657749963, 12531.373431328215, 12655.361620775906, 12665.176763510342, 12774.23354598727, 12249.755004900031, 12278.07914406441, 12289.815652765394, 12310.26138431697, 12540.0, 12489.0, 12583.68540786451, 12604.202067048893, 12948.185341263197, 12956.546520871725, 7467.887981680387, 7884.0, 8451.915480845113, 8665.0, 9254.028327025566, 12006.21959572625, 12093.213941093802, 12100.939495302468, 12526.749465010831, 12586.937065314614], "value": 8374.121420716237, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.9634259143522, 1484.3172140815223, 1613.5643376288403, 1761.964760704786, 1762.7267773495112, 7741.225877412256, 8357.874631880519, 8382.119877412875, 8941.061188575204, 8948.910510894897, 8458.407911446202, 8767.912320876789, 8796.95601521993, 8813.338999575026, 8823.77940551485, 2243.5288589396246, 2323.571003832648, 2323.604987152188, 2326.546323466916, 2327.278543651465, 2264.230161745006, 2296.5980953333183, 2314.375118717945, 2325.197806756666, 2327.8254130940163, 2262.7058482397265, 2279.7492275849645, 2299.620562607168, 2300.0799680127916, 2317.8377513574055, 2257.3905045637584, 2280.1905323610126, 2283.794458498735, 2289.954200915989, 2291.3355127013147, 2226.688263643075, 2231.564844855254, 2236.3514580771557, 2237.093976939342, 2240.630296001158, 8612.39713220075, 8744.081871403474, 8753.124687531195, 8811.471311721318, 8834.381593288472, 5049.798008079672, 5141.794328226866, 5143.3570803649545, 5145.33110695611, 5158.329417175781, 3298.175456135966, 3335.633080361158, 3445.689887910075, 3452.067941655739, 3459.705924996378, 1190.8630507491662, 1193.0714653771413, 1195.9820602690966, 1196.1029228078942, 1211.4306276050243, 11919.463624136848, 11968.521259149711, 11971.580994665232, 11972.401379931056, 11995.400229988465, 4283.421738065384, 4317.740935543878, 4487.573680500347, 4494.820207191676, 4527.683062185615, 10163.94918025405, 10194.490275486196, 10194.796104077877, 10214.233932454947, 10215.693529193988, 5142.717150556755, 5149.639525233198, 5168.793248270103, 5170.3278573785165, 5185.740712964337, 4166.479190101238, 4573.5426457354, 4708.576228139415, 4731.739754313477, 4754.0, 3868.5357757069332, 3886.514185726784, 3930.5479869814767, 3975.0658595230097, 4062.695297852673, 1271.4087949103712, 1278.5588971804711, 1281.3913391139135, 1285.395863943945, 1294.5210272199347, 865.3034307382492, 960.1262850805733, 995.1193194023341, 1008.7074748323051, 1016.8220561401725, 6110.358412366726, 6115.694215289218, 6238.875222495615, 6303.684815759194, 6314.968425157845, 439.246691923353, 443.46340927478116, 451.7447642082213, 463.1986663072903, 468.8921548043969, 4173.91652166961, 4278.336857787048, 4296.0, 4353.455818022747, 4359.782010899442, 10218.591256349811, 10672.30630009047, 10689.786204276026, 10745.14038876888, 10762.031417172491, 10644.787104258026, 10655.680329590125, 10661.200409969284, 10667.039966402906, 10667.359958402365, 7658.349040331635, 8006.959965200137, 8038.477498962666, 8064.919350806535, 8138.877916831252, 6126.724297406717, 6169.722362493609, 6323.779505568203, 6340.873182536416, 6505.316941721051, 9841.85237221428, 9885.357451765612, 10040.69877903664, 10172.440515771703, 10189.133923616278, 9950.900490994998, 10111.949440252753, 10114.8482772757, 10141.29010969225, 10257.435841028517, 6815.284395138439, 7450.36671882896, 7470.962645186739, 7531.096268447822, 7722.884156737541, 8498.150184981452, 8532.274756645505, 8575.056743758307, 8592.613332399931, 8624.353173511887, 7448.14346350155, 7705.922940770521, 7753.340966017726, 7828.569428681477, 7852.60736963161, 7507.66215520292, 7662.348700360531, 7679.116901556169, 7746.728864489716, 7776.688932442639, 7310.926890731024, 7325.523840950321, 7362.7423040193335, 7364.742234021784, 7374.225706300761, 5349.598780091586, 5373.570114390761, 5505.834824955257, 5519.806806761744, 5642.85892852682, 5306.097963346163, 5465.726713664221, 5567.415421380697, 5630.239917611234, 5673.546116310603], "value": 4552.454192652477, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.5502651314673, 324.53429328913006, 329.1146815067467, 331.6782720760863, 334.3079824762739, 5628.409017053206, 5674.489295963363, 5690.687012214326, 5695.8576035599135, 5765.1352297155345, 5583.553315734742, 5584.581156413265, 5591.552675785938, 5650.29371328584, 5664.830055098343, 4131.380292956051, 4283.100548884722, 4371.409859668952, 4381.904523869032, 4411.757353345581, 4349.847755328564, 4378.190034843548, 4393.2970724684055, 4416.690831641787, 4417.337399390085, 4372.775622825598, 4409.316555933835, 4421.38100665907, 4435.135148646015, 4437.179121862449, 4313.1158112586845, 4325.4593175853015, 4329.393884856123, 4339.392485052095, 4356.869293921188, 3831.6934645228316, 3837.7527303626152, 3849.903752406184, 3882.010087427716, 3886.689064874803, 5476.972615136939, 5524.8342549723575, 5524.972375138099, 5549.306336707911, 5551.639143455663, 4882.0, 5049.798008079709, 5056.81164926242, 5060.569851562622, 5074.264231686385, 5876.794312199096, 5906.320773111104, 5910.202122713422, 5939.881202375971, 5951.232676805306, 4271.893202669927, 4274.978625106885, 4282.48610166782, 4284.657227421799, 4300.096979634281, 5981.9401805981815, 6115.969420152871, 6121.0, 6133.601315914496, 6141.017437210025, 4374.671899607542, 4387.648988080946, 4387.780610969438, 4392.890177745582, 4399.296112621965, 4399.560043995639, 4424.469063712375, 4424.778761061934, 4435.2016637005645, 4442.2892337225885, 4954.752262386938, 5014.373203349582, 5016.0971025215085, 5039.69761814285, 5064.696118232918, 5855.912161317584, 5933.317668468181, 5957.940420595739, 5975.267172519921, 5978.282606087298, 1475.4024620028906, 1516.924153792306, 1535.385845661722, 1542.0901668015924, 1543.1435553268043, 954.4893481987103, 975.9560819763128, 991.5339790298548, 1006.1950439648252, 1016.6848277034143, 5672.404397538282, 5677.17680936262, 5695.971520142372, 5696.857578560569, 5706.514946229617, 6014.218151640346, 6046.818595442144, 6055.273367195965, 6068.96689608986, 6107.4197951194565, 5562.666240025612, 5798.82603521895, 5822.214001109796, 5835.883282334415, 5882.176495290577, 3271.004687140842, 3296.522004309362, 3300.35643049603, 3307.9834600826844, 3309.7848639838335, 6055.394460553997, 6345.936540634627, 6368.235811702532, 6377.362263773585, 6399.584027038228, 6189.195404597373, 6217.875642487215, 6229.56393052482, 6234.314225435199, 6237.563370564017, 5976.432238937294, 6305.716242769178, 6358.33237510064, 6386.16979792624, 6387.872242555123, 6060.545459090674, 6063.8180854572665, 6069.878602428015, 6108.419700128481, 6121.47967422774, 6058.333583305921, 6079.270487541523, 6087.391260873877, 6098.939010609837, 6119.510439164945, 6000.609960352563, 6261.5616906816085, 6355.396237357444, 6387.616742995435, 6443.2590252119735, 4321.913561728811, 4323.913521729611, 4339.153864996421, 4344.6089851913475, 4348.608625223618, 5901.793437229677, 6183.752649894134, 6188.845278868064, 6216.502679785516, 6242.687865606792, 5986.341502434816, 6025.216721826135, 6068.150458935841, 6068.21113255274, 6095.75037117381, 6044.607100538451, 6044.727987240497, 6059.6364218147055, 6068.179546136053, 6070.757169713339, 5514.862128446821, 5589.720513974204, 5800.854978625568, 5889.733707252961, 5966.254218222723, 6008.956954635445, 6021.548383871314, 6022.187004754477, 6092.512598992159, 6097.817065487865, 5629.634073785354, 5815.854603634773, 5900.527957763455, 5919.674417906885, 5950.434708702666], "value": 4528.963904607519, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.5299767142043, 772.8222508822971, 826.5701835045772, 829.2619568583959, 889.5863423508067, 14204.147751134926, 15020.0, 15069.39722411105, 15092.094474331534, 15120.546383608496, 14065.226412547307, 14229.644258893533, 14229.715405691906, 14260.0, 15014.774778378305, 644.680882962934, 792.2790260862616, 811.1726039439768, 811.5658122904248, 811.7240138352959, 794.3168874767695, 795.1372760554805, 802.9598520074002, 804.6057431858377, 804.9235322644369, 827.4786884262905, 830.3481766813053, 831.4346244553701, 834.0658462521953, 836.4103307168432, 827.0778082438098, 827.8675411934091, 830.0827585517976, 832.92087251711, 833.071125694852, 593.8841925824466, 594.9553783466214, 597.0357872036673, 599.3886236039216, 599.8830228105521, 14963.625909352244, 14974.326155323037, 15002.0, 15002.399904003827, 15016.399344026226, 15754.606134846606, 15881.205939702968, 16074.678506429806, 16119.597010074725, 16417.0, 12109.818352724717, 12155.93922030393, 12206.267623942593, 12414.131010829245, 12858.742825143445, 3945.1320709443876, 3987.4218238355566, 4054.776987265699, 4084.8978775530554, 4090.1819636072605, 78808.0, 81304.59347703283, 81369.0, 81463.59268203621, 81591.59204204, 12110.576129835414, 12260.877391225973, 12394.75210495785, 12798.16811907223, 12827.166234194934, 23098.65352019721, 23475.295741127793, 23497.17759878396, 23669.408264793172, 23703.525929481657, 8670.86993695095, 8699.826003479895, 8759.386842921062, 8800.339974501938, 8940.955295223612, 4169.082801783603, 4225.471816022997, 4363.410939523187, 4377.146456440963, 4392.121575684876, 3391.6947474727394, 3465.8440370183403, 3501.439769636846, 3507.7369197310304, 3512.7365447591533, 592.5822295281902, 596.0850095103995, 596.4810614765182, 604.6432604763211, 605.252513146264, 730.8428687832142, 738.6454501839147, 763.5609524523421, 776.8679324514733, 779.473855147773, 10190.753571037967, 10685.946570267099, 10789.298695584763, 11348.943255283672, 11843.58547450835, 658.2430205263985, 693.4244577001077, 800.9118996910336, 829.7113810887181, 831.5135645647243, 4957.182064959241, 5104.2343648453025, 5106.234064890222, 5116.948830511722, 5128.538431541179, 120824.39587802005, 121278.0, 122136.0, 122174.85178038059, 124271.0, 61137.69431152816, 105587.0, 106048.0, 107139.46430267955, 107906.46046769716, 67488.0, 88545.55727221322, 88828.11171888327, 89110.0, 91217.08782912219, 9755.902440975784, 9761.9023809761, 9938.403695778277, 9972.30193886421, 10020.498975051072, 52087.0, 54217.74693518401, 54256.72871635616, 54977.45022549883, 55686.0, 80823.0, 81466.0, 83349.16650833414, 84361.0, 84687.5765621168, 12334.75330493403, 12636.810447843105, 12845.550405735754, 12891.742165156456, 13187.142835715647, 14610.196439195946, 14825.925870371011, 14910.627234319229, 15040.623984400478, 15516.612084697521, 12710.0, 12750.553730619384, 12829.87170128324, 13004.349782511026, 13389.464421423034, 12983.610491685264, 13544.661383465493, 13551.59345219645, 13617.863821362056, 13726.45094196221, 12679.0, 13280.468781248643, 13296.268705221306, 13312.600621980968, 13859.099158554662, 10442.29102968861, 10764.372203014309, 10789.980732177413, 11086.833697494705, 11136.0, 10144.847827282745, 10436.478176091317, 10563.63027294041, 11260.38067906273, 11358.886411135783], "value": 7683.526467898056, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 106.0, 112.0, 112.0, 112.0, 111.0, 110.0, 114.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 118.0, 142.0, 177.0, 120.0, 153.0, 147.0, 122.0, 186.0, 121.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 161.0, 164.0, 162.0, 164.0, 167.0, 171.0, 163.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 149.0, 77.0, 75.0, 86.0, 75.0, 165.0, 76.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 150.0, 86.0, 87.0, 87.0, 142.0, 86.0, 85.0, 169.0], "value": 106.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 121.0, 117.0, 118.0, 117.0, 119.0, 117.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 147.0, 150.0, 150.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 100.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 56.0, 54.0, 56.0, 57.0, 60.0, 53.0, 56.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 60.0, 61.0, 61.0, 60.0, 60.0, 62.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 75.0, 74.0, 75.0, 77.0, 74.0, 76.0, 80.0, 81.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 118.0, 120.0, 133.0, 126.0, 122.0, 120.0, 122.0, 180.0, 123.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 160.0, 156.0, 156.0, 157.0, 154.0, 161.0, 159.0, 163.0, 158.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 65.0, 67.0, 65.0, 64.0, 64.0, 63.0, 63.0], "value": 64.6, "unit": "score"}]}]} 20:27:59 INFO - Return code: 0 20:27:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:27:59 ERROR - # TBPL SUCCESS # 20:27:59 INFO - Running post-action listener: _resource_record_post_action 20:27:59 INFO - ##### 20:27:59 INFO - ##### Finished run-tests step (success) 20:27:59 INFO - ##### 20:27:59 INFO - Running post-run listener: _resource_record_post_run 20:27:59 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 565268480; Read time: 0; Write time: 510808 20:27:59 INFO - TinderboxPrint: CPU usage
13.3% 20:27:59 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:27:59 INFO - TinderboxPrint: I/O write bytes / time
565,268,480 / 510,808 20:27:59 INFO - TinderboxPrint: CPU idle
8,244.4 (86.7%) 20:27:59 INFO - TinderboxPrint: CPU user
1,213.3 (12.8%) 20:27:59 INFO - TinderboxPrint: Swap in / out
0 / 0 20:27:59 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 269533184; Read time: 0; Write time: 283904 20:27:59 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295735296; Read time: 0; Write time: 226904 20:27:59 INFO - Running post-run listener: _upload_blobber_files 20:27:59 INFO - Blob upload gear active. 20:27:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:27:59 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 20:27:59 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:27:59 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:28:00 INFO - (blobuploader) - INFO - Open directory for files ... 20:28:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:28:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:28:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:28:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:28:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:28:00 INFO - (blobuploader) - INFO - Done attempting. 20:28:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:28:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:28:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:28:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:28:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:28:01 INFO - (blobuploader) - INFO - Done attempting. 20:28:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:28:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:28:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:28:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:28:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:28:04 INFO - (blobuploader) - INFO - Done attempting. 20:28:04 INFO - (blobuploader) - INFO - Iteration through files over. 20:28:04 INFO - Return code: 0 20:28:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:28:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:28:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/76404c93ea3f08d79a9c1ea6d5b74a41938e1a0fc9a1d014774faa3436c565b59ab32501784dc5994b09985dc7af93ab4a6332fe496128670067d35640cc19f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ce29af4b0d87e70d60d2621bc5325d6070877b0840e84e137b4a1df4920ea3beb116b9cb656e8a2bf61c35f07246f06ca1641f391299fc83464bbcbd529aeb71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/249a6631358fb5e3101ab28214612b899202818bd40789e034bbb4fb778702d4df9d2dc2567cd98de709009d4385d2b557a828ca88d9334d80149fab382c6d54"} 20:28:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:28:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:28:04 INFO - Contents: 20:28:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/76404c93ea3f08d79a9c1ea6d5b74a41938e1a0fc9a1d014774faa3436c565b59ab32501784dc5994b09985dc7af93ab4a6332fe496128670067d35640cc19f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ce29af4b0d87e70d60d2621bc5325d6070877b0840e84e137b4a1df4920ea3beb116b9cb656e8a2bf61c35f07246f06ca1641f391299fc83464bbcbd529aeb71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/249a6631358fb5e3101ab28214612b899202818bd40789e034bbb4fb778702d4df9d2dc2567cd98de709009d4385d2b557a828ca88d9334d80149fab382c6d54"} 20:28:04 INFO - Running post-run listener: copy_logs_to_upload_dir 20:28:04 INFO - Copying logs to upload dir... 20:28:04 INFO - mkdir: /builds/slave/test/build/upload/logs 20:28:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.773603 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-07 20:28:04.649202) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 20:28:04.652451) ========= 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=7de08804244eb36560b44971000001c3-1467946881.67455-1017688133 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/Autoland/sha512/76404c93ea3f08d79a9c1ea6d5b74a41938e1a0fc9a1d014774faa3436c565b59ab32501784dc5994b09985dc7af93ab4a6332fe496128670067d35640cc19f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ce29af4b0d87e70d60d2621bc5325d6070877b0840e84e137b4a1df4920ea3beb116b9cb656e8a2bf61c35f07246f06ca1641f391299fc83464bbcbd529aeb71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/249a6631358fb5e3101ab28214612b899202818bd40789e034bbb4fb778702d4df9d2dc2567cd98de709009d4385d2b557a828ca88d9334d80149fab382c6d54"} build_url:https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011393 build_url: 'https://queue.taskcluster.net/v1/task/DgS2uUrlQ_ShWaXAkmWlgQ/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/Autoland/sha512/76404c93ea3f08d79a9c1ea6d5b74a41938e1a0fc9a1d014774faa3436c565b59ab32501784dc5994b09985dc7af93ab4a6332fe496128670067d35640cc19f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ce29af4b0d87e70d60d2621bc5325d6070877b0840e84e137b4a1df4920ea3beb116b9cb656e8a2bf61c35f07246f06ca1641f391299fc83464bbcbd529aeb71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/249a6631358fb5e3101ab28214612b899202818bd40789e034bbb4fb778702d4df9d2dc2567cd98de709009d4385d2b557a828ca88d9334d80149fab382c6d54"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 20:28:04.677944) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:28:04.678287) ========= 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=7de08804244eb36560b44971000001c3-1467946881.67455-1017688133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:28:04.760939) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 20:28:04.761285) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 20:28:04.761597) ========= ========= Total master_lag: 0.18 =========