builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1468370778.18 results: success (0) buildid: 20160712162527 builduid: 572c3ed1d9bf48eaba41e5b218010d1a revision: 04821a70c739a00d12e12df651c0989441e22728 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 17:46:18.179545) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 17:46:18.179973) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 17:46:18.180332) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 17:46:18.237905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 17:46:18.238216) ========= 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=5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 17:46:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2016-07-12 17:46:18 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084503 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 17:46:18.353212) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 17:46:18.353562) ========= 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=5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021252 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 17:46:18.421870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 17:46:18.422524) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 04821a70c739a00d12e12df651c0989441e22728 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 04821a70c739a00d12e12df651c0989441e22728 --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=5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 17:46:18,913 truncating revision to first 12 chars 2016-07-12 17:46:18,913 Setting DEBUG logging. 2016-07-12 17:46:18,913 attempt 1/10 2016-07-12 17:46:18,913 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/04821a70c739?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 17:46:19,215 unpacking tar archive at: mozilla-central-04821a70c739/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630288 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 17:46:19.067534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 17:46:19.067860) ========= script_repo_revision: 04821a70c739a00d12e12df651c0989441e22728 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 17:46:19.068335) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 17:46:19.068647) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 17:46:19.077656) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-07-12 17:46:19.078100) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:46:19 INFO - MultiFileLogger online at 20160712 17:46:19 in /builds/slave/test 17:46:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:46:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:46:19 INFO - {'append_to_log': False, 17:46:19 INFO - 'base_work_dir': '/builds/slave/test', 17:46:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:46:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:46:19 INFO - 'branch': 'Firefox-Non-PGO', 17:46:19 INFO - 'buildbot_json_path': 'buildprops.json', 17:46:19 INFO - 'config_files': ('talos/linux_config.py',), 17:46:19 INFO - 'default_actions': ('clobber', 17:46:19 INFO - 'read-buildbot-config', 17:46:19 INFO - 'download-and-extract', 17:46:19 INFO - 'populate-webroot', 17:46:19 INFO - 'create-virtualenv', 17:46:19 INFO - 'install', 17:46:19 INFO - 'run-tests'), 17:46:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:46:19 INFO - 'download_minidump_stackwalk': True, 17:46:19 INFO - 'download_symbols': 'ondemand', 17:46:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:46:19 INFO - 'tooltool.py': '/tools/tooltool.py', 17:46:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:46:19 INFO - '/tools/misc-python/virtualenv.py')}, 17:46:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:46:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:46:19 INFO - 'installer_path': 'installer.exe', 17:46:19 INFO - 'log_level': 'info', 17:46:19 INFO - 'log_name': 'talos', 17:46:19 INFO - 'log_to_console': True, 17:46:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:46:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:46:19 INFO - 'opt_config_files': (), 17:46:19 INFO - 'pip_index': False, 17:46:19 INFO - 'sps_profile': False, 17:46:19 INFO - 'sps_profile_interval': 0, 17:46:19 INFO - 'suite': 'dromaeojs-e10s', 17:46:19 INFO - 'system_bits': '32', 17:46:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:46:19 INFO - 'title': 'talos-linux64-ix-011', 17:46:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:46:19 INFO - 'use_talos_json': True, 17:46:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:46:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:46:19 INFO - 'work_dir': 'build'} 17:46:19 INFO - ##### 17:46:19 INFO - ##### Running clobber step. 17:46:19 INFO - ##### 17:46:19 INFO - Running pre-action listener: _resource_record_pre_action 17:46:19 INFO - Running main action method: clobber 17:46:19 INFO - rmtree: /builds/slave/test/build 17:46:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:46:20 INFO - Running post-action listener: _resource_record_post_action 17:46:20 INFO - ##### 17:46:20 INFO - ##### Finished clobber step (success) 17:46:20 INFO - ##### 17:46:20 INFO - ##### 17:46:20 INFO - ##### Running read-buildbot-config step. 17:46:20 INFO - ##### 17:46:20 INFO - Running pre-action listener: _resource_record_pre_action 17:46:20 INFO - Running main action method: read_buildbot_config 17:46:20 INFO - Using buildbot properties: 17:46:20 INFO - { 17:46:20 INFO - "project": "", 17:46:20 INFO - "product": "firefox", 17:46:20 INFO - "script_repo_revision": "production", 17:46:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:46:20 INFO - "repository": "", 17:46:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:46:20 INFO - "buildid": "20160712162527", 17:46:20 INFO - "pgo_build": "False", 17:46:20 INFO - "basedir": "/builds/slave/test", 17:46:20 INFO - "buildnumber": 122, 17:46:20 INFO - "slavename": "talos-linux64-ix-011", 17:46:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:46:20 INFO - "platform": "ubuntu64_hw", 17:46:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:46:20 INFO - "branch": "mozilla-central", 17:46:20 INFO - "repo_path": "mozilla-central", 17:46:20 INFO - "revision": "04821a70c739a00d12e12df651c0989441e22728", 17:46:20 INFO - "stage_platform": "linux64", 17:46:20 INFO - "builduid": "572c3ed1d9bf48eaba41e5b218010d1a", 17:46:20 INFO - "slavebuilddir": "test" 17:46:20 INFO - } 17:46:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:46:20 INFO - Running post-action listener: _resource_record_post_action 17:46:20 INFO - ##### 17:46:20 INFO - ##### Finished read-buildbot-config step (success) 17:46:20 INFO - ##### 17:46:20 INFO - ##### 17:46:20 INFO - ##### Running download-and-extract step. 17:46:20 INFO - ##### 17:46:20 INFO - Running pre-action listener: _resource_record_pre_action 17:46:20 INFO - Running main action method: download_and_extract 17:46:20 INFO - mkdir: /builds/slave/test/build/tests 17:46:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:20 INFO - https://queue.taskcluster.net/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:46:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:46:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:46:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/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 17:46:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/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 17:46:29 INFO - Downloaded 1361 bytes. 17:46:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:46:29 INFO - Using the following test package requirements: 17:46:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:46:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:46:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:46:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:29 INFO - u'jsshell-linux-x86_64.zip'], 17:46:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:46:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:46:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:46:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:46:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:46:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:46:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:46:29 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')]} 17:46:29 INFO - https://queue.taskcluster.net/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:46:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:46:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:46:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/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 17:46:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/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 17:46:32 INFO - Downloaded 22750890 bytes. 17:46:32 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'] 17:46:32 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 17:46:33 INFO - Return code: 0 17:46:33 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 17:46:33 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')]} 17:46:33 INFO - https://queue.taskcluster.net/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:46:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:46:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:46:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/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 17:46:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/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 17:46:45 INFO - Downloaded 22750890 bytes. 17:46:45 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'] 17:46:45 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 17:46:46 INFO - Return code: 0 17:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:46 INFO - https://queue.taskcluster.net/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:46:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:46:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:46:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/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 17:46:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/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 17:46:47 INFO - Downloaded 14403317 bytes. 17:46:47 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'] 17:46:47 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 17:46:47 INFO - Return code: 0 17:46:47 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')]} 17:46:47 INFO - https://queue.taskcluster.net/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:46:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:46:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:46:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/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 17:46:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/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 17:46:49 INFO - Downloaded 57012181 bytes. 17:46:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:46:49 INFO - mkdir: /builds/slave/test/properties 17:46:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:46:49 INFO - Writing to file /builds/slave/test/properties/build_url 17:46:49 INFO - Contents: 17:46:49 INFO - build_url:https://queue.taskcluster.net/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:46:50 INFO - Running post-action listener: _resource_record_post_action 17:46:50 INFO - Running post-action listener: set_extra_try_arguments 17:46:50 INFO - ##### 17:46:50 INFO - ##### Finished download-and-extract step (success) 17:46:50 INFO - ##### 17:46:50 INFO - ##### 17:46:50 INFO - ##### Running populate-webroot step. 17:46:50 INFO - ##### 17:46:50 INFO - Running pre-action listener: _resource_record_pre_action 17:46:50 INFO - Running main action method: populate_webroot 17:46:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:46:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:46:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:46:50 INFO - '--tppagecycles', 17:46:50 INFO - '7'], 17:46:50 INFO - 'tests': ['tsvgm']}}, 17:46:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:46:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:46:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:46:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:46:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:46:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:46:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:50 INFO - 'talos_options': ['--disable-e10s'], 17:46:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:46:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:46:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:50 INFO - 'talos_options': ['--disable-e10s'], 17:46:50 INFO - 'tests': ['damp', 'tps']}, 17:46:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:50 INFO - 'tests': ['damp', 'tps']}, 17:46:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:46:50 INFO - 'tests': ['dromaeo_dom']}, 17:46:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:46:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:46:50 INFO - 'tests': ['basic_compositor_video']}, 17:46:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:46:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:46:50 INFO - 'tests': ['a11yr', 17:46:50 INFO - 'ts_paint', 17:46:50 INFO - 'tpaint', 17:46:50 INFO - 'sessionrestore', 17:46:50 INFO - 'sessionrestore_no_auto_restore', 17:46:50 INFO - 'tabpaint']}, 17:46:50 INFO - 'other-e10s': {'tests': ['a11yr', 17:46:50 INFO - 'ts_paint', 17:46:50 INFO - 'tpaint', 17:46:50 INFO - 'sessionrestore', 17:46:50 INFO - 'sessionrestore_no_auto_restore', 17:46:50 INFO - 'tabpaint']}, 17:46:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:46:50 INFO - 'ts_paint', 17:46:50 INFO - 'tpaint', 17:46:50 INFO - 'sessionrestore', 17:46:50 INFO - 'sessionrestore_no_auto_restore', 17:46:50 INFO - 'tabpaint']}, 17:46:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:46:50 INFO - 'ts_paint', 17:46:50 INFO - 'tpaint', 17:46:50 INFO - 'sessionrestore', 17:46:50 INFO - 'sessionrestore_no_auto_restore', 17:46:50 INFO - 'tabpaint']}, 17:46:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:46:50 INFO - 'tests': ['a11yr', 17:46:50 INFO - 'ts_paint', 17:46:50 INFO - 'tpaint', 17:46:50 INFO - 'sessionrestore', 17:46:50 INFO - 'sessionrestore_no_auto_restore', 17:46:50 INFO - 'tabpaint']}, 17:46:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:46:50 INFO - 'tests': ['a11yr', 17:46:50 INFO - 'ts_paint', 17:46:50 INFO - 'tpaint', 17:46:50 INFO - 'sessionrestore', 17:46:50 INFO - 'sessionrestore_no_auto_restore', 17:46:50 INFO - 'tabpaint']}, 17:46:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:46:50 INFO - 'tests': ['tsvgx', 17:46:50 INFO - 'tsvgr_opacity', 17:46:50 INFO - 'tart', 17:46:50 INFO - 'tscrollx', 17:46:50 INFO - 'cart']}, 17:46:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:46:50 INFO - 'tsvgr_opacity', 17:46:50 INFO - 'tart', 17:46:50 INFO - 'tscrollx', 17:46:50 INFO - 'cart']}, 17:46:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:50 INFO - 'talos_options': ['--disable-e10s'], 17:46:50 INFO - 'tests': ['tp5o']}, 17:46:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:50 INFO - 'tests': ['tp5o']}, 17:46:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:50 INFO - 'talos_options': ['--disable-e10s', 17:46:50 INFO - '--xperf_path', 17:46:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:46:50 INFO - 'tests': ['tp5n']}, 17:46:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:50 INFO - 'talos_options': ['--xperf_path', 17:46:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:46:50 INFO - 'tests': ['tp5n']}}, 17:46:50 INFO - 'talos.zip': {'path': '', 17:46:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:46:50 INFO - Running post-action listener: _resource_record_post_action 17:46:50 INFO - ##### 17:46:50 INFO - ##### Finished populate-webroot step (success) 17:46:50 INFO - ##### 17:46:50 INFO - ##### 17:46:50 INFO - ##### Running create-virtualenv step. 17:46:50 INFO - ##### 17:46:50 INFO - Running pre-action listener: _resource_record_pre_action 17:46:50 INFO - Running main action method: create_virtualenv 17:46:50 INFO - Creating virtualenv /builds/slave/test/build/venv 17:46:50 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 17:46:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:46:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:46:50 INFO - Using real prefix '/usr' 17:46:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:46:50 INFO - Installing distribute.............................................................................................................................................................................................done. 17:46:52 INFO - Installing pip.................done. 17:46:52 INFO - Return code: 0 17:46:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:52 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 0xabe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xced400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c570>, '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 0xd7d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7d900>, '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': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', '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 17:46:52 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 17:46:52 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 17:46:52 INFO - Using env: {'DISPLAY': ':0', 17:46:52 INFO - 'HOME': '/home/cltbld', 17:46:52 INFO - 'LANG': 'en_US.UTF-8', 17:46:52 INFO - 'LANGUAGE': 'en_US:en', 17:46:52 INFO - 'LOGNAME': 'cltbld', 17:46:52 INFO - 'MAIL': '/var/mail/cltbld', 17:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:52 INFO - 'MOZ_NO_REMOTE': '1', 17:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:52 INFO - 'NO_EM_RESTART': '1', 17:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:52 INFO - 'PWD': '/builds/slave/test', 17:46:52 INFO - 'SHELL': '/bin/bash', 17:46:52 INFO - 'SHLVL': '1', 17:46:52 INFO - 'TERM': 'linux', 17:46:52 INFO - 'TMOUT': '86400', 17:46:52 INFO - 'USER': 'cltbld', 17:46:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', 17:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:52 INFO - '_': '/tools/buildbot/bin/python'} 17:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:53 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 17:46:53 INFO - Cleaning up... 17:46:53 INFO - Return code: 0 17:46:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:46: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')]} 17:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46: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')]} 17:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46: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', '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 0xabe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xced400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c570>, '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 0xd7d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7d900>, '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': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', '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 17:46: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:46: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 psutil>=3.1.1 17:46:53 INFO - Using env: {'DISPLAY': ':0', 17:46:53 INFO - 'HOME': '/home/cltbld', 17:46:53 INFO - 'LANG': 'en_US.UTF-8', 17:46:53 INFO - 'LANGUAGE': 'en_US:en', 17:46:53 INFO - 'LOGNAME': 'cltbld', 17:46:53 INFO - 'MAIL': '/var/mail/cltbld', 17:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:53 INFO - 'MOZ_NO_REMOTE': '1', 17:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:53 INFO - 'NO_EM_RESTART': '1', 17:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:53 INFO - 'PWD': '/builds/slave/test', 17:46:53 INFO - 'SHELL': '/bin/bash', 17:46:53 INFO - 'SHLVL': '1', 17:46:53 INFO - 'TERM': 'linux', 17:46:53 INFO - 'TMOUT': '86400', 17:46:53 INFO - 'USER': 'cltbld', 17:46:53 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', 17:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:53 INFO - '_': '/tools/buildbot/bin/python'} 17:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:53 INFO - Downloading/unpacking psutil>=3.1.1 17:46: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 17:46: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 17:46: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 17:46: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 17:46: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 17:46: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 17:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:46:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:46:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:46:55 INFO - Installing collected packages: psutil 17:46:55 INFO - Running setup.py install for psutil 17:46:55 INFO - building 'psutil._psutil_linux' extension 17:46:55 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 17:46:55 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 17:46:55 INFO - building 'psutil._psutil_posix' extension 17:46:55 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 17:46:55 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 17:46:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:46:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:46:55 INFO - Successfully installed psutil 17:46:55 INFO - Cleaning up... 17:46:55 INFO - Return code: 0 17:46:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:46: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')]} 17:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46: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')]} 17:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xabe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xced400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c570>, '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 0xd7d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7d900>, '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': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', '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 17:46: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:46: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 mozsystemmonitor==0.3 17:46:55 INFO - Using env: {'DISPLAY': ':0', 17:46:55 INFO - 'HOME': '/home/cltbld', 17:46:55 INFO - 'LANG': 'en_US.UTF-8', 17:46:55 INFO - 'LANGUAGE': 'en_US:en', 17:46:55 INFO - 'LOGNAME': 'cltbld', 17:46:55 INFO - 'MAIL': '/var/mail/cltbld', 17:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:55 INFO - 'MOZ_NO_REMOTE': '1', 17:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:55 INFO - 'NO_EM_RESTART': '1', 17:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:55 INFO - 'PWD': '/builds/slave/test', 17:46:55 INFO - 'SHELL': '/bin/bash', 17:46:55 INFO - 'SHLVL': '1', 17:46:55 INFO - 'TERM': 'linux', 17:46:55 INFO - 'TMOUT': '86400', 17:46:55 INFO - 'USER': 'cltbld', 17:46:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', 17:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:55 INFO - '_': '/tools/buildbot/bin/python'} 17:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:46: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 17:46: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 17:46: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 17:46: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 17:46: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 17:46: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 17:46:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:46:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:46:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:46:57 INFO - Installing collected packages: mozsystemmonitor 17:46:57 INFO - Running setup.py install for mozsystemmonitor 17:46:58 INFO - Successfully installed mozsystemmonitor 17:46:58 INFO - Cleaning up... 17:46:58 INFO - Return code: 0 17:46:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:58 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 0xabe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xced400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c570>, '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 0xd7d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7d900>, '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': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', '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 17:46:58 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 17:46:58 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 17:46:58 INFO - Using env: {'DISPLAY': ':0', 17:46:58 INFO - 'HOME': '/home/cltbld', 17:46:58 INFO - 'LANG': 'en_US.UTF-8', 17:46:58 INFO - 'LANGUAGE': 'en_US:en', 17:46:58 INFO - 'LOGNAME': 'cltbld', 17:46:58 INFO - 'MAIL': '/var/mail/cltbld', 17:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:58 INFO - 'MOZ_NO_REMOTE': '1', 17:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:58 INFO - 'NO_EM_RESTART': '1', 17:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:58 INFO - 'PWD': '/builds/slave/test', 17:46:58 INFO - 'SHELL': '/bin/bash', 17:46:58 INFO - 'SHLVL': '1', 17:46:58 INFO - 'TERM': 'linux', 17:46:58 INFO - 'TMOUT': '86400', 17:46:58 INFO - 'USER': 'cltbld', 17:46:58 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', 17:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:58 INFO - '_': '/tools/buildbot/bin/python'} 17:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:58 INFO - Downloading/unpacking jsonschema==2.5.1 17:46: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 17:46: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 17:46: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 17:46: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 17:46: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 17:46: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 17:47:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:47:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:47:00 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 17:47:00 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 17:47:00 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 17:47:00 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 17:47:00 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 17:47:00 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 17:47:00 INFO - Downloading functools32-3.2.3-2.tar.gz 17:47:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:47:00 INFO - warning: no files found matching '*.txt' 17:47:00 INFO - no previously-included directories found matching 'build' 17:47:00 INFO - no previously-included directories found matching 'dist' 17:47:00 INFO - no previously-included directories found matching '.git*' 17:47:00 INFO - Installing collected packages: jsonschema, functools32 17:47:00 INFO - Running setup.py install for functools32 17:47:00 INFO - warning: no files found matching '*.txt' 17:47:00 INFO - no previously-included directories found matching 'build' 17:47:00 INFO - no previously-included directories found matching 'dist' 17:47:00 INFO - no previously-included directories found matching '.git*' 17:47:00 INFO - Successfully installed jsonschema functools32 17:47:00 INFO - Cleaning up... 17:47:00 INFO - Return code: 0 17:47:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:47:00 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')]} 17:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:00 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')]} 17:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:00 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 0xabe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xced400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c570>, '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 0xd7d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7d900>, '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': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', '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 17:47:00 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 17:47:00 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 17:47:00 INFO - Using env: {'DISPLAY': ':0', 17:47:00 INFO - 'HOME': '/home/cltbld', 17:47:00 INFO - 'LANG': 'en_US.UTF-8', 17:47:00 INFO - 'LANGUAGE': 'en_US:en', 17:47:00 INFO - 'LOGNAME': 'cltbld', 17:47:00 INFO - 'MAIL': '/var/mail/cltbld', 17:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:00 INFO - 'MOZ_NO_REMOTE': '1', 17:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:00 INFO - 'NO_EM_RESTART': '1', 17:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:00 INFO - 'PWD': '/builds/slave/test', 17:47:00 INFO - 'SHELL': '/bin/bash', 17:47:00 INFO - 'SHLVL': '1', 17:47:00 INFO - 'TERM': 'linux', 17:47:00 INFO - 'TMOUT': '86400', 17:47:00 INFO - 'USER': 'cltbld', 17:47:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', 17:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:00 INFO - '_': '/tools/buildbot/bin/python'} 17:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:00 INFO - Downloading/unpacking blobuploader==1.2.4 17:47:00 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 17:47:00 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 17:47:00 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 17:47:00 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 17:47:00 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 17:47:00 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 17:47:02 INFO - Downloading blobuploader-1.2.4.tar.gz 17:47:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:47:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:47:02 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 17:47:02 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 17:47:02 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 17:47:02 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 17:47:02 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 17:47:02 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 17:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:47:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:47:03 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 17:47:03 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 17:47:03 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 17:47:03 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 17:47:03 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 17:47:03 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 17:47:03 INFO - Downloading docopt-0.6.1.tar.gz 17:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:47:03 INFO - Installing collected packages: blobuploader, requests, docopt 17:47:03 INFO - Running setup.py install for blobuploader 17:47:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:47:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:47:03 INFO - Running setup.py install for requests 17:47:04 INFO - Running setup.py install for docopt 17:47:04 INFO - Successfully installed blobuploader requests docopt 17:47:04 INFO - Cleaning up... 17:47:04 INFO - Return code: 0 17:47:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:04 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 0xabe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xced400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c570>, '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 0xd7d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7d900>, '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': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', '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 17:47:04 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 17:47:04 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 17:47:04 INFO - Using env: {'DISPLAY': ':0', 17:47:04 INFO - 'HOME': '/home/cltbld', 17:47:04 INFO - 'LANG': 'en_US.UTF-8', 17:47:04 INFO - 'LANGUAGE': 'en_US:en', 17:47:04 INFO - 'LOGNAME': 'cltbld', 17:47:04 INFO - 'MAIL': '/var/mail/cltbld', 17:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:04 INFO - 'MOZ_NO_REMOTE': '1', 17:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:04 INFO - 'NO_EM_RESTART': '1', 17:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:04 INFO - 'PWD': '/builds/slave/test', 17:47:04 INFO - 'SHELL': '/bin/bash', 17:47:04 INFO - 'SHLVL': '1', 17:47:04 INFO - 'TERM': 'linux', 17:47:04 INFO - 'TMOUT': '86400', 17:47:04 INFO - 'USER': 'cltbld', 17:47:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', 17:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:04 INFO - '_': '/tools/buildbot/bin/python'} 17:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:47:04 INFO - Running setup.py (path:/tmp/pip-bAo2xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:47:04 INFO - Running setup.py (path:/tmp/pip-cfPd5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:47:04 INFO - Running setup.py (path:/tmp/pip-zJUAUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:47:04 INFO - Running setup.py (path:/tmp/pip-Rv8PwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:47:04 INFO - Running setup.py (path:/tmp/pip-Q5GuHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:47:04 INFO - Running setup.py (path:/tmp/pip-P15g77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:47:04 INFO - Running setup.py (path:/tmp/pip-56fy0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:47:04 INFO - Running setup.py (path:/tmp/pip-Tk2gJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:47:04 INFO - Running setup.py (path:/tmp/pip-lYSMyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:47:05 INFO - Running setup.py (path:/tmp/pip-OWtXdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:47:05 INFO - Running setup.py (path:/tmp/pip-jOYk1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:47:05 INFO - Running setup.py (path:/tmp/pip-M419GB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:47:05 INFO - Running setup.py (path:/tmp/pip-yZeEhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:47:05 INFO - Running setup.py (path:/tmp/pip-PEz5Gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:05 INFO - Running setup.py (path:/tmp/pip-RPTHU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:47:05 INFO - Running setup.py (path:/tmp/pip-_UKg2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:47:05 INFO - Running setup.py (path:/tmp/pip-u573JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:47:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:47:05 INFO - Running setup.py install for manifestparser 17:47:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:47:05 INFO - Running setup.py install for mozcrash 17:47:05 INFO - Running setup.py install for mozdebug 17:47:05 INFO - Running setup.py install for mozdevice 17:47:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:47:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:47:06 INFO - Running setup.py install for mozfile 17:47:06 INFO - Running setup.py install for mozhttpd 17:47:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:47:06 INFO - Running setup.py install for mozinfo 17:47:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:47:06 INFO - Running setup.py install for mozInstall 17:47:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:47:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:47:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:47:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:47:06 INFO - Running setup.py install for mozleak 17:47:06 INFO - Running setup.py install for mozlog 17:47:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:47:06 INFO - Running setup.py install for moznetwork 17:47:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:47:06 INFO - Running setup.py install for mozprocess 17:47:06 INFO - Running setup.py install for mozprofile 17:47:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:47:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:47:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:47:06 INFO - Running setup.py install for mozrunner 17:47:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:47:07 INFO - Running setup.py install for mozscreenshot 17:47:07 INFO - Running setup.py install for moztest 17:47:07 INFO - Running setup.py install for mozversion 17:47:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:47:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:47:07 INFO - Cleaning up... 17:47:07 INFO - Return code: 0 17:47:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:07 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 0xabe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xced400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c570>, '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 0xd7d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7d900>, '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': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', '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 17:47:07 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 17:47:07 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 17:47:07 INFO - Using env: {'DISPLAY': ':0', 17:47:07 INFO - 'HOME': '/home/cltbld', 17:47:07 INFO - 'LANG': 'en_US.UTF-8', 17:47:07 INFO - 'LANGUAGE': 'en_US:en', 17:47:07 INFO - 'LOGNAME': 'cltbld', 17:47:07 INFO - 'MAIL': '/var/mail/cltbld', 17:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:07 INFO - 'MOZ_NO_REMOTE': '1', 17:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:07 INFO - 'NO_EM_RESTART': '1', 17:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:07 INFO - 'PWD': '/builds/slave/test', 17:47:07 INFO - 'SHELL': '/bin/bash', 17:47:07 INFO - 'SHLVL': '1', 17:47:07 INFO - 'TERM': 'linux', 17:47:07 INFO - 'TMOUT': '86400', 17:47:07 INFO - 'USER': 'cltbld', 17:47:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', 17:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:07 INFO - '_': '/tools/buildbot/bin/python'} 17:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:47:07 INFO - Running setup.py (path:/tmp/pip-K_w7VQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:47:07 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)) 17:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:47:07 INFO - Running setup.py (path:/tmp/pip-Va3aCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:47:07 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)) 17:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:47:07 INFO - Running setup.py (path:/tmp/pip-IE2R7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:47:07 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)) 17:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:47:07 INFO - Running setup.py (path:/tmp/pip-pZIKXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:47:07 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)) 17:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:47:07 INFO - Running setup.py (path:/tmp/pip-0uCbl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:47:07 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)) 17:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:47:07 INFO - Running setup.py (path:/tmp/pip-prsKfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:47:08 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)) 17:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:47:08 INFO - Running setup.py (path:/tmp/pip-_RSqC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:47:08 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)) 17:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:47:08 INFO - Running setup.py (path:/tmp/pip-TW3Dct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:47:08 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)) 17:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:47:08 INFO - Running setup.py (path:/tmp/pip-3x_1XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:47:08 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)) 17:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:47:08 INFO - Running setup.py (path:/tmp/pip-JxvqJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:47:08 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)) 17:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:47:08 INFO - Running setup.py (path:/tmp/pip-WotX6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:47:08 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)) 17:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:47:08 INFO - Running setup.py (path:/tmp/pip-4qS3fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:47:08 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)) 17:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:47:08 INFO - Running setup.py (path:/tmp/pip-EsAtwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:47:08 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)) 17:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:47:08 INFO - Running setup.py (path:/tmp/pip-DnFsvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:47:08 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)) 17:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:08 INFO - Running setup.py (path:/tmp/pip-YEuN3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:08 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)) 17:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:47:08 INFO - Running setup.py (path:/tmp/pip-asqdMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:47:08 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)) 17:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:47:08 INFO - Running setup.py (path:/tmp/pip-KAspKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:47:08 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)) 17:47:08 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)) 17:47:08 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)) 17:47:08 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)) 17:47:08 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)) 17:47:08 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)) 17:47:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:47:08 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 17:47:08 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 17:47:08 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 17:47:08 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 17:47:08 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 17:47:08 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 17:47:10 INFO - Downloading blessings-1.6.tar.gz 17:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:47:10 INFO - Installing collected packages: blessings 17:47:10 INFO - Running setup.py install for blessings 17:47:10 INFO - Successfully installed blessings 17:47:10 INFO - Cleaning up... 17:47:11 INFO - Return code: 0 17:47:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:47:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:47:11 INFO - Reading from file tmpfile_stdout 17:47:11 INFO - Current package versions: 17:47:11 INFO - argparse == 1.2.1 17:47:11 INFO - blessings == 1.6 17:47:11 INFO - blobuploader == 1.2.4 17:47:11 INFO - docopt == 0.6.1 17:47:11 INFO - functools32 == 3.2.3-2 17:47:11 INFO - jsonschema == 2.5.1 17:47:11 INFO - manifestparser == 1.1 17:47:11 INFO - mozInstall == 1.12 17:47:11 INFO - mozcrash == 0.17 17:47:11 INFO - mozdebug == 0.1 17:47:11 INFO - mozdevice == 0.48 17:47:11 INFO - mozfile == 1.2 17:47:11 INFO - mozhttpd == 0.7 17:47:11 INFO - mozinfo == 0.9 17:47:11 INFO - mozleak == 0.1 17:47:11 INFO - mozlog == 3.2 17:47:11 INFO - moznetwork == 0.27 17:47:11 INFO - mozprocess == 0.23 17:47:11 INFO - mozprofile == 0.28 17:47:11 INFO - mozrunner == 6.12 17:47:11 INFO - mozscreenshot == 0.1 17:47:11 INFO - mozsystemmonitor == 0.3 17:47:11 INFO - moztest == 0.7 17:47:11 INFO - mozversion == 1.4 17:47:11 INFO - psutil == 3.1.1 17:47:11 INFO - requests == 1.2.3 17:47:11 INFO - wsgiref == 0.1.2 17:47:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:11 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 0xabe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xced400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c570>, '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 0xd7d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7d900>, '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': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', '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 17:47:11 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 17:47:11 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 17:47:11 INFO - Using env: {'DISPLAY': ':0', 17:47:11 INFO - 'HOME': '/home/cltbld', 17:47:11 INFO - 'LANG': 'en_US.UTF-8', 17:47:11 INFO - 'LANGUAGE': 'en_US:en', 17:47:11 INFO - 'LOGNAME': 'cltbld', 17:47:11 INFO - 'MAIL': '/var/mail/cltbld', 17:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:11 INFO - 'MOZ_NO_REMOTE': '1', 17:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:11 INFO - 'NO_EM_RESTART': '1', 17:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:11 INFO - 'PWD': '/builds/slave/test', 17:47:11 INFO - 'SHELL': '/bin/bash', 17:47:11 INFO - 'SHLVL': '1', 17:47:11 INFO - 'TERM': 'linux', 17:47:11 INFO - 'TMOUT': '86400', 17:47:11 INFO - 'USER': 'cltbld', 17:47:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', 17:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:11 INFO - '_': '/tools/buildbot/bin/python'} 17:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:11 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)) 17:47:11 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)) 17:47:11 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)) 17:47:11 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)) 17:47:11 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)) 17:47:11 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)) 17:47:11 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)) 17:47:11 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)) 17:47:11 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)) 17:47:11 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)) 17:47:11 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)) 17:47:11 INFO - Cleaning up... 17:47:11 INFO - Return code: 0 17:47:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:11 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 0xabe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xced400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c570>, '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 0xd7d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7d900>, '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': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', '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 17:47:11 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 17:47:11 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 17:47:11 INFO - Using env: {'DISPLAY': ':0', 17:47:11 INFO - 'HOME': '/home/cltbld', 17:47:11 INFO - 'LANG': 'en_US.UTF-8', 17:47:11 INFO - 'LANGUAGE': 'en_US:en', 17:47:11 INFO - 'LOGNAME': 'cltbld', 17:47:11 INFO - 'MAIL': '/var/mail/cltbld', 17:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:11 INFO - 'MOZ_NO_REMOTE': '1', 17:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:11 INFO - 'NO_EM_RESTART': '1', 17:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:11 INFO - 'PWD': '/builds/slave/test', 17:47:11 INFO - 'SHELL': '/bin/bash', 17:47:11 INFO - 'SHLVL': '1', 17:47:11 INFO - 'TERM': 'linux', 17:47:11 INFO - 'TMOUT': '86400', 17:47:11 INFO - 'USER': 'cltbld', 17:47:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', 17:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:11 INFO - '_': '/tools/buildbot/bin/python'} 17:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:47:11 INFO - Cleaning up... 17:47:11 INFO - Return code: 0 17:47:11 INFO - Running post-action listener: _resource_record_post_action 17:47:11 INFO - Running post-action listener: _start_resource_monitoring 17:47:11 INFO - Starting resource monitoring. 17:47:11 INFO - ##### 17:47:11 INFO - ##### Finished create-virtualenv step (success) 17:47:11 INFO - ##### 17:47:11 INFO - ##### 17:47:11 INFO - ##### Running install step. 17:47:11 INFO - ##### 17:47:11 INFO - Running pre-action listener: _resource_record_pre_action 17:47:11 INFO - Running main action method: install 17:47:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:47:11 INFO - Reading from file tmpfile_stdout 17:47:11 INFO - Detecting whether we're running mozinstall >=1.0... 17:47:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:47:12 INFO - Reading from file tmpfile_stdout 17:47:12 INFO - Output received: 17:47:12 INFO - Usage: mozinstall [options] installer 17:47:12 INFO - Options: 17:47:12 INFO - -h, --help show this help message and exit 17:47:12 INFO - -d DEST, --destination=DEST 17:47:12 INFO - Directory to install application into. [default: 17:47:12 INFO - "/builds/slave/test"] 17:47:12 INFO - --app=APP Application being installed. [default: firefox] 17:47:12 INFO - mkdir: /builds/slave/test/build/application 17:47:12 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'] 17:47:12 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 17:47:28 INFO - Reading from file tmpfile_stdout 17:47:28 INFO - Output received: 17:47:28 INFO - /builds/slave/test/build/application/firefox/firefox 17:47:28 INFO - Running post-action listener: _resource_record_post_action 17:47:28 INFO - ##### 17:47:28 INFO - ##### Finished install step (success) 17:47:28 INFO - ##### 17:47:28 INFO - ##### 17:47:28 INFO - ##### Running run-tests step. 17:47:28 INFO - ##### 17:47:28 INFO - Running pre-action listener: _resource_record_pre_action 17:47:28 INFO - Running main action method: run_tests 17:47:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:47:28 INFO - Python 2.7.3 17:47:28 INFO - Return code: 0 17:47:28 INFO - grabbing minidump binary from tooltool 17:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:28 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 0xd7c570>, '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 0xd7d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd7d900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:47:28 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 17:47:28 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 17:47:28 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 17:47:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:47:28 INFO - Return code: 0 17:47:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:47:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:47:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:47:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:47:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:47:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 17:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 17:47:28 INFO - Using env: {'DISPLAY': ':0', 17:47:28 INFO - 'HOME': '/home/cltbld', 17:47:28 INFO - 'LANG': 'en_US.UTF-8', 17:47:28 INFO - 'LANGUAGE': 'en_US:en', 17:47:28 INFO - 'LOGNAME': 'cltbld', 17:47:28 INFO - 'MAIL': '/var/mail/cltbld', 17:47:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:47:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:28 INFO - 'MOZ_NO_REMOTE': '1', 17:47:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:28 INFO - 'NO_EM_RESTART': '1', 17:47:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:28 INFO - 'PWD': '/builds/slave/test', 17:47:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:47:28 INFO - 'SHELL': '/bin/bash', 17:47:28 INFO - 'SHLVL': '1', 17:47:28 INFO - 'TERM': 'linux', 17:47:28 INFO - 'TMOUT': '86400', 17:47:28 INFO - 'USER': 'cltbld', 17:47:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822', 17:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:28 INFO - '_': '/tools/buildbot/bin/python'} 17:47:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 17:47:28 INFO - mozversion application_buildid: 20160712162527 17:47:28 INFO - mozversion application_changeset: 04821a70c739a00d12e12df651c0989441e22728 17:47:28 INFO - mozversion application_display_name: Nightly 17:47:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:47:28 INFO - mozversion application_name: Firefox 17:47:28 INFO - mozversion application_remotingname: firefox 17:47:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:47:28 INFO - mozversion application_vendor: Mozilla 17:47:28 INFO - mozversion application_version: 50.0a1 17:47:28 INFO - mozversion platform_buildid: 20160712162527 17:47:28 INFO - mozversion platform_changeset: 04821a70c739a00d12e12df651c0989441e22728 17:47:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:47:28 INFO - mozversion platform_version: 50.0a1 17:47:28 INFO - using testdate: 1468370848 17:47:28 INFO - actual date: 1468370848 17:47:28 INFO - starting webserver on 'localhost:60369' 17:47:28 INFO - SUITE-START | Running 2 tests 17:47:28 INFO - TEST-START | dromaeo_css 17:47:28 INFO - operating with platform_type : linux_ 17:47:28 INFO - Initialising browser for dromaeo_css test... 17:47:28 INFO - TEST-INFO | started process 28702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN8BpK2/profile http://localhost:60369/getInfo.html) 17:47:34 INFO - PROCESS | 28702 | __metrics Screen width/height:1600/1200 17:47:34 INFO - PROCESS | 28702 | colorDepth:24 17:47:34 INFO - PROCESS | 28702 | Browser inner width/height: 1024/697 17:47:34 INFO - PROCESS | 28702 | __metrics 17:47:35 ERROR - PROCESS | 28702 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 17:47:36 INFO - TEST-INFO | 28702: exit 0 17:47:36 INFO - Browser initialized. 17:47:36 INFO - Running cycle 1/1 for dromaeo_css test... 17:47:36 INFO - TEST-INFO | started process 28821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN8BpK2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:47:48 INFO - PROCESS | 28821 | RSS: Main: 168337408 17:47:48 INFO - PROCESS | 28821 | 17:48:38 INFO - PROCESS | 28821 | 1468370918397 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] 17:50:50 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:60369/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60369/tests/dromaeo/cssquery-ext.html) 17:50:51 INFO - PROCESS | 28821 | RSS: Main: 171458560 17:50:51 INFO - PROCESS | 28821 | 17:53:54 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:60369/tests/dromaeo/cssquery-ext.html (next: http://localhost:60369/tests/dromaeo/cssquery-jquery.html) 17:53:54 INFO - PROCESS | 28821 | RSS: Main: 168546304 17:53:54 INFO - PROCESS | 28821 | 17:56:56 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:60369/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60369/tests/dromaeo/cssquery-mootools.html) 17:56:57 INFO - PROCESS | 28821 | RSS: Main: 172036096 17:56:57 INFO - PROCESS | 28821 | 17:59:59 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:60369/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60369/tests/dromaeo/cssquery-prototype.html) 17:59:59 INFO - PROCESS | 28821 | RSS: Main: 167153664 17:59:59 INFO - PROCESS | 28821 | 18:03:02 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:60369/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60369/tests/dromaeo/cssquery-yui.html) 18:03:03 INFO - PROCESS | 28821 | RSS: Main: 169164800 18:03:03 INFO - PROCESS | 28821 | 18:06:06 INFO - PROCESS | 28821 | Cycle 1(1): loaded http://localhost:60369/tests/dromaeo/cssquery-yui.html (next: http://localhost:60369/tests/dromaeo/cssquery-dojo.html) 18:06:06 INFO - PROCESS | 28821 | RSS: Main: 170377216 18:06:06 INFO - PROCESS | 28821 | 18:06:06 INFO - PROCESS | 28821 | __start_tp_report 18:06:06 INFO - PROCESS | 28821 | _x_x_mozilla_page_load 18:06:06 INFO - PROCESS | 28821 | _x_x_mozilla_page_load_details 18:06:06 INFO - PROCESS | 28821 | |i|pagename|runs| 18:06:06 INFO - PROCESS | 28821 | |0;dojo.html;2601.6357709920608;2638.709741928388;2644.6561946946895;2657.202839148255;2666.666666666668;4651.953310505135;4670.69640473369;4699.483056863746;4777.402824646919;4831.033793241349;4581.5647513486165;4643.071385722852;4687.601553867926;4701.529847015297;4718.079974404993;4302.247106756313;4334.349847522865;4448.0436706108185;4450.821967121327;4452.732836029849;4123.237201117788;4433.157700036999;4435.246008178601;4445.110977804436;4477.5298593647685;4208.936865946983;4244.830206791725;4255.829766809324;4344.131173765244;4417.359482874997;4307.784610769449;4321.58944900234;4328.0045589514275;4331.870043898688;4374.343848422762;4362.694611377205;4370.082282720632;4371.169477799208;4384.780760961971;4403.36151258069;4610.377599024122;4681.485036645966;4693.990791979707;4704.270838020078;4768;4966.726830024347;4990.6257030722845;5001.9749901250625;5006.224035274502;5017.422996355429;4883.3651625288485;5025;5049.469805670426;5067.518585734386;5113.335266415379;4648.3259927310355;4678.298255261738;4697.295405689174;4697.389339385926;4704.905901881977;5107.092241052346;5148.665336753099;5155.9742201288755;5175.353080864892;5211.0359583477175;4759.262314341283;4798.2082956311815;4942.184539550934;4947.505249475023;4988.251762235621;4913.754312284372;4946.282788995575;4978.975105124451;4982.60139188864;5020.046191223656;4850.927236091461;4891;4892.046051020088;4930.2358134488495;4955.281484184773;4898.804047838046;4905.558499735041;4925.13810083234;4949.975250123726;4951.851444456672;4140.565240649748;4158.812853421603;4186.623203911662;4201.13876655291;4232.682548808852;3706.5366829146355;3710.981445092811;3714.68425183857;3745.756525825867;3760.360738674432;4382.802773875183;4397.252467080604;4437.201303765289;4487.102579484051;4491.752953587584;4883.340748998839;4973.229149481764;5004.974975125101;5014.2979982802435;5043.394792624908;4389.561043895585;4428.689991700615;4429.15845989261;4432.3351497275025;4473.619742321874;4474.843380481668;4488.685791994529;4489.371487991683;4494.303382975644;4536.115457485825;4761.047790441856;4811.4707382187935;4829.468758436639;4837.612990960785;4847.321375007431;5030.446650868328;5077.619178561548;5080;5084.8220312288895;5128.743562821918;4726.480087190337;4750.501197374226;4824.951750482591;4853;4874.2201247800185;4893.510648935078;4944.28307895346;4957.925631115609;4966.652334336562;5011.072951503984;5026.974865125651;5036.874078148076;5038.949610503848;5040.697558146523;5098.643094983316;4726.669133160645;4903.4606193317995;4940.802367905244;4957.405111386656;4975.0796102721115;4763.142634325716;4806.255030470283;4923.630727695366;4974.726390048582;5019.899602007867;4840.467548569584;4842.080004799077;4858.392700912386;4881.048195601966;4892.143874821821;4870.659053866337;4878;4978.900421991612;4986.825461108844;4999.325091112653;4803.495632958489;4838.080764654705;4839.249916262985;4840.709557426566;4847.394075740533 18:06:06 INFO - PROCESS | 28821 | |1;ext.html;551.6497024389512;551.8978988887056;554.7669978608984;557.3757391721273;590.0971513584218;37084.443733343986;40187.19625607486;40317;40349.79825100874;40386.39420408692;41290.38064429036;41848;42021.36967945483;42079.789601051954;42248.15503689925;7788.493747906382;7918.485298455582;7933.365330773524;7951.443398962075;7959;7744.535327880317;7769.883451748228;7778;7805;7829.451938364316;7886.64510097047;7897.842043159133;7910.327622152124;7910.367170626365;7913.446058775888;7847.372210223197;7863.606819658994;7866.252705992922;7876.960615196945;7884.369250460007;7858.214178582153;7866.0560732711865;7920.089189743196;7924.762257132295;7944.364450843977;39007.8049609753;39232.41151382731;39391.21217575661;39432.408513872026;39478.802605987075;2781.6105745195687;2879.52782897713;3077.338372249955;3144.5126005469187;3208.4545627243424;30185.547216791765;30604.846975765202;30729.692703072906;30751.692483075105;30762.077137685905;3438.862445502202;3618.2582570572968;3647.124690074363;3725.62743725628;3730.123420996064;261385;261446;263482;263925;263981.6800916002;32783.83608081944;33246.16884577905;33426;35396.469052964225;55126;33688;34376.65623343785;34415.13962150966;34463.827680861934;34638.65361346405;13428.127171733806;13588.728225435436;13621.795673064911;13627;13682;10908.727281817859;11008.834867476995;11040.834387484194;11049.889501104886;11199;7965;7982.401319901031;8018.5990700464745;8052.194780521901;8084.7574572762915;3033.4388138194504;3046.1214152625557;3094.9381012379627;3108.362785628941;3126.8592913318957;903.2006674093475;907.9092090790868;931.6599441203912;957.2485598805044;959.9856002159974;28168.29579260535;28808.567871481944;28937.42125157485;29150.170699197603;29493;868.2533021601417;868.2880038368477;876.5179151466796;908.2370808520874;1003.7390278527489;14941;15378.38486460529;15446.227688615749;15526.844731552766;15670.294836732375;389134;395283;395715;396289;396346;52025.47974520282;52401.73799131056;52431.73784131055;52716.472835271925;52791.73604131955;1126.4142645824124;1180.055955235808;1184.0527577937787;1211.3640338822013;1216.0150278274625;27694;27785;27820.86089569539;28861.85569072141;29049.12852614425;45092.54907451015;45294.320585191905;45836.77081614704;45939;45948.540514594424;329980;332137;334103;335287;335940;25765.484690306464;25866.224013279632;26369.07708230203;26415.471690565697;26679;44030.339544907496;44236.336454953846;44250.89022179388;44295.11409771851;44706.55293447154;37663.10379650628;38188.2362352757;38666.42000370053;38743.418848717854;39556;37895.43156852705;38555.61444385633;38697.22605547817;38701.41947870728;39144.80427597844;36110.819445902605;36773.63226367702;36783.26433471262;36887.81556092203;37065.444018340284;33174.66825331812;33948.66051339455;34202.31595368128;34446.10546419971;34677.306453870275;25690.35774105662;26065.869670651526;26261.212163635122;26331.473370532865;26785.732142679102 18:06:06 INFO - PROCESS | 28821 | |2;jquery.html;361.3423569104231;371.93119272934507;376.6892313841081;378.71217874415436;383.96928245740344;15560.533184004484;16935;17626.29494820209;17671.73492397615;17884.999999999967;16223.756643650355;16989.57526061849;17872.10639468028;17969.101544922767;18035.63928721425;4549.431321084872;4732.645051621143;4733.313669517918;4734;4746.382970213867;3479.721622270225;4670.859874203762;6603.966980165116;6977.686004129826;6980.930190698079;6959.721611135548;6983.777838878202;7062.646867656622;7094.11323584552;7128.073350464459;7041.683124259421;7093.787186384417;7108.537945033582;7118.964405177992;7129.322714342129;6694.330566943316;6903.1371078615175;6905.792826215222;6926.965365173192;6938.826529336757;22297.331080067623;22692.319230423112;23052.884735576383;23962.161324353565;24018;1952.2288695965015;2051.9487012824648;2159.0284372032493;2397.6283676030243;2446.681931348931;13964;14469;14532.52946999002;14633.560993170222;14687.192204428753;1756.745271935575;1788.642271545696;1829.9634007319778;1916.7412399326051;1923.6152769446167;87300.56349718274;87630.561847191;88116.55941720314;89203.55398223033;91524;15838.76241856373;16328.346866125223;16701.749473757904;16703.832961670472;16890.40883569069;29058.41883162325;29122.417551648847;29308.26729331741;29382.412351752846;29531.55702664462;8278.420510564203;8752.824943501095;8758.347909047498;8777.561121943878;8925.241354484811;7163.140423149255;7351.852962940711;7373.225811289844;7513.774586762406;7547.433942454228;8438.409311348147;8471.152884711602;8549.829003419896;8565.700200493078;8691.608877600524;1523.116592376419;1575.5745948593815;1638.90166590005;1662.8170901200858;1689.0794516988271;872.6029656506274;891.3493150000536;911.6535716427715;913.6847787513298;922.6493932305681;16364;17009.91495042517;17114.400995965083;17246;17480.650386992187;846.0608724316004;849.6898631999276;853.3812985585525;860.242986172177;882.170759486081;5741.425857414225;5915.40845915405;6080.361562035922;6124.234470691164;6346.30190679025;385177;388825;389817;390450;392611;81876.59061704772;85649.57175214209;85910.57044714736;85910.57044714736;86051.5697421509;427.6856510464806;430.84489583749826;433.7787728258611;435.0146917232471;435.3513265234777;9784.804303914025;10633.149348051982;10701.250912436055;10792.946035269773;10884.292520986111;39666;39961.80019099886;40395.59604403919;40811.38782918199;40870.386944196456;54110.18834717404;54984.450155497936;55787;55998.72000639971;56030.719846402135;7288.927110728825;7349.118105827121;7377.225391333833;7526.548407095592;7529.322360987538;11102.88897111051;11210.831837522606;11241.100711943189;11371.886281137082;11394.829077564009;9609.815463328781;9642.662506812228;9732.854007189757;9798.412095274307;9836.655717049869;9874.802503949737;9945.950270248602;9961.40231586107;10059.647912323033;10066.396016239049;9621.663241786504;9842.11420972116;9964.10323070927;10093.091621754078;10151.187904967732;7300.488965772557;9613.855792162984;10308.690739277834;10398.22013349017;10495.52770125331;10046.69859904204;10130.89869101329;10308.845367319345;10554.683359499228;10820.513076911715 18:06:06 INFO - PROCESS | 28821 | |3;mootools.html;1360.5986234060952;1395.4069520453809;1464.4508309383975;1643.7698722178889;1666.350123451854;6407.199100112486;7123.0740003799565;7244.529105608139;7544.660490277937;7551.207123252062;7171.354578087971;7442.106947166334;7510;7513.135989361225;7516.135644400895;2177.9891100544473;2215.667649852527;2215.869906347758;2219.03471989685;2219.3896678413403;2124.1397234120204;2136.7222261106035;2208.8895555222257;2214.2471559669707;2215.9113635454564;2159.686845407415;2181.7381914170323;2189.791969762878;2191.7041199438113;2192.451887028243;2103.1587365053947;2127.361791462563;2128.7658357580576;2133.114757375687;2133.9146434142617;2064.98967505163;2074.5228597422524;2090.8850013249266;2108.0724481228212;2108.314797690741;7353.264673532657;7450.478466507347;7461.626918654046;7494.43791715618;7504.699812007513;4388.868333949987;4551.908961820778;4559.612432943204;4566.611837993742;4566.817327306904;2709.8645067746534;2724.5504491758834;2836.858157092137;2852.415254872746;2882.769378449719;825.4964471672275;871.5990644303628;877.32007694037;877.7761670773975;1685.7050016247108;9372.062793720641;9582.089701478279;9593.376430532064;9595.664151754725;9641.469719165443;3816.9427458588143;3980.8407663693706;3982.661473774762;4047.0489434982755;4052.9392059119136;7417.925820741832;7445.590492522855;7457.179710231871;7467.477276590586;7472.7296359618995;4454.086912182995;4458.643308535309;4463.732176069446;4467.419235499365;4471.977640111779;3683.171286460525;3916.4321173429694;4040.1111755413763;4189.811458484375;4211.263028969918;3322.318924620447;3372.7133193678324;3375.3586818504405;3457.11843479911;3475.09647491654;1014.3153371474225;1024.9436281004466;1028.4292217819182;1036.2487196782272;1037.7872536130076;739.1868944161487;808.7937575918103;812.727736208365;831.2352635575285;860.4321148042387;4990.326305948651;5030.924536131961;5038.546530812245;5045.495450454925;5127.410347809975;407.5700136356173;415.2048826497224;427.3504273504256;431.33358960406247;432.9047609525899;3575.3921833288405;3588.748787584896;3641.253543023674;3708.165662725919;3730.925381492409;8568.400211985227;9062.275017998545;9068.909310906807;9207.63169473227;9246.26029917605;9003.414778039407;9108.49903255314;9136.132067453715;9142.63429462814;9142.680006199751;7009.824754381181;7086.893696594555;7097.361237488651;7102.60935648534;7176.174739904874;5197.168453047494;5230.790768369223;5258.6581872178185;5267.209918512101;5272.393674727302;8442.366822488215;8484.491225265561;8590.613422396133;8619.956900215459;8679.17547832955;8231.547264900248;8267.214614611603;8277.337812974827;8358.164183581594;8768.605412756313;5320.361556613077;5838.766449341979;5877.265341832271;5918.378570250062;5935.40645935403;6974.546654467444;7220.241874603301;7264.164621068645;7280.708771649287;7313.305236002571;6512.413882750575;6545.574537655228;6594.769183078569;6610;6625.370589793962;6545.967270163619;6685.364890335411;6729.158855143107;6807.659617019228;6843.315668433117;5804.5356371491025;5816.272965879265;5816.651000939957;5882.588218824641;5937.5249980000635;4337.6963612546815;4407.382966384773;4435.467743870756;4451.888702782457;4566.8173273068705;4505;4700.506446823171;4771.832985845479;4776.044791041875;4812.8796780080775 18:06:06 INFO - PROCESS | 28821 | |4;prototype.html;303.71147409960537;306.48204534336963;310.2940809658028;310.92537790930186;312.626411438331;5014.373203349582;5054.772535235914;5056.443791182967;5058.645894787366;5072.44203137655;4973.179425394806;4991.525805048524;4993.500649935005;4995.550400463958;5002.474740152286;3719.721020923428;3803.1442925341717;3905.531336239641;3931.567527571965;3943.2704949584277;3881.68946484282;3909.6285852843935;3922.9019274518223;3925.3326934421216;3929.783861887595;3894.240623078501;3894.785786781726;3904.297226499229;3912.8088270568433;3916.471276377695;3814.313423583754;3904.7852368119743;3915.060385507486;3920.6471417572557;3931.0761970936805;3497.1082373994723;3497.3529896969144;3501.212227248874;3504.3341765064556;3505.263894582141;4877.683025583073;4885.584725298354;4885.6335774817035;4887.486813884527;4907.312976183337;4338.284183109783;4486.416765820455;4500.932486012713;4513.255312873372;4522.751248681321;5235.267062611238;5239.580833533309;5246.7901283948595;5247.370315562157;5247.449017853109;3793.1275806564645;3802.448644946495;3808.6000969898314;3811.8856434307013;3814.9618503814886;5339.279197308352;5390.568754499631;5428.83713488596;5440.4287549807495;5463.562914966793;3826.3877779555696;3902.3561112416132;3904.472896158982;3922.1763429680086;3931.2334094851803;3895.980520097438;3941.7437866538585;3955.8219880105466;3968.6031396860085;3969.226000929849;4440.046379592969;4462.687611867138;4465.709728867613;4469.150861336336;4491.281394976853;4983.476734942851;5231.9595357810485;5235.267062611238;5279.208118782137;5279.472052794767;1331.900107491942;1340.8390993080893;1344.8117263583106;1349.3253373313344;1352.5266156845223;841.3605659698673;847.652462490376;857.648364170687;873.6898401067657;881.6958149438434;4569.474510431343;4728.692634978785;4733.881652958635;4735.337052812609;4736.289556566474;5339.706316152571;5381.892362152735;5399.514043736004;5420.940042783717;5466.5900057495055;4515.571020753023;4681.859544213679;4710.952890471051;4713.996551465682;4720.592497826134;2863.2698661841096;2907.6220091387986;2908.2147820088458;2908.75275601572;2934.39844831809;5150.793968241303;5179.715115668599;5203.32356793622;5211.296474975906;5237.240600112962;5351.25082488452;5495.120780675073;5526.944730552724;5546.473085056913;5579.163125531121;5135.486451354909;5181.559567436735;5191.480851914778;5209.557187639018;5213.478652134756;5419.593530485151;5436.7553460093595;5447.96488667152;5449.863753406038;5460.481254280837;5057.241413787961;5278.445763194963;5289.523942845162;5301.628885977944;5312.4156342803035;5142.280080788618;5163.483651634807;5171.267625345551;5176.689398636094;5182.170852663556;3825.6748176405317;3855.768653880776;3860.6332398422105;3861.80690965445;3866.69066474687;5158.484151584811;5388.73056347189;5400.891982160413;5408.810691625774;5494.478024587658;5280.7359632019015;5290.841274761763;5292.391374991771;5297.78151025274;5313.54834839043;5252.212168174804;5262.210668399771;5269.868253293698;5307.6284660073425;5328.547073498796;4924.581410579997;5154.304168937146;5199.610029247746;5221.895562088661;5226.660267082628;5108.84673459782;5166.948330516797;5323.6273460857365;5337.464704265598;5369.570434365163;5120.719820044988;5142.254373115952;5146.716930568855;5167.044096842096;5203.19350500673 18:06:06 INFO - PROCESS | 28821 | |5;yui.html;670.7551743613581;691.301785196951;741.0107506478851;763.130031763789;767.2672597669226;11906.464209110589;12945.352732363368;12948.676283092916;12997.545085921995;13005.349732513372;11944.462499187535;11981.341026243554;11982.101342399334;11996.520139194421;12032.699182520442;616.5252755378356;743.8512297540486;750.6134340814485;763.6296396247816;777.4985134588187;770.3644493293056;771.4368510986983;773.9729109481169;777.8211011467366;778.0702061037035;835.0688981785327;836.3476488339105;836.5566249887569;836.8828364029041;837.8868852704899;830.8629076202419;831.3640065350012;832.11795496773;832.7918020494876;833.4999000599653;604.5133667397743;604.7732100462326;604.7943699142313;605.4067014325985;605.9969700151515;12699.809502857464;12704.745905081847;12721.173123746927;12756.744865102739;12778.10553261272;13283.3358332083;13614.659633509142;13647.658808529766;13676.316184190751;13703.383347749275;9916.504174791231;10262;10368.533415996299;10548.314359566604;10629.415382153978;3338.8163650999186;3380.932381352384;3392.508086327469;3394.9490757638655;3422.6748458896363;62642.37357626457;62842;63488.68255658692;64488.35511644871;64501;10705.304155229886;10744.73138171552;10876.238663293652;10888;10932.070773984142;19904.303349382702;19942.60114797696;19943.60112797765;19957.600847982958;19958.90020549917;6934.133233345832;7076.823079423056;7077.541149076152;7136.607486588287;7290.161631412349;3758.9436158457647;3798.506194194737;3816.14136819219;3821.1402434452025;3869.2068126034096;2751.0783887397547;2829.0522674903727;2841.6163817884735;2845.558938364557;2850.8859645614357;480.978355973982;503.4009528660882;505.8179055540003;507.14292845091677;510.2983397827987;508.9338386009869;558.1293182635021;565.1804882919782;591.8697886464971;607.2773399654398;8512.65949362031;8854.24738897188;9064.184223419923;9125.954370228106;9149.94775600801;566.1422944239481;591.9437653422918;593.9792107276224;616.3805375597585;652.9836754081091;3966.960330396717;4337;4371.540988196193;4376.059147283349;4510.458744950627;95625;95878;95932.0406795937;96967;97003;48341;48993;71838;72138;72717.27282727211;46378.07243855104;50305.49694503081;70979.2902070983;74120.14699632552;74432.62783686047;9168.816623667355;9169;9309.813803724022;9502.762430939281;9506.90493095088;43743;45765.77117114393;46058.30912536382;46500.53499464962;46739;59853.102203466115;60172.69913650579;63721.68139159275;64359.678201608695;67603.32396676167;11537.365444900275;11723.296602203895;11729.120315976164;11789.705257368634;12055.048894080312;12995;13344.266065366499;13448.394822233218;13986.790198147239;14010.299485025911;12346.938265308616;12370.876291236973;12635.93682031584;12778;13239.735205296032;12185.207961482476;12201.450934707782;12608.87391126077;12661.177023493443;12690.555830546256;11595.362255076052;11854;12259.509619615472;12317.50729970827;12359;10102.242331824995;10188.796224075626;10327.225458090523;10368.792624147625;10777;10379.273450858367;10530.789384212427;10634.787304253718;10747.623833165802;10766.515506802056 18:06:06 INFO - PROCESS | 28821 | __end_tp_report 18:06:06 INFO - PROCESS | 28821 | __start_cc_report 18:06:06 INFO - PROCESS | 28821 | _x_x_mozilla_cycle_collect,383 18:06:06 INFO - PROCESS | 28821 | __end_cc_report 18:06:06 INFO - PROCESS | 28821 | __startTimestamp1468371966343__endTimestamp 18:06:06 INFO - PROCESS | 28821 | 18:06:06 INFO - PROCESS | 28821 | ------- Summary: start ------- 18:06:06 INFO - PROCESS | 28821 | Number of tests: 6 18:06:06 INFO - PROCESS | 28821 | 18:06:06 INFO - PROCESS | 28821 | [#0] dojo.html Cycles:165 Average:4650.69 Median:4806.26 stddev:477.10 (9.9%) stddev-sans-first:450.67 18:06:06 INFO - PROCESS | 28821 | Values: 2601.6 2638.7 2644.7 2657.2 2666.7 4652.0 4670.7 4699.5 4777.4 4831.0 4581.6 4643.1 4687.6 4701.5 4718.1 4302.2 4334.3 4448.0 4450.8 4452.7 4123.2 4433.2 4435.2 4445.1 4477.5 4208.9 4244.8 4255.8 4344.1 4417.4 4307.8 4321.6 4328.0 4331.9 4374.3 4362.7 4370.1 4371.2 4384.8 4403.4 4610.4 4681.5 4694.0 4704.3 4768.0 4966.7 4990.6 5002.0 5006.2 5017.4 4883.4 5025.0 5049.5 5067.5 5113.3 4648.3 4678.3 4697.3 4697.4 4704.9 5107.1 5148.7 5156.0 5175.4 5211.0 4759.3 4798.2 4942.2 4947.5 4988.3 4913.8 4946.3 4979.0 4982.6 5020.0 4850.9 4891.0 4892.0 4930.2 4955.3 4898.8 4905.6 4925.1 4950.0 4951.9 4140.6 4158.8 4186.6 4201.1 4232.7 3706.5 3711.0 3714.7 3745.8 3760.4 4382.8 4397.3 4437.2 4487.1 4491.8 4883.3 4973.2 5005.0 5014.3 5043.4 4389.6 4428.7 4429.2 4432.3 4473.6 4474.8 4488.7 4489.4 4494.3 4536.1 4761.0 4811.5 4829.5 4837.6 4847.3 5030.4 5077.6 5080.0 5084.8 5128.7 4726.5 4750.5 4825.0 4853.0 4874.2 4893.5 4944.3 4957.9 4966.7 5011.1 5027.0 5036.9 5038.9 5040.7 5098.6 4726.7 4903.5 4940.8 4957.4 4975.1 4763.1 4806.3 4923.6 4974.7 5019.9 4840.5 4842.1 4858.4 4881.0 4892.1 4870.7 4878.0 4978.9 4986.8 4999.3 4803.5 4838.1 4839.2 4840.7 4847.4 18:06:06 INFO - PROCESS | 28821 | 18:06:06 INFO - PROCESS | 28821 | [#1] ext.html Cycles:180 Average:47649.44 Median:20696.61 stddev:88281.03 (426.5%) stddev-sans-first:88457.85 18:06:06 INFO - PROCESS | 28821 | Values: 551.6 551.9 554.8 557.4 590.1 37084.4 40187.2 40317.0 40349.8 40386.4 41290.4 41848.0 42021.4 42079.8 42248.2 7788.5 7918.5 7933.4 7951.4 7959.0 7744.5 7769.9 7778.0 7805.0 7829.5 7886.6 7897.8 7910.3 7910.4 7913.4 7847.4 7863.6 7866.3 7877.0 7884.4 7858.2 7866.1 7920.1 7924.8 7944.4 39007.8 39232.4 39391.2 39432.4 39478.8 2781.6 2879.5 3077.3 3144.5 3208.5 30185.5 30604.8 30729.7 30751.7 30762.1 3438.9 3618.3 3647.1 3725.6 3730.1 261385.0 261446.0 263482.0 263925.0 263981.7 32783.8 33246.2 33426.0 35396.5 55126.0 33688.0 34376.7 34415.1 34463.8 34638.7 13428.1 13588.7 13621.8 13627.0 13682.0 10908.7 11008.8 11040.8 11049.9 11199.0 7965.0 7982.4 8018.6 8052.2 8084.8 3033.4 3046.1 3094.9 3108.4 3126.9 903.2 907.9 931.7 957.2 960.0 28168.3 28808.6 28937.4 29150.2 29493.0 868.3 868.3 876.5 908.2 1003.7 14941.0 15378.4 15446.2 15526.8 15670.3 389134.0 395283.0 395715.0 396289.0 396346.0 52025.5 52401.7 52431.7 52716.5 52791.7 1126.4 1180.1 1184.1 1211.4 1216.0 27694.0 27785.0 27820.9 28861.9 29049.1 45092.5 45294.3 45836.8 45939.0 45948.5 329980.0 332137.0 334103.0 335287.0 335940.0 25765.5 25866.2 26369.1 26415.5 26679.0 44030.3 44236.3 44250.9 44295.1 44706.6 37663.1 38188.2 38666.4 38743.4 39556.0 37895.4 38555.6 38697.2 38701.4 39144.8 36110.8 36773.6 36783.3 36887.8 37065.4 33174.7 33948.7 34202.3 34446.1 34677.3 25690.4 26065.9 26261.2 26331.5 26785.7 18:06:06 INFO - PROCESS | 28821 | 18:06:06 INFO - PROCESS | 28821 | [#2] jquery.html Cycles:180 Average:26200.08 Median:435.18 stddev:64888.29 (14910.6%) stddev-sans-first:65041.31 18:06:06 INFO - PROCESS | 28821 | Values: 361.3 371.9 376.7 378.7 384.0 15560.5 16935.0 17626.3 17671.7 17885.0 16223.8 16989.6 17872.1 17969.1 18035.6 4549.4 4732.6 4733.3 4734.0 4746.4 3479.7 4670.9 6604.0 6977.7 6980.9 6959.7 6983.8 7062.6 7094.1 7128.1 7041.7 7093.8 7108.5 7119.0 7129.3 6694.3 6903.1 6905.8 6927.0 6938.8 22297.3 22692.3 23052.9 23962.2 24018.0 1952.2 2051.9 2159.0 2397.6 2446.7 13964.0 14469.0 14532.5 14633.6 14687.2 1756.7 1788.6 1830.0 1916.7 1923.6 87300.6 87630.6 88116.6 89203.6 91524.0 15838.8 16328.3 16701.7 16703.8 16890.4 29058.4 29122.4 29308.3 29382.4 29531.6 8278.4 8752.8 8758.3 8777.6 8925.2 7163.1 7351.9 7373.2 7513.8 7547.4 8438.4 8471.2 8549.8 8565.7 8691.6 1523.1 1575.6 1638.9 1662.8 1689.1 872.6 891.3 911.7 913.7 922.6 16364.0 17009.9 17114.4 17246.0 17480.7 846.1 849.7 853.4 860.2 882.2 5741.4 5915.4 6080.4 6124.2 6346.3 385177.0 388825.0 389817.0 390450.0 392611.0 81876.6 85649.6 85910.6 85910.6 86051.6 427.7 430.8 433.8 435.0 435.4 9784.8 10633.1 10701.3 10792.9 10884.3 39666.0 39961.8 40395.6 40811.4 40870.4 54110.2 54984.5 55787.0 55998.7 56030.7 7288.9 7349.1 7377.2 7526.5 7529.3 11102.9 11210.8 11241.1 11371.9 11394.8 9609.8 9642.7 9732.9 9798.4 9836.7 9874.8 9946.0 9961.4 10059.6 10066.4 9621.7 9842.1 9964.1 10093.1 10151.2 7300.5 9613.9 10308.7 10398.2 10495.5 10046.7 10130.9 10308.8 10554.7 10820.5 18:06:06 INFO - PROCESS | 28821 | 18:06:06 INFO - PROCESS | 28821 | [#3] mootools.html Cycles:180 Average:4867.64 Median:5162.29 stddev:2651.03 (51.4%) stddev-sans-first:2645.37 18:06:06 INFO - PROCESS | 28821 | Values: 1360.6 1395.4 1464.5 1643.8 1666.4 6407.2 7123.1 7244.5 7544.7 7551.2 7171.4 7442.1 7510.0 7513.1 7516.1 2178.0 2215.7 2215.9 2219.0 2219.4 2124.1 2136.7 2208.9 2214.2 2215.9 2159.7 2181.7 2189.8 2191.7 2192.5 2103.2 2127.4 2128.8 2133.1 2133.9 2065.0 2074.5 2090.9 2108.1 2108.3 7353.3 7450.5 7461.6 7494.4 7504.7 4388.9 4551.9 4559.6 4566.6 4566.8 2709.9 2724.6 2836.9 2852.4 2882.8 825.5 871.6 877.3 877.8 1685.7 9372.1 9582.1 9593.4 9595.7 9641.5 3816.9 3980.8 3982.7 4047.0 4052.9 7417.9 7445.6 7457.2 7467.5 7472.7 4454.1 4458.6 4463.7 4467.4 4472.0 3683.2 3916.4 4040.1 4189.8 4211.3 3322.3 3372.7 3375.4 3457.1 3475.1 1014.3 1024.9 1028.4 1036.2 1037.8 739.2 808.8 812.7 831.2 860.4 4990.3 5030.9 5038.5 5045.5 5127.4 407.6 415.2 427.4 431.3 432.9 3575.4 3588.7 3641.3 3708.2 3730.9 8568.4 9062.3 9068.9 9207.6 9246.3 9003.4 9108.5 9136.1 9142.6 9142.7 7009.8 7086.9 7097.4 7102.6 7176.2 5197.2 5230.8 5258.7 5267.2 5272.4 8442.4 8484.5 8590.6 8620.0 8679.2 8231.5 8267.2 8277.3 8358.2 8768.6 5320.4 5838.8 5877.3 5918.4 5935.4 6974.5 7220.2 7264.2 7280.7 7313.3 6512.4 6545.6 6594.8 6610.0 6625.4 6546.0 6685.4 6729.2 6807.7 6843.3 5804.5 5816.3 5816.7 5882.6 5937.5 4337.7 4407.4 4435.5 4451.9 4566.8 4505.0 4700.5 4771.8 4776.0 4812.9 18:06:06 INFO - PROCESS | 28821 | 18:06:06 INFO - PROCESS | 28821 | [#4] prototype.html Cycles:180 Average:4381.93 Median:4999.01 stddev:1269.46 (25.4%) stddev-sans-first:1235.56 18:06:06 INFO - PROCESS | 28821 | Values: 303.7 306.5 310.3 310.9 312.6 5014.4 5054.8 5056.4 5058.6 5072.4 4973.2 4991.5 4993.5 4995.6 5002.5 3719.7 3803.1 3905.5 3931.6 3943.3 3881.7 3909.6 3922.9 3925.3 3929.8 3894.2 3894.8 3904.3 3912.8 3916.5 3814.3 3904.8 3915.1 3920.6 3931.1 3497.1 3497.4 3501.2 3504.3 3505.3 4877.7 4885.6 4885.6 4887.5 4907.3 4338.3 4486.4 4500.9 4513.3 4522.8 5235.3 5239.6 5246.8 5247.4 5247.4 3793.1 3802.4 3808.6 3811.9 3815.0 5339.3 5390.6 5428.8 5440.4 5463.6 3826.4 3902.4 3904.5 3922.2 3931.2 3896.0 3941.7 3955.8 3968.6 3969.2 4440.0 4462.7 4465.7 4469.2 4491.3 4983.5 5232.0 5235.3 5279.2 5279.5 1331.9 1340.8 1344.8 1349.3 1352.5 841.4 847.7 857.6 873.7 881.7 4569.5 4728.7 4733.9 4735.3 4736.3 5339.7 5381.9 5399.5 5420.9 5466.6 4515.6 4681.9 4711.0 4714.0 4720.6 2863.3 2907.6 2908.2 2908.8 2934.4 5150.8 5179.7 5203.3 5211.3 5237.2 5351.3 5495.1 5526.9 5546.5 5579.2 5135.5 5181.6 5191.5 5209.6 5213.5 5419.6 5436.8 5448.0 5449.9 5460.5 5057.2 5278.4 5289.5 5301.6 5312.4 5142.3 5163.5 5171.3 5176.7 5182.2 3825.7 3855.8 3860.6 3861.8 3866.7 5158.5 5388.7 5400.9 5408.8 5494.5 5280.7 5290.8 5292.4 5297.8 5313.5 5252.2 5262.2 5269.9 5307.6 5328.5 4924.6 5154.3 5199.6 5221.9 5226.7 5108.8 5166.9 5323.6 5337.5 5369.6 5120.7 5142.3 5146.7 5167.0 5203.2 18:06:06 INFO - PROCESS | 28821 | 18:06:06 INFO - PROCESS | 28821 | [#5] yui.html Cycles:180 Average:17122.33 Median:45912.04 stddev:23418.88 (51.0%) stddev-sans-first:23452.00 18:06:06 INFO - PROCESS | 28821 | Values: 670.8 691.3 741.0 763.1 767.3 11906.5 12945.4 12948.7 12997.5 13005.3 11944.5 11981.3 11982.1 11996.5 12032.7 616.5 743.9 750.6 763.6 777.5 770.4 771.4 774.0 777.8 778.1 835.1 836.3 836.6 836.9 837.9 830.9 831.4 832.1 832.8 833.5 604.5 604.8 604.8 605.4 606.0 12699.8 12704.7 12721.2 12756.7 12778.1 13283.3 13614.7 13647.7 13676.3 13703.4 9916.5 10262.0 10368.5 10548.3 10629.4 3338.8 3380.9 3392.5 3394.9 3422.7 62642.4 62842.0 63488.7 64488.4 64501.0 10705.3 10744.7 10876.2 10888.0 10932.1 19904.3 19942.6 19943.6 19957.6 19958.9 6934.1 7076.8 7077.5 7136.6 7290.2 3758.9 3798.5 3816.1 3821.1 3869.2 2751.1 2829.1 2841.6 2845.6 2850.9 481.0 503.4 505.8 507.1 510.3 508.9 558.1 565.2 591.9 607.3 8512.7 8854.2 9064.2 9126.0 9149.9 566.1 591.9 594.0 616.4 653.0 3967.0 4337.0 4371.5 4376.1 4510.5 95625.0 95878.0 95932.0 96967.0 97003.0 48341.0 48993.0 71838.0 72138.0 72717.3 46378.1 50305.5 70979.3 74120.1 74432.6 9168.8 9169.0 9309.8 9502.8 9506.9 43743.0 45765.8 46058.3 46500.5 46739.0 59853.1 60172.7 63721.7 64359.7 67603.3 11537.4 11723.3 11729.1 11789.7 12055.0 12995.0 13344.3 13448.4 13986.8 14010.3 12346.9 12370.9 12635.9 12778.0 13239.7 12185.2 12201.5 12608.9 12661.2 12690.6 11595.4 11854.0 12259.5 12317.5 12359.0 10102.2 10188.8 10327.2 10368.8 10777.0 10379.3 10530.8 10634.8 10747.6 10766.5 18:06:06 INFO - PROCESS | 28821 | -------- Summary: end -------- 18:06:06 INFO - PROCESS | 28821 | 18:06:07 INFO - TEST-INFO | 28821: exit 0 18:06:07 INFO - TEST-OK | dromaeo_css | took 1118483ms 18:06:07 INFO - TEST-START | kraken 18:06:07 INFO - operating with platform_type : linux_ 18:06:07 INFO - Initialising browser for kraken test... 18:06:07 INFO - TEST-INFO | started process 29067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWQ9it1/profile http://localhost:60369/getInfo.html) 18:06:12 INFO - PROCESS | 29067 | __metrics Screen width/height:1600/1200 18:06:12 INFO - PROCESS | 29067 | colorDepth:24 18:06:12 INFO - PROCESS | 29067 | Browser inner width/height: 1024/697 18:06:12 INFO - PROCESS | 29067 | __metrics 18:06:13 ERROR - PROCESS | 29067 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 18:06:14 INFO - TEST-INFO | 29067: exit 0 18:06:14 INFO - Browser initialized. 18:06:14 INFO - Running cycle 1/1 for kraken test... 18:06:14 INFO - TEST-INFO | started process 29189 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWQ9it1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:06:26 INFO - PROCESS | 29189 | RSS: Main: 168960000 18:06:26 INFO - PROCESS | 29189 | 18:06:29 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:60369/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60369/tests/kraken/driver.html?testName=audio-beat-detection) 18:06:30 INFO - PROCESS | 29189 | RSS: Main: 173346816 18:06:30 INFO - PROCESS | 29189 | 18:06:32 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:60369/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60369/tests/kraken/driver.html?testName=audio-dft) 18:06:33 INFO - PROCESS | 29189 | RSS: Main: 173776896 18:06:33 INFO - PROCESS | 29189 | 18:06:36 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:60369/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60369/tests/kraken/driver.html?testName=audio-fft) 18:06:37 INFO - PROCESS | 29189 | RSS: Main: 168185856 18:06:37 INFO - PROCESS | 29189 | 18:06:39 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:60369/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60369/tests/kraken/driver.html?testName=audio-oscillator) 18:06:39 INFO - PROCESS | 29189 | RSS: Main: 169226240 18:06:39 INFO - PROCESS | 29189 | 18:06:42 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:60369/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60369/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:06:42 INFO - PROCESS | 29189 | RSS: Main: 169263104 18:06:42 INFO - PROCESS | 29189 | 18:06:45 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:60369/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60369/tests/kraken/driver.html?testName=imaging-darkroom) 18:06:46 INFO - PROCESS | 29189 | RSS: Main: 169734144 18:06:46 INFO - PROCESS | 29189 | 18:06:50 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:60369/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60369/tests/kraken/driver.html?testName=imaging-desaturate) 18:06:50 INFO - PROCESS | 29189 | RSS: Main: 167006208 18:06:50 INFO - PROCESS | 29189 | 18:06:53 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:60369/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60369/tests/kraken/driver.html?testName=json-parse-financial) 18:06:54 INFO - PROCESS | 29189 | RSS: Main: 168349696 18:06:54 INFO - PROCESS | 29189 | 18:06:56 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:60369/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60369/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:06:56 INFO - PROCESS | 29189 | RSS: Main: 169144320 18:06:56 INFO - PROCESS | 29189 | 18:06:58 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:60369/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60369/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:06:59 INFO - PROCESS | 29189 | RSS: Main: 169725952 18:06:59 INFO - PROCESS | 29189 | 18:07:01 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:60369/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60369/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:07:02 INFO - PROCESS | 29189 | RSS: Main: 170364928 18:07:02 INFO - PROCESS | 29189 | 18:07:04 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:60369/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:07:05 INFO - PROCESS | 29189 | RSS: Main: 170205184 18:07:05 INFO - PROCESS | 29189 | 18:07:08 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:60369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:07:08 INFO - PROCESS | 29189 | RSS: Main: 169713664 18:07:08 INFO - PROCESS | 29189 | 18:07:10 INFO - PROCESS | 29189 | Cycle 1(1): loaded http://localhost:60369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60369/tests/kraken/driver.html?testName=ai-astar) 18:07:11 INFO - PROCESS | 29189 | RSS: Main: 170225664 18:07:11 INFO - PROCESS | 29189 | 18:07:11 INFO - PROCESS | 29189 | __start_tp_report 18:07:11 INFO - PROCESS | 29189 | _x_x_mozilla_page_load 18:07:11 INFO - PROCESS | 29189 | _x_x_mozilla_page_load_details 18:07:11 INFO - PROCESS | 29189 | |i|pagename|runs| 18:07:11 INFO - PROCESS | 29189 | |0;ai-astar;106;115;110;116;117;117;117;117;115;117 18:07:11 INFO - PROCESS | 29189 | |1;audio-beat-detection;150;123;152;179;125;147;150;124;177;129 18:07:11 INFO - PROCESS | 29189 | |2;audio-dft;163;163;164;169;166;162;165;163;164;162 18:07:11 INFO - PROCESS | 29189 | |3;audio-fft;76;78;76;161;77;75;75;76;162;77 18:07:11 INFO - PROCESS | 29189 | |4;audio-oscillator;88;87;150;86;85;86;129;85;86;137 18:07:11 INFO - PROCESS | 29189 | |5;imaging-gaussian-blur;118;117;117;117;118;118;118;118;119;118 18:07:11 INFO - PROCESS | 29189 | |6;imaging-darkroom;148;148;149;149;147;149;149;147;149;148 18:07:11 INFO - PROCESS | 29189 | |7;imaging-desaturate;96;95;96;96;95;96;95;95;95;96 18:07:11 INFO - PROCESS | 29189 | |8;json-parse-financial;61;63;62;63;65;64;63;62;63;62 18:07:11 INFO - PROCESS | 29189 | |9;json-stringify-tinderbox;65;66;65;65;66;65;65;65;65;65 18:07:11 INFO - PROCESS | 29189 | |10;stanford-crypto-aes;79;79;83;85;80;79;79;79;84;91 18:07:11 INFO - PROCESS | 29189 | |11;stanford-crypto-ccm;131;141;128;127;130;146;136;133;170;141 18:07:11 INFO - PROCESS | 29189 | |12;stanford-crypto-pbkdf2;167;168;172;169;173;180;171;167;166;171 18:07:11 INFO - PROCESS | 29189 | |13;stanford-crypto-sha256-iterative;71;69;71;71;68;68;67;71;67;66 18:07:11 INFO - PROCESS | 29189 | __end_tp_report 18:07:11 INFO - PROCESS | 29189 | __start_cc_report 18:07:11 INFO - PROCESS | 29189 | _x_x_mozilla_cycle_collect,983 18:07:11 INFO - PROCESS | 29189 | __end_cc_report 18:07:11 INFO - PROCESS | 29189 | __startTimestamp1468372031034__endTimestamp 18:07:11 INFO - PROCESS | 29189 | 18:07:11 INFO - PROCESS | 29189 | ------- Summary: start ------- 18:07:11 INFO - PROCESS | 29189 | Number of tests: 14 18:07:11 INFO - PROCESS | 29189 | 18:07:11 INFO - PROCESS | 29189 | [#0] ai-astar Cycles:10 Average:114.70 Median:117.00 stddev:3.74 (3.2%) stddev-sans-first:2.29 18:07:11 INFO - PROCESS | 29189 | Values: 106.0 115.0 110.0 116.0 117.0 117.0 117.0 117.0 115.0 117.0 18:07:11 INFO - PROCESS | 29189 | 18:07:11 INFO - PROCESS | 29189 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:150.00 stddev:20.71 (13.8%) stddev-sans-first:21.91 18:07:11 INFO - PROCESS | 29189 | Values: 150.0 123.0 152.0 179.0 125.0 147.0 150.0 124.0 177.0 129.0 18:07:11 INFO - PROCESS | 29189 | 18:07:11 INFO - PROCESS | 29189 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.13 (1.3%) stddev-sans-first:2.22 18:07:11 INFO - PROCESS | 29189 | Values: 163.0 163.0 164.0 169.0 166.0 162.0 165.0 163.0 164.0 162.0 18:07:11 INFO - PROCESS | 29189 | 18:07:11 INFO - PROCESS | 29189 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:35.96 (47.3%) stddev-sans-first:37.59 18:07:11 INFO - PROCESS | 29189 | Values: 76.0 78.0 76.0 161.0 77.0 75.0 75.0 76.0 162.0 77.0 18:07:11 INFO - PROCESS | 29189 | 18:07:11 INFO - PROCESS | 29189 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:86.00 stddev:25.87 (30.1%) stddev-sans-first:26.95 18:07:11 INFO - PROCESS | 29189 | Values: 88.0 87.0 150.0 86.0 85.0 86.0 129.0 85.0 86.0 137.0 18:07:11 INFO - PROCESS | 29189 | 18:07:11 INFO - PROCESS | 29189 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 18:07:11 INFO - PROCESS | 29189 | Values: 118.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 119.0 118.0 18:07:11 INFO - PROCESS | 29189 | 18:07:11 INFO - PROCESS | 29189 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:149.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 18:07:11 INFO - PROCESS | 29189 | Values: 148.0 148.0 149.0 149.0 147.0 149.0 149.0 147.0 149.0 148.0 18:07:11 INFO - PROCESS | 29189 | 18:07:11 INFO - PROCESS | 29189 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:07:11 INFO - PROCESS | 29189 | Values: 96.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 18:07:11 INFO - PROCESS | 29189 | 18:07:11 INFO - PROCESS | 29189 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:1.14 (1.8%) stddev-sans-first:1.00 18:07:11 INFO - PROCESS | 29189 | Values: 61.0 63.0 62.0 63.0 65.0 64.0 63.0 62.0 63.0 62.0 18:07:11 INFO - PROCESS | 29189 | 18:07:11 INFO - PROCESS | 29189 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 18:07:11 INFO - PROCESS | 29189 | Values: 65.0 66.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 18:07:11 INFO - PROCESS | 29189 | 18:07:11 INFO - PROCESS | 29189 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.50 stddev:3.99 (4.9%) stddev-sans-first:4.11 18:07:11 INFO - PROCESS | 29189 | Values: 79.0 79.0 83.0 85.0 80.0 79.0 79.0 79.0 84.0 91.0 18:07:11 INFO - PROCESS | 29189 | 18:07:11 INFO - PROCESS | 29189 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:138.50 stddev:12.77 (9.2%) stddev-sans-first:13.27 18:07:11 INFO - PROCESS | 29189 | Values: 131.0 141.0 128.0 127.0 130.0 146.0 136.0 133.0 170.0 141.0 18:07:11 INFO - PROCESS | 29189 | 18:07:11 INFO - PROCESS | 29189 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.00 stddev:4.12 (2.4%) stddev-sans-first:4.18 18:07:11 INFO - PROCESS | 29189 | Values: 167.0 168.0 172.0 169.0 173.0 180.0 171.0 167.0 166.0 171.0 18:07:11 INFO - PROCESS | 29189 | 18:07:11 INFO - PROCESS | 29189 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:70.00 stddev:1.97 (2.8%) stddev-sans-first:1.94 18:07:11 INFO - PROCESS | 29189 | Values: 71.0 69.0 71.0 71.0 68.0 68.0 67.0 71.0 67.0 66.0 18:07:11 INFO - PROCESS | 29189 | -------- Summary: end -------- 18:07:11 INFO - PROCESS | 29189 | 18:07:12 INFO - TEST-INFO | 29189: exit 0 18:07:12 INFO - TEST-OK | kraken | took 65026ms 18:07:12 INFO - SUITE-END | took 1183s 18:07:12 INFO - Completed test suite (00:19:43) 18:07:12 INFO - javascript benchmark 18:07:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6424.80300178029, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2601.6357709920608, 2638.709741928388, 2644.6561946946895, 2657.202839148255, 2666.666666666668, 4651.953310505135, 4670.69640473369, 4699.483056863746, 4777.402824646919, 4831.033793241349, 4581.5647513486165, 4643.071385722852, 4687.601553867926, 4701.529847015297, 4718.079974404993, 4302.247106756313, 4334.349847522865, 4448.0436706108185, 4450.821967121327, 4452.732836029849, 4123.237201117788, 4433.157700036999, 4435.246008178601, 4445.110977804436, 4477.5298593647685, 4208.936865946983, 4244.830206791725, 4255.829766809324, 4344.131173765244, 4417.359482874997, 4307.784610769449, 4321.58944900234, 4328.0045589514275, 4331.870043898688, 4374.343848422762, 4362.694611377205, 4370.082282720632, 4371.169477799208, 4384.780760961971, 4403.36151258069, 4610.377599024122, 4681.485036645966, 4693.990791979707, 4704.270838020078, 4768.0, 4966.726830024347, 4990.6257030722845, 5001.9749901250625, 5006.224035274502, 5017.422996355429, 4883.3651625288485, 5025.0, 5049.469805670426, 5067.518585734386, 5113.335266415379, 4648.3259927310355, 4678.298255261738, 4697.295405689174, 4697.389339385926, 4704.905901881977, 5107.092241052346, 5148.665336753099, 5155.9742201288755, 5175.353080864892, 5211.0359583477175, 4759.262314341283, 4798.2082956311815, 4942.184539550934, 4947.505249475023, 4988.251762235621, 4913.754312284372, 4946.282788995575, 4978.975105124451, 4982.60139188864, 5020.046191223656, 4850.927236091461, 4891.0, 4892.046051020088, 4930.2358134488495, 4955.281484184773, 4898.804047838046, 4905.558499735041, 4925.13810083234, 4949.975250123726, 4951.851444456672, 4140.565240649748, 4158.812853421603, 4186.623203911662, 4201.13876655291, 4232.682548808852, 3706.5366829146355, 3710.981445092811, 3714.68425183857, 3745.756525825867, 3760.360738674432, 4382.802773875183, 4397.252467080604, 4437.201303765289, 4487.102579484051, 4491.752953587584, 4883.340748998839, 4973.229149481764, 5004.974975125101, 5014.2979982802435, 5043.394792624908, 4389.561043895585, 4428.689991700615, 4429.15845989261, 4432.3351497275025, 4473.619742321874, 4474.843380481668, 4488.685791994529, 4489.371487991683, 4494.303382975644, 4536.115457485825, 4761.047790441856, 4811.4707382187935, 4829.468758436639, 4837.612990960785, 4847.321375007431, 5030.446650868328, 5077.619178561548, 5080.0, 5084.8220312288895, 5128.743562821918, 4726.480087190337, 4750.501197374226, 4824.951750482591, 4853.0, 4874.2201247800185, 4893.510648935078, 4944.28307895346, 4957.925631115609, 4966.652334336562, 5011.072951503984, 5026.974865125651, 5036.874078148076, 5038.949610503848, 5040.697558146523, 5098.643094983316, 4726.669133160645, 4903.4606193317995, 4940.802367905244, 4957.405111386656, 4975.0796102721115, 4763.142634325716, 4806.255030470283, 4923.630727695366, 4974.726390048582, 5019.899602007867, 4840.467548569584, 4842.080004799077, 4858.392700912386, 4881.048195601966, 4892.143874821821, 4870.659053866337, 4878.0, 4978.900421991612, 4986.825461108844, 4999.325091112653, 4803.495632958489, 4838.080764654705, 4839.249916262985, 4840.709557426566, 4847.394075740533], "value": 4620.798319216993, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.6497024389512, 551.8978988887056, 554.7669978608984, 557.3757391721273, 590.0971513584218, 37084.443733343986, 40187.19625607486, 40317.0, 40349.79825100874, 40386.39420408692, 41290.38064429036, 41848.0, 42021.36967945483, 42079.789601051954, 42248.15503689925, 7788.493747906382, 7918.485298455582, 7933.365330773524, 7951.443398962075, 7959.0, 7744.535327880317, 7769.883451748228, 7778.0, 7805.0, 7829.451938364316, 7886.64510097047, 7897.842043159133, 7910.327622152124, 7910.367170626365, 7913.446058775888, 7847.372210223197, 7863.606819658994, 7866.252705992922, 7876.960615196945, 7884.369250460007, 7858.214178582153, 7866.0560732711865, 7920.089189743196, 7924.762257132295, 7944.364450843977, 39007.8049609753, 39232.41151382731, 39391.21217575661, 39432.408513872026, 39478.802605987075, 2781.6105745195687, 2879.52782897713, 3077.338372249955, 3144.5126005469187, 3208.4545627243424, 30185.547216791765, 30604.846975765202, 30729.692703072906, 30751.692483075105, 30762.077137685905, 3438.862445502202, 3618.2582570572968, 3647.124690074363, 3725.62743725628, 3730.123420996064, 261385.0, 261446.0, 263482.0, 263925.0, 263981.6800916002, 32783.83608081944, 33246.16884577905, 33426.0, 35396.469052964225, 55126.0, 33688.0, 34376.65623343785, 34415.13962150966, 34463.827680861934, 34638.65361346405, 13428.127171733806, 13588.728225435436, 13621.795673064911, 13627.0, 13682.0, 10908.727281817859, 11008.834867476995, 11040.834387484194, 11049.889501104886, 11199.0, 7965.0, 7982.401319901031, 8018.5990700464745, 8052.194780521901, 8084.7574572762915, 3033.4388138194504, 3046.1214152625557, 3094.9381012379627, 3108.362785628941, 3126.8592913318957, 903.2006674093475, 907.9092090790868, 931.6599441203912, 957.2485598805044, 959.9856002159974, 28168.29579260535, 28808.567871481944, 28937.42125157485, 29150.170699197603, 29493.0, 868.2533021601417, 868.2880038368477, 876.5179151466796, 908.2370808520874, 1003.7390278527489, 14941.0, 15378.38486460529, 15446.227688615749, 15526.844731552766, 15670.294836732375, 389134.0, 395283.0, 395715.0, 396289.0, 396346.0, 52025.47974520282, 52401.73799131056, 52431.73784131055, 52716.472835271925, 52791.73604131955, 1126.4142645824124, 1180.055955235808, 1184.0527577937787, 1211.3640338822013, 1216.0150278274625, 27694.0, 27785.0, 27820.86089569539, 28861.85569072141, 29049.12852614425, 45092.54907451015, 45294.320585191905, 45836.77081614704, 45939.0, 45948.540514594424, 329980.0, 332137.0, 334103.0, 335287.0, 335940.0, 25765.484690306464, 25866.224013279632, 26369.07708230203, 26415.471690565697, 26679.0, 44030.339544907496, 44236.336454953846, 44250.89022179388, 44295.11409771851, 44706.55293447154, 37663.10379650628, 38188.2362352757, 38666.42000370053, 38743.418848717854, 39556.0, 37895.43156852705, 38555.61444385633, 38697.22605547817, 38701.41947870728, 39144.80427597844, 36110.819445902605, 36773.63226367702, 36783.26433471262, 36887.81556092203, 37065.444018340284, 33174.66825331812, 33948.66051339455, 34202.31595368128, 34446.10546419971, 34677.306453870275, 25690.35774105662, 26065.869670651526, 26261.212163635122, 26331.473370532865, 26785.732142679102], "value": 16711.106060286143, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.3423569104231, 371.93119272934507, 376.6892313841081, 378.71217874415436, 383.96928245740344, 15560.533184004484, 16935.0, 17626.29494820209, 17671.73492397615, 17884.999999999967, 16223.756643650355, 16989.57526061849, 17872.10639468028, 17969.101544922767, 18035.63928721425, 4549.431321084872, 4732.645051621143, 4733.313669517918, 4734.0, 4746.382970213867, 3479.721622270225, 4670.859874203762, 6603.966980165116, 6977.686004129826, 6980.930190698079, 6959.721611135548, 6983.777838878202, 7062.646867656622, 7094.11323584552, 7128.073350464459, 7041.683124259421, 7093.787186384417, 7108.537945033582, 7118.964405177992, 7129.322714342129, 6694.330566943316, 6903.1371078615175, 6905.792826215222, 6926.965365173192, 6938.826529336757, 22297.331080067623, 22692.319230423112, 23052.884735576383, 23962.161324353565, 24018.0, 1952.2288695965015, 2051.9487012824648, 2159.0284372032493, 2397.6283676030243, 2446.681931348931, 13964.0, 14469.0, 14532.52946999002, 14633.560993170222, 14687.192204428753, 1756.745271935575, 1788.642271545696, 1829.9634007319778, 1916.7412399326051, 1923.6152769446167, 87300.56349718274, 87630.561847191, 88116.55941720314, 89203.55398223033, 91524.0, 15838.76241856373, 16328.346866125223, 16701.749473757904, 16703.832961670472, 16890.40883569069, 29058.41883162325, 29122.417551648847, 29308.26729331741, 29382.412351752846, 29531.55702664462, 8278.420510564203, 8752.824943501095, 8758.347909047498, 8777.561121943878, 8925.241354484811, 7163.140423149255, 7351.852962940711, 7373.225811289844, 7513.774586762406, 7547.433942454228, 8438.409311348147, 8471.152884711602, 8549.829003419896, 8565.700200493078, 8691.608877600524, 1523.116592376419, 1575.5745948593815, 1638.90166590005, 1662.8170901200858, 1689.0794516988271, 872.6029656506274, 891.3493150000536, 911.6535716427715, 913.6847787513298, 922.6493932305681, 16364.0, 17009.91495042517, 17114.400995965083, 17246.0, 17480.650386992187, 846.0608724316004, 849.6898631999276, 853.3812985585525, 860.242986172177, 882.170759486081, 5741.425857414225, 5915.40845915405, 6080.361562035922, 6124.234470691164, 6346.30190679025, 385177.0, 388825.0, 389817.0, 390450.0, 392611.0, 81876.59061704772, 85649.57175214209, 85910.57044714736, 85910.57044714736, 86051.5697421509, 427.6856510464806, 430.84489583749826, 433.7787728258611, 435.0146917232471, 435.3513265234777, 9784.804303914025, 10633.149348051982, 10701.250912436055, 10792.946035269773, 10884.292520986111, 39666.0, 39961.80019099886, 40395.59604403919, 40811.38782918199, 40870.386944196456, 54110.18834717404, 54984.450155497936, 55787.0, 55998.72000639971, 56030.719846402135, 7288.927110728825, 7349.118105827121, 7377.225391333833, 7526.548407095592, 7529.322360987538, 11102.88897111051, 11210.831837522606, 11241.100711943189, 11371.886281137082, 11394.829077564009, 9609.815463328781, 9642.662506812228, 9732.854007189757, 9798.412095274307, 9836.655717049869, 9874.802503949737, 9945.950270248602, 9961.40231586107, 10059.647912323033, 10066.396016239049, 9621.663241786504, 9842.11420972116, 9964.10323070927, 10093.091621754078, 10151.187904967732, 7300.488965772557, 9613.855792162984, 10308.690739277834, 10398.22013349017, 10495.52770125331, 10046.69859904204, 10130.89869101329, 10308.845367319345, 10554.683359499228, 10820.513076911715], "value": 8838.45299778996, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.5986234060952, 1395.4069520453809, 1464.4508309383975, 1643.7698722178889, 1666.350123451854, 6407.199100112486, 7123.0740003799565, 7244.529105608139, 7544.660490277937, 7551.207123252062, 7171.354578087971, 7442.106947166334, 7510.0, 7513.135989361225, 7516.135644400895, 2177.9891100544473, 2215.667649852527, 2215.869906347758, 2219.03471989685, 2219.3896678413403, 2124.1397234120204, 2136.7222261106035, 2208.8895555222257, 2214.2471559669707, 2215.9113635454564, 2159.686845407415, 2181.7381914170323, 2189.791969762878, 2191.7041199438113, 2192.451887028243, 2103.1587365053947, 2127.361791462563, 2128.7658357580576, 2133.114757375687, 2133.9146434142617, 2064.98967505163, 2074.5228597422524, 2090.8850013249266, 2108.0724481228212, 2108.314797690741, 7353.264673532657, 7450.478466507347, 7461.626918654046, 7494.43791715618, 7504.699812007513, 4388.868333949987, 4551.908961820778, 4559.612432943204, 4566.611837993742, 4566.817327306904, 2709.8645067746534, 2724.5504491758834, 2836.858157092137, 2852.415254872746, 2882.769378449719, 825.4964471672275, 871.5990644303628, 877.32007694037, 877.7761670773975, 1685.7050016247108, 9372.062793720641, 9582.089701478279, 9593.376430532064, 9595.664151754725, 9641.469719165443, 3816.9427458588143, 3980.8407663693706, 3982.661473774762, 4047.0489434982755, 4052.9392059119136, 7417.925820741832, 7445.590492522855, 7457.179710231871, 7467.477276590586, 7472.7296359618995, 4454.086912182995, 4458.643308535309, 4463.732176069446, 4467.419235499365, 4471.977640111779, 3683.171286460525, 3916.4321173429694, 4040.1111755413763, 4189.811458484375, 4211.263028969918, 3322.318924620447, 3372.7133193678324, 3375.3586818504405, 3457.11843479911, 3475.09647491654, 1014.3153371474225, 1024.9436281004466, 1028.4292217819182, 1036.2487196782272, 1037.7872536130076, 739.1868944161487, 808.7937575918103, 812.727736208365, 831.2352635575285, 860.4321148042387, 4990.326305948651, 5030.924536131961, 5038.546530812245, 5045.495450454925, 5127.410347809975, 407.5700136356173, 415.2048826497224, 427.3504273504256, 431.33358960406247, 432.9047609525899, 3575.3921833288405, 3588.748787584896, 3641.253543023674, 3708.165662725919, 3730.925381492409, 8568.400211985227, 9062.275017998545, 9068.909310906807, 9207.63169473227, 9246.26029917605, 9003.414778039407, 9108.49903255314, 9136.132067453715, 9142.63429462814, 9142.680006199751, 7009.824754381181, 7086.893696594555, 7097.361237488651, 7102.60935648534, 7176.174739904874, 5197.168453047494, 5230.790768369223, 5258.6581872178185, 5267.209918512101, 5272.393674727302, 8442.366822488215, 8484.491225265561, 8590.613422396133, 8619.956900215459, 8679.17547832955, 8231.547264900248, 8267.214614611603, 8277.337812974827, 8358.164183581594, 8768.605412756313, 5320.361556613077, 5838.766449341979, 5877.265341832271, 5918.378570250062, 5935.40645935403, 6974.546654467444, 7220.241874603301, 7264.164621068645, 7280.708771649287, 7313.305236002571, 6512.413882750575, 6545.574537655228, 6594.769183078569, 6610.0, 6625.370589793962, 6545.967270163619, 6685.364890335411, 6729.158855143107, 6807.659617019228, 6843.315668433117, 5804.5356371491025, 5816.272965879265, 5816.651000939957, 5882.588218824641, 5937.5249980000635, 4337.6963612546815, 4407.382966384773, 4435.467743870756, 4451.888702782457, 4566.8173273068705, 4505.0, 4700.506446823171, 4771.832985845479, 4776.044791041875, 4812.8796780080775], "value": 3907.0004835498557, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.71147409960537, 306.48204534336963, 310.2940809658028, 310.92537790930186, 312.626411438331, 5014.373203349582, 5054.772535235914, 5056.443791182967, 5058.645894787366, 5072.44203137655, 4973.179425394806, 4991.525805048524, 4993.500649935005, 4995.550400463958, 5002.474740152286, 3719.721020923428, 3803.1442925341717, 3905.531336239641, 3931.567527571965, 3943.2704949584277, 3881.68946484282, 3909.6285852843935, 3922.9019274518223, 3925.3326934421216, 3929.783861887595, 3894.240623078501, 3894.785786781726, 3904.297226499229, 3912.8088270568433, 3916.471276377695, 3814.313423583754, 3904.7852368119743, 3915.060385507486, 3920.6471417572557, 3931.0761970936805, 3497.1082373994723, 3497.3529896969144, 3501.212227248874, 3504.3341765064556, 3505.263894582141, 4877.683025583073, 4885.584725298354, 4885.6335774817035, 4887.486813884527, 4907.312976183337, 4338.284183109783, 4486.416765820455, 4500.932486012713, 4513.255312873372, 4522.751248681321, 5235.267062611238, 5239.580833533309, 5246.7901283948595, 5247.370315562157, 5247.449017853109, 3793.1275806564645, 3802.448644946495, 3808.6000969898314, 3811.8856434307013, 3814.9618503814886, 5339.279197308352, 5390.568754499631, 5428.83713488596, 5440.4287549807495, 5463.562914966793, 3826.3877779555696, 3902.3561112416132, 3904.472896158982, 3922.1763429680086, 3931.2334094851803, 3895.980520097438, 3941.7437866538585, 3955.8219880105466, 3968.6031396860085, 3969.226000929849, 4440.046379592969, 4462.687611867138, 4465.709728867613, 4469.150861336336, 4491.281394976853, 4983.476734942851, 5231.9595357810485, 5235.267062611238, 5279.208118782137, 5279.472052794767, 1331.900107491942, 1340.8390993080893, 1344.8117263583106, 1349.3253373313344, 1352.5266156845223, 841.3605659698673, 847.652462490376, 857.648364170687, 873.6898401067657, 881.6958149438434, 4569.474510431343, 4728.692634978785, 4733.881652958635, 4735.337052812609, 4736.289556566474, 5339.706316152571, 5381.892362152735, 5399.514043736004, 5420.940042783717, 5466.5900057495055, 4515.571020753023, 4681.859544213679, 4710.952890471051, 4713.996551465682, 4720.592497826134, 2863.2698661841096, 2907.6220091387986, 2908.2147820088458, 2908.75275601572, 2934.39844831809, 5150.793968241303, 5179.715115668599, 5203.32356793622, 5211.296474975906, 5237.240600112962, 5351.25082488452, 5495.120780675073, 5526.944730552724, 5546.473085056913, 5579.163125531121, 5135.486451354909, 5181.559567436735, 5191.480851914778, 5209.557187639018, 5213.478652134756, 5419.593530485151, 5436.7553460093595, 5447.96488667152, 5449.863753406038, 5460.481254280837, 5057.241413787961, 5278.445763194963, 5289.523942845162, 5301.628885977944, 5312.4156342803035, 5142.280080788618, 5163.483651634807, 5171.267625345551, 5176.689398636094, 5182.170852663556, 3825.6748176405317, 3855.768653880776, 3860.6332398422105, 3861.80690965445, 3866.69066474687, 5158.484151584811, 5388.73056347189, 5400.891982160413, 5408.810691625774, 5494.478024587658, 5280.7359632019015, 5290.841274761763, 5292.391374991771, 5297.78151025274, 5313.54834839043, 5252.212168174804, 5262.210668399771, 5269.868253293698, 5307.6284660073425, 5328.547073498796, 4924.581410579997, 5154.304168937146, 5199.610029247746, 5221.895562088661, 5226.660267082628, 5108.84673459782, 5166.948330516797, 5323.6273460857365, 5337.464704265598, 5369.570434365163, 5120.719820044988, 5142.254373115952, 5146.716930568855, 5167.044096842096, 5203.19350500673], "value": 3974.032533502674, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.7551743613581, 691.301785196951, 741.0107506478851, 763.130031763789, 767.2672597669226, 11906.464209110589, 12945.352732363368, 12948.676283092916, 12997.545085921995, 13005.349732513372, 11944.462499187535, 11981.341026243554, 11982.101342399334, 11996.520139194421, 12032.699182520442, 616.5252755378356, 743.8512297540486, 750.6134340814485, 763.6296396247816, 777.4985134588187, 770.3644493293056, 771.4368510986983, 773.9729109481169, 777.8211011467366, 778.0702061037035, 835.0688981785327, 836.3476488339105, 836.5566249887569, 836.8828364029041, 837.8868852704899, 830.8629076202419, 831.3640065350012, 832.11795496773, 832.7918020494876, 833.4999000599653, 604.5133667397743, 604.7732100462326, 604.7943699142313, 605.4067014325985, 605.9969700151515, 12699.809502857464, 12704.745905081847, 12721.173123746927, 12756.744865102739, 12778.10553261272, 13283.3358332083, 13614.659633509142, 13647.658808529766, 13676.316184190751, 13703.383347749275, 9916.504174791231, 10262.0, 10368.533415996299, 10548.314359566604, 10629.415382153978, 3338.8163650999186, 3380.932381352384, 3392.508086327469, 3394.9490757638655, 3422.6748458896363, 62642.37357626457, 62842.0, 63488.68255658692, 64488.35511644871, 64501.0, 10705.304155229886, 10744.73138171552, 10876.238663293652, 10888.0, 10932.070773984142, 19904.303349382702, 19942.60114797696, 19943.60112797765, 19957.600847982958, 19958.90020549917, 6934.133233345832, 7076.823079423056, 7077.541149076152, 7136.607486588287, 7290.161631412349, 3758.9436158457647, 3798.506194194737, 3816.14136819219, 3821.1402434452025, 3869.2068126034096, 2751.0783887397547, 2829.0522674903727, 2841.6163817884735, 2845.558938364557, 2850.8859645614357, 480.978355973982, 503.4009528660882, 505.8179055540003, 507.14292845091677, 510.2983397827987, 508.9338386009869, 558.1293182635021, 565.1804882919782, 591.8697886464971, 607.2773399654398, 8512.65949362031, 8854.24738897188, 9064.184223419923, 9125.954370228106, 9149.94775600801, 566.1422944239481, 591.9437653422918, 593.9792107276224, 616.3805375597585, 652.9836754081091, 3966.960330396717, 4337.0, 4371.540988196193, 4376.059147283349, 4510.458744950627, 95625.0, 95878.0, 95932.0406795937, 96967.0, 97003.0, 48341.0, 48993.0, 71838.0, 72138.0, 72717.27282727211, 46378.07243855104, 50305.49694503081, 70979.2902070983, 74120.14699632552, 74432.62783686047, 9168.816623667355, 9169.0, 9309.813803724022, 9502.762430939281, 9506.90493095088, 43743.0, 45765.77117114393, 46058.30912536382, 46500.53499464962, 46739.0, 59853.102203466115, 60172.69913650579, 63721.68139159275, 64359.678201608695, 67603.32396676167, 11537.365444900275, 11723.296602203895, 11729.120315976164, 11789.705257368634, 12055.048894080312, 12995.0, 13344.266065366499, 13448.394822233218, 13986.790198147239, 14010.299485025911, 12346.938265308616, 12370.876291236973, 12635.93682031584, 12778.0, 13239.735205296032, 12185.207961482476, 12201.450934707782, 12608.87391126077, 12661.177023493443, 12690.555830546256, 11595.362255076052, 11854.0, 12259.509619615472, 12317.50729970827, 12359.0, 10102.242331824995, 10188.796224075626, 10327.225458090523, 10368.792624147625, 10777.0, 10379.273450858367, 10530.789384212427, 10634.787304253718, 10747.623833165802, 10766.515506802056], "value": 6636.454881690743, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 110.0, 116.0, 117.0, 117.0, 117.0, 117.0, 115.0, 117.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 152.0, 179.0, 125.0, 147.0, 150.0, 124.0, 177.0, 129.0], "value": 145.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 169.0, 166.0, 162.0, 165.0, 163.0, 164.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 161.0, 77.0, 75.0, 75.0, 76.0, 162.0, 77.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 150.0, 86.0, 85.0, 86.0, 129.0, 85.0, 86.0, 137.0], "value": 101.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 149.0, 147.0, 149.0, 149.0, 147.0, 149.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 63.0, 65.0, 64.0, 63.0, 62.0, 63.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 83.0, 85.0, 80.0, 79.0, 79.0, 79.0, 84.0, 91.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 141.0, 128.0, 127.0, 130.0, 146.0, 136.0, 133.0, 170.0, 141.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 172.0, 169.0, 173.0, 180.0, 171.0, 167.0, 166.0, 171.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 71.0, 71.0, 68.0, 68.0, 67.0, 71.0, 67.0, 66.0], "value": 68.9, "unit": "score"}]}]} 18:07:12 INFO - Return code: 0 18:07:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:07:12 ERROR - # TBPL SUCCESS # 18:07:12 INFO - Running post-action listener: _resource_record_post_action 18:07:12 INFO - ##### 18:07:12 INFO - ##### Finished run-tests step (success) 18:07:12 INFO - ##### 18:07:12 INFO - Running post-run listener: _resource_record_post_run 18:07:12 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 545099776; Read time: 332; Write time: 705520 18:07:12 INFO - TinderboxPrint: CPU usage
13.4% 18:07:12 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 332 18:07:12 INFO - TinderboxPrint: I/O write bytes / time
545,099,776 / 705,520 18:07:12 INFO - TinderboxPrint: CPU idle
8,296.3 (86.6%) 18:07:12 INFO - TinderboxPrint: CPU user
1,220.3 (12.7%) 18:07:12 INFO - TinderboxPrint: Swap in / out
0 / 0 18:07:12 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 246931456; Read time: 72; Write time: 415504 18:07:12 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297865216; Read time: 260; Write time: 289940 18:07:13 INFO - Running post-run listener: _upload_blobber_files 18:07:13 INFO - Blob upload gear active. 18:07:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:07:13 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 18:07:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:07:13 INFO - (blobuploader) - INFO - Open directory for files ... 18:07:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:07:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:07:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:14 INFO - (blobuploader) - INFO - Done attempting. 18:07:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:07:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:07:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:15 INFO - (blobuploader) - INFO - Done attempting. 18:07:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:07:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:07:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:19 INFO - (blobuploader) - INFO - Done attempting. 18:07:19 INFO - (blobuploader) - INFO - Iteration through files over. 18:07:19 INFO - Return code: 0 18:07:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:07:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:07:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e42ae09bd53e49bbb555cc50471458642e65e6b16dd8311c2c6af4b063345dd2e6447c67d69d10dfe79ff885deec619866f653911d9bb2810c500ecd5e0ab213", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/616b378ab7e1cae946d3cbfc56985f53cfc33772c659e81a6919fb90391c3579a0179c88104b4e8913239d0774c1e8e43ba1f77901d77285c84688d0100e9cb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2761035ccd6a7cfc73becb7338154379bf6513603e638ed8ba0c1363602f7b93e73c88cdf2d3cb7c99497c42b72c574cd2a4ae04df226f5e454d124d291eec70"} 18:07:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:07:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:07:19 INFO - Contents: 18:07:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e42ae09bd53e49bbb555cc50471458642e65e6b16dd8311c2c6af4b063345dd2e6447c67d69d10dfe79ff885deec619866f653911d9bb2810c500ecd5e0ab213", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/616b378ab7e1cae946d3cbfc56985f53cfc33772c659e81a6919fb90391c3579a0179c88104b4e8913239d0774c1e8e43ba1f77901d77285c84688d0100e9cb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2761035ccd6a7cfc73becb7338154379bf6513603e638ed8ba0c1363602f7b93e73c88cdf2d3cb7c99497c42b72c574cd2a4ae04df226f5e454d124d291eec70"} 18:07:19 INFO - Running post-run listener: copy_logs_to_upload_dir 18:07:19 INFO - Copying logs to upload dir... 18:07:19 INFO - mkdir: /builds/slave/test/build/upload/logs 18:07:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.638829 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-07-12 18:07:18.735641) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 18:07:18.738672) ========= 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=5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e42ae09bd53e49bbb555cc50471458642e65e6b16dd8311c2c6af4b063345dd2e6447c67d69d10dfe79ff885deec619866f653911d9bb2810c500ecd5e0ab213", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/616b378ab7e1cae946d3cbfc56985f53cfc33772c659e81a6919fb90391c3579a0179c88104b4e8913239d0774c1e8e43ba1f77901d77285c84688d0100e9cb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2761035ccd6a7cfc73becb7338154379bf6513603e638ed8ba0c1363602f7b93e73c88cdf2d3cb7c99497c42b72c574cd2a4ae04df226f5e454d124d291eec70"} build_url:https://queue.taskcluster.net/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/JOu6l9HrRXqBa9yRXhRBHQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e42ae09bd53e49bbb555cc50471458642e65e6b16dd8311c2c6af4b063345dd2e6447c67d69d10dfe79ff885deec619866f653911d9bb2810c500ecd5e0ab213", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/616b378ab7e1cae946d3cbfc56985f53cfc33772c659e81a6919fb90391c3579a0179c88104b4e8913239d0774c1e8e43ba1f77901d77285c84688d0100e9cb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2761035ccd6a7cfc73becb7338154379bf6513603e638ed8ba0c1363602f7b93e73c88cdf2d3cb7c99497c42b72c574cd2a4ae04df226f5e454d124d291eec70"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 18:07:18.763814) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:07:18.764145) ========= 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=5cf47e208febbcd81da23b2e0000026f-1468368460.129076-827259822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:07:18.848621) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 18:07:18.849192) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 18:07:18.849573) ========= ========= Total master_lag: 0.20 =========