builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1468600378.54 results: success (0) buildid: 20160715071457 builduid: f8b003dfbcac42faac47e5e84cd9cd09 revision: 676b7df970b6b2f9432e421f9151e80346ee42ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:58.544957) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:58.545413) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:58.545717) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:58.577345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:58.577705) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 09:32:58-- 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% 96.2M=0s 2016-07-15 09:32:58 (96.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112449 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:58.707208) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:58.707803) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014371 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:58.758112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:58.758589) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 676b7df970b6b2f9432e421f9151e80346ee42ab --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 676b7df970b6b2f9432e421f9151e80346ee42ab --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=9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 09:32:58,896 truncating revision to first 12 chars 2016-07-15 09:32:58,896 Setting DEBUG logging. 2016-07-15 09:32:58,896 attempt 1/10 2016-07-15 09:32:58,896 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/676b7df970b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 09:32:59,199 unpacking tar archive at: mozilla-central-676b7df970b6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681273 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:59.454187) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:59.454535) ========= script_repo_revision: 676b7df970b6b2f9432e421f9151e80346ee42ab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:59.454999) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:59.455299) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 09:32:59.465033) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-15 09:32:59.465373) ========= /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=9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:32:59 INFO - MultiFileLogger online at 20160715 09:32:59 in /builds/slave/test 09:32:59 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 09:32:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:32:59 INFO - {'append_to_log': False, 09:32:59 INFO - 'base_work_dir': '/builds/slave/test', 09:32:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:32:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:32:59 INFO - 'branch': 'Firefox-Non-PGO', 09:32:59 INFO - 'buildbot_json_path': 'buildprops.json', 09:32:59 INFO - 'config_files': ('talos/linux_config.py',), 09:32:59 INFO - 'default_actions': ('clobber', 09:32:59 INFO - 'read-buildbot-config', 09:32:59 INFO - 'download-and-extract', 09:32:59 INFO - 'populate-webroot', 09:32:59 INFO - 'create-virtualenv', 09:32:59 INFO - 'install', 09:32:59 INFO - 'run-tests'), 09:32:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:32:59 INFO - 'download_minidump_stackwalk': True, 09:32:59 INFO - 'download_symbols': 'ondemand', 09:32:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:32:59 INFO - 'tooltool.py': '/tools/tooltool.py', 09:32:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:32:59 INFO - '/tools/misc-python/virtualenv.py')}, 09:32:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:32:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:32:59 INFO - 'installer_path': 'installer.exe', 09:32:59 INFO - 'log_level': 'info', 09:32:59 INFO - 'log_name': 'talos', 09:32:59 INFO - 'log_to_console': True, 09:32:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:32:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:32:59 INFO - 'opt_config_files': (), 09:32:59 INFO - 'pip_index': False, 09:32:59 INFO - 'sps_profile': False, 09:32:59 INFO - 'sps_profile_interval': 0, 09:32:59 INFO - 'suite': 'dromaeojs-e10s', 09:32:59 INFO - 'system_bits': '32', 09:32:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:32:59 INFO - 'title': 'talos-linux64-ix-029', 09:32:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:32:59 INFO - 'use_talos_json': True, 09:32:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:32:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:32:59 INFO - 'work_dir': 'build'} 09:32:59 INFO - ##### 09:32:59 INFO - ##### Running clobber step. 09:32:59 INFO - ##### 09:32:59 INFO - Running pre-action listener: _resource_record_pre_action 09:32:59 INFO - Running main action method: clobber 09:32:59 INFO - rmtree: /builds/slave/test/build 09:32:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:33:00 INFO - Running post-action listener: _resource_record_post_action 09:33:00 INFO - ##### 09:33:00 INFO - ##### Finished clobber step (success) 09:33:00 INFO - ##### 09:33:00 INFO - ##### 09:33:00 INFO - ##### Running read-buildbot-config step. 09:33:00 INFO - ##### 09:33:00 INFO - Running pre-action listener: _resource_record_pre_action 09:33:00 INFO - Running main action method: read_buildbot_config 09:33:00 INFO - Using buildbot properties: 09:33:00 INFO - { 09:33:00 INFO - "project": "", 09:33:00 INFO - "product": "firefox", 09:33:00 INFO - "script_repo_revision": "production", 09:33:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:33:00 INFO - "repository": "", 09:33:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:33:00 INFO - "buildid": "20160715071457", 09:33:00 INFO - "pgo_build": "False", 09:33:00 INFO - "basedir": "/builds/slave/test", 09:33:00 INFO - "buildnumber": 127, 09:33:00 INFO - "slavename": "talos-linux64-ix-029", 09:33:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:33:00 INFO - "platform": "ubuntu64_hw", 09:33:00 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:33:00 INFO - "branch": "mozilla-central", 09:33:00 INFO - "repo_path": "mozilla-central", 09:33:00 INFO - "revision": "676b7df970b6b2f9432e421f9151e80346ee42ab", 09:33:00 INFO - "stage_platform": "linux64", 09:33:00 INFO - "builduid": "f8b003dfbcac42faac47e5e84cd9cd09", 09:33:00 INFO - "slavebuilddir": "test" 09:33:00 INFO - } 09:33:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:33:00 INFO - Running post-action listener: _resource_record_post_action 09:33:00 INFO - ##### 09:33:00 INFO - ##### Finished read-buildbot-config step (success) 09:33:00 INFO - ##### 09:33:00 INFO - ##### 09:33:00 INFO - ##### Running download-and-extract step. 09:33:00 INFO - ##### 09:33:00 INFO - Running pre-action listener: _resource_record_pre_action 09:33:00 INFO - Running main action method: download_and_extract 09:33:00 INFO - mkdir: /builds/slave/test/build/tests 09:33: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')]} 09:33:00 INFO - https://queue.taskcluster.net/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:33:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:33:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:33:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/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 09:33:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/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 09:33:04 INFO - Downloaded 1361 bytes. 09:33:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:33:04 INFO - Using the following test package requirements: 09:33:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:33:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:33:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:33:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:04 INFO - u'jsshell-linux-x86_64.zip'], 09:33:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:33:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:33:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:33:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:33:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:33:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:33:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:33: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')]} 09:33:04 INFO - https://queue.taskcluster.net/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:33:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:33:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:33:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/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 09:33:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/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 09:33:08 INFO - Downloaded 22756641 bytes. 09:33:08 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'] 09:33:08 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 09:33:10 INFO - Return code: 0 09:33:10 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 09:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:10 INFO - https://queue.taskcluster.net/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:33:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:33:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:33:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/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 09:33:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/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 09:33:17 INFO - Downloaded 22756641 bytes. 09:33:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:33:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:33:19 INFO - Return code: 0 09:33:19 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')]} 09:33:19 INFO - https://queue.taskcluster.net/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:33:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:33:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:33:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/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 09:33:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/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 09:33:20 INFO - Downloaded 14403317 bytes. 09:33:20 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'] 09:33:20 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 09:33:20 INFO - Return code: 0 09:33: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')]} 09:33:20 INFO - https://queue.taskcluster.net/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:33:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:33:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:33:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/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 09:33:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y_EQikAlTG-GD6lA43Y7KA/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 09:33:21 INFO - Downloaded 57043506 bytes. 09:33:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:33:21 INFO - mkdir: /builds/slave/test/properties 09:33:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:33:21 INFO - Writing to file /builds/slave/test/properties/build_url 09:33:21 INFO - Contents: 09:33:21 INFO - build_url:https://queue.taskcluster.net/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:33:22 INFO - Running post-action listener: _resource_record_post_action 09:33:22 INFO - Running post-action listener: set_extra_try_arguments 09:33:22 INFO - ##### 09:33:22 INFO - ##### Finished download-and-extract step (success) 09:33:22 INFO - ##### 09:33:22 INFO - ##### 09:33:22 INFO - ##### Running populate-webroot step. 09:33:22 INFO - ##### 09:33:22 INFO - Running pre-action listener: _resource_record_pre_action 09:33:22 INFO - Running main action method: populate_webroot 09:33:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:33:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:33:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:33:22 INFO - '--tppagecycles', 09:33:22 INFO - '7'], 09:33:22 INFO - 'tests': ['tsvgm']}}, 09:33:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:33:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:33:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:33:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:33:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:33:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:33:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:22 INFO - 'talos_options': ['--disable-e10s'], 09:33:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:22 INFO - 'talos_options': ['--disable-e10s'], 09:33:22 INFO - 'tests': ['damp', 'tps']}, 09:33:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:22 INFO - 'tests': ['damp', 'tps']}, 09:33:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:33:22 INFO - 'tests': ['dromaeo_dom']}, 09:33:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:33:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:33:22 INFO - 'tests': ['basic_compositor_video']}, 09:33:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:33:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:33:22 INFO - 'tests': ['a11yr', 09:33:22 INFO - 'ts_paint', 09:33:22 INFO - 'tpaint', 09:33:22 INFO - 'sessionrestore', 09:33:22 INFO - 'sessionrestore_no_auto_restore', 09:33:22 INFO - 'tabpaint']}, 09:33:22 INFO - 'other-e10s': {'tests': ['a11yr', 09:33:22 INFO - 'ts_paint', 09:33:22 INFO - 'tpaint', 09:33:22 INFO - 'sessionrestore', 09:33:22 INFO - 'sessionrestore_no_auto_restore', 09:33:22 INFO - 'tabpaint']}, 09:33:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:33:22 INFO - 'ts_paint', 09:33:22 INFO - 'tpaint', 09:33:22 INFO - 'sessionrestore', 09:33:22 INFO - 'sessionrestore_no_auto_restore', 09:33:22 INFO - 'tabpaint']}, 09:33:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:33:22 INFO - 'ts_paint', 09:33:22 INFO - 'tpaint', 09:33:22 INFO - 'sessionrestore', 09:33:22 INFO - 'sessionrestore_no_auto_restore', 09:33:22 INFO - 'tabpaint']}, 09:33:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:33:22 INFO - 'tests': ['a11yr', 09:33:22 INFO - 'ts_paint', 09:33:22 INFO - 'tpaint', 09:33:22 INFO - 'sessionrestore', 09:33:22 INFO - 'sessionrestore_no_auto_restore', 09:33:22 INFO - 'tabpaint']}, 09:33:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:33:22 INFO - 'tests': ['a11yr', 09:33:22 INFO - 'ts_paint', 09:33:22 INFO - 'tpaint', 09:33:22 INFO - 'sessionrestore', 09:33:22 INFO - 'sessionrestore_no_auto_restore', 09:33:22 INFO - 'tabpaint']}, 09:33:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:33:22 INFO - 'tests': ['tsvgx', 09:33:22 INFO - 'tsvgr_opacity', 09:33:22 INFO - 'tart', 09:33:22 INFO - 'tscrollx', 09:33:22 INFO - 'cart']}, 09:33:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:33:22 INFO - 'tsvgr_opacity', 09:33:22 INFO - 'tart', 09:33:22 INFO - 'tscrollx', 09:33:22 INFO - 'cart']}, 09:33:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:22 INFO - 'talos_options': ['--disable-e10s'], 09:33:22 INFO - 'tests': ['tp5o']}, 09:33:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:22 INFO - 'tests': ['tp5o']}, 09:33:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:22 INFO - 'talos_options': ['--disable-e10s', 09:33:22 INFO - '--xperf_path', 09:33:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:22 INFO - 'tests': ['tp5n']}, 09:33:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:22 INFO - 'talos_options': ['--xperf_path', 09:33:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:22 INFO - 'tests': ['tp5n']}}, 09:33:22 INFO - 'talos.zip': {'path': '', 09:33:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:33:22 INFO - Running post-action listener: _resource_record_post_action 09:33:22 INFO - ##### 09:33:22 INFO - ##### Finished populate-webroot step (success) 09:33:22 INFO - ##### 09:33:22 INFO - ##### 09:33:22 INFO - ##### Running create-virtualenv step. 09:33:22 INFO - ##### 09:33:22 INFO - Running pre-action listener: _resource_record_pre_action 09:33:22 INFO - Running main action method: create_virtualenv 09:33:22 INFO - Creating virtualenv /builds/slave/test/build/venv 09:33:22 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 09:33:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:33:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:33:22 INFO - Using real prefix '/usr' 09:33:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:33:23 INFO - Installing distribute.............................................................................................................................................................................................done. 09:33:25 INFO - Installing pip.................done. 09:33:25 INFO - Return code: 0 09:33:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1221400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b0570>, '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 0x12b1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b1900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', '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 09:33:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:33:25 INFO - Using env: {'DISPLAY': ':0', 09:33:25 INFO - 'HOME': '/home/cltbld', 09:33:25 INFO - 'LANG': 'en_US.UTF-8', 09:33:25 INFO - 'LANGUAGE': 'en_US:en', 09:33:25 INFO - 'LOGNAME': 'cltbld', 09:33:25 INFO - 'MAIL': '/var/mail/cltbld', 09:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:25 INFO - 'MOZ_NO_REMOTE': '1', 09:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:25 INFO - 'NO_EM_RESTART': '1', 09:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:25 INFO - 'PWD': '/builds/slave/test', 09:33:25 INFO - 'SHELL': '/bin/bash', 09:33:25 INFO - 'SHLVL': '1', 09:33:25 INFO - 'TERM': 'linux', 09:33:25 INFO - 'TMOUT': '86400', 09:33:25 INFO - 'USER': 'cltbld', 09:33:25 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', 09:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:25 INFO - '_': '/tools/buildbot/bin/python'} 09:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:25 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 09:33:25 INFO - Cleaning up... 09:33:25 INFO - Return code: 0 09:33:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xff2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1221400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b0570>, '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 0x12b1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b1900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', '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 09:33:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:33:25 INFO - Using env: {'DISPLAY': ':0', 09:33:25 INFO - 'HOME': '/home/cltbld', 09:33:25 INFO - 'LANG': 'en_US.UTF-8', 09:33:25 INFO - 'LANGUAGE': 'en_US:en', 09:33:25 INFO - 'LOGNAME': 'cltbld', 09:33:25 INFO - 'MAIL': '/var/mail/cltbld', 09:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:25 INFO - 'MOZ_NO_REMOTE': '1', 09:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:25 INFO - 'NO_EM_RESTART': '1', 09:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:25 INFO - 'PWD': '/builds/slave/test', 09:33:25 INFO - 'SHELL': '/bin/bash', 09:33:25 INFO - 'SHLVL': '1', 09:33:25 INFO - 'TERM': 'linux', 09:33:25 INFO - 'TMOUT': '86400', 09:33:25 INFO - 'USER': 'cltbld', 09:33:25 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', 09:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:25 INFO - '_': '/tools/buildbot/bin/python'} 09:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:25 INFO - Downloading/unpacking psutil>=3.1.1 09:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:33:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:27 INFO - Installing collected packages: psutil 09:33:27 INFO - Running setup.py install for psutil 09:33:27 INFO - building 'psutil._psutil_linux' extension 09:33:27 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 09:33:27 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 09:33:27 INFO - building 'psutil._psutil_posix' extension 09:33:27 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 09:33:28 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 09:33:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:28 INFO - Successfully installed psutil 09:33:28 INFO - Cleaning up... 09:33:28 INFO - Return code: 0 09:33:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:33: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')]} 09:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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')]} 09:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:28 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 0xff2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1221400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b0570>, '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 0x12b1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b1900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', '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 09:33:28 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 09:33:28 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 09:33:28 INFO - Using env: {'DISPLAY': ':0', 09:33:28 INFO - 'HOME': '/home/cltbld', 09:33:28 INFO - 'LANG': 'en_US.UTF-8', 09:33:28 INFO - 'LANGUAGE': 'en_US:en', 09:33:28 INFO - 'LOGNAME': 'cltbld', 09:33:28 INFO - 'MAIL': '/var/mail/cltbld', 09:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:28 INFO - 'MOZ_NO_REMOTE': '1', 09:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:28 INFO - 'NO_EM_RESTART': '1', 09:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:28 INFO - 'PWD': '/builds/slave/test', 09:33:28 INFO - 'SHELL': '/bin/bash', 09:33:28 INFO - 'SHLVL': '1', 09:33:28 INFO - 'TERM': 'linux', 09:33:28 INFO - 'TMOUT': '86400', 09:33:28 INFO - 'USER': 'cltbld', 09:33:28 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', 09:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:28 INFO - '_': '/tools/buildbot/bin/python'} 09:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:33:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:33:30 INFO - Installing collected packages: mozsystemmonitor 09:33:30 INFO - Running setup.py install for mozsystemmonitor 09:33:30 INFO - Successfully installed mozsystemmonitor 09:33:30 INFO - Cleaning up... 09:33:30 INFO - Return code: 0 09:33:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:33:30 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')]} 09:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:30 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')]} 09:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:30 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 0xff2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1221400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b0570>, '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 0x12b1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b1900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', '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 09:33:30 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 09:33:30 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 09:33:30 INFO - Using env: {'DISPLAY': ':0', 09:33:30 INFO - 'HOME': '/home/cltbld', 09:33:30 INFO - 'LANG': 'en_US.UTF-8', 09:33:30 INFO - 'LANGUAGE': 'en_US:en', 09:33:30 INFO - 'LOGNAME': 'cltbld', 09:33:30 INFO - 'MAIL': '/var/mail/cltbld', 09:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:30 INFO - 'MOZ_NO_REMOTE': '1', 09:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:30 INFO - 'NO_EM_RESTART': '1', 09:33:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:30 INFO - 'PWD': '/builds/slave/test', 09:33:30 INFO - 'SHELL': '/bin/bash', 09:33:30 INFO - 'SHLVL': '1', 09:33:30 INFO - 'TERM': 'linux', 09:33:30 INFO - 'TMOUT': '86400', 09:33:30 INFO - 'USER': 'cltbld', 09:33:30 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', 09:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:30 INFO - '_': '/tools/buildbot/bin/python'} 09:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:30 INFO - Downloading/unpacking jsonschema==2.5.1 09:33:30 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 09:33:30 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 09:33:30 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 09:33:30 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 09:33:30 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 09:33:30 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 09:33:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:33:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:33:32 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 09:33:32 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 09:33:32 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 09:33:32 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 09:33:32 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 09:33:32 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 09:33:32 INFO - Downloading functools32-3.2.3-2.tar.gz 09:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:33:32 INFO - warning: no files found matching '*.txt' 09:33:32 INFO - no previously-included directories found matching 'build' 09:33:32 INFO - no previously-included directories found matching 'dist' 09:33:32 INFO - no previously-included directories found matching '.git*' 09:33:32 INFO - Installing collected packages: jsonschema, functools32 09:33:33 INFO - Running setup.py install for functools32 09:33:33 INFO - warning: no files found matching '*.txt' 09:33:33 INFO - no previously-included directories found matching 'build' 09:33:33 INFO - no previously-included directories found matching 'dist' 09:33:33 INFO - no previously-included directories found matching '.git*' 09:33:33 INFO - Successfully installed jsonschema functools32 09:33:33 INFO - Cleaning up... 09:33:33 INFO - Return code: 0 09:33:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:33: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')]} 09:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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')]} 09:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:33 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 0xff2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1221400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b0570>, '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 0x12b1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b1900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', '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 09:33:33 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 09:33:33 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 09:33:33 INFO - Using env: {'DISPLAY': ':0', 09:33:33 INFO - 'HOME': '/home/cltbld', 09:33:33 INFO - 'LANG': 'en_US.UTF-8', 09:33:33 INFO - 'LANGUAGE': 'en_US:en', 09:33:33 INFO - 'LOGNAME': 'cltbld', 09:33:33 INFO - 'MAIL': '/var/mail/cltbld', 09:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:33 INFO - 'MOZ_NO_REMOTE': '1', 09:33:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:33 INFO - 'NO_EM_RESTART': '1', 09:33:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:33 INFO - 'PWD': '/builds/slave/test', 09:33:33 INFO - 'SHELL': '/bin/bash', 09:33:33 INFO - 'SHLVL': '1', 09:33:33 INFO - 'TERM': 'linux', 09:33:33 INFO - 'TMOUT': '86400', 09:33:33 INFO - 'USER': 'cltbld', 09:33:33 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', 09:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:33 INFO - '_': '/tools/buildbot/bin/python'} 09:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:33 INFO - Downloading/unpacking blobuploader==1.2.4 09:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:35 INFO - Downloading blobuploader-1.2.4.tar.gz 09:33:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:33:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:33:35 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 09:33:35 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 09:33:35 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 09:33:35 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 09:33:35 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 09:33:35 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 09:33:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:33:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:33:35 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 09:33:35 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 09:33:35 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 09:33:35 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 09:33:35 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 09:33:35 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 09:33:35 INFO - Downloading docopt-0.6.1.tar.gz 09:33:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:33:36 INFO - Installing collected packages: blobuploader, requests, docopt 09:33:36 INFO - Running setup.py install for blobuploader 09:33:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:33:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:33:36 INFO - Running setup.py install for requests 09:33:36 INFO - Running setup.py install for docopt 09:33:36 INFO - Successfully installed blobuploader requests docopt 09:33:36 INFO - Cleaning up... 09:33:36 INFO - Return code: 0 09:33:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:36 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 0xff2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1221400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b0570>, '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 0x12b1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b1900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', '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 09:33:36 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 09:33:36 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 09:33:36 INFO - Using env: {'DISPLAY': ':0', 09:33:36 INFO - 'HOME': '/home/cltbld', 09:33:36 INFO - 'LANG': 'en_US.UTF-8', 09:33:36 INFO - 'LANGUAGE': 'en_US:en', 09:33:36 INFO - 'LOGNAME': 'cltbld', 09:33:36 INFO - 'MAIL': '/var/mail/cltbld', 09:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:36 INFO - 'MOZ_NO_REMOTE': '1', 09:33:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:36 INFO - 'NO_EM_RESTART': '1', 09:33:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:36 INFO - 'PWD': '/builds/slave/test', 09:33:36 INFO - 'SHELL': '/bin/bash', 09:33:36 INFO - 'SHLVL': '1', 09:33:36 INFO - 'TERM': 'linux', 09:33:36 INFO - 'TMOUT': '86400', 09:33:36 INFO - 'USER': 'cltbld', 09:33:36 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', 09:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:36 INFO - '_': '/tools/buildbot/bin/python'} 09:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:36 INFO - Running setup.py (path:/tmp/pip-Cfr8RW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:36 INFO - Running setup.py (path:/tmp/pip-GMjBkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:36 INFO - Running setup.py (path:/tmp/pip-8IqxVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:37 INFO - Running setup.py (path:/tmp/pip-FXjdhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:37 INFO - Running setup.py (path:/tmp/pip-7XZVog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:37 INFO - Running setup.py (path:/tmp/pip-Kh7nOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:37 INFO - Running setup.py (path:/tmp/pip-oVncR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:37 INFO - Running setup.py (path:/tmp/pip-h2Ek4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:37 INFO - Running setup.py (path:/tmp/pip-9q74g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:37 INFO - Running setup.py (path:/tmp/pip-NRnsFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:37 INFO - Running setup.py (path:/tmp/pip-IVSaER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:37 INFO - Running setup.py (path:/tmp/pip-7lpIBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:37 INFO - Running setup.py (path:/tmp/pip-ovXGeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:37 INFO - Running setup.py (path:/tmp/pip-8cSA0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:37 INFO - Running setup.py (path:/tmp/pip-D6U377-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:37 INFO - Running setup.py (path:/tmp/pip-rCw2zO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:37 INFO - Running setup.py (path:/tmp/pip-RBDWJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:38 INFO - Running setup.py install for manifestparser 09:33:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Running setup.py install for mozcrash 09:33:38 INFO - Running setup.py install for mozdebug 09:33:38 INFO - Running setup.py install for mozdevice 09:33:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Running setup.py install for mozfile 09:33:38 INFO - Running setup.py install for mozhttpd 09:33:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Running setup.py install for mozinfo 09:33:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Running setup.py install for mozInstall 09:33:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:33:38 INFO - Running setup.py install for mozleak 09:33:38 INFO - Running setup.py install for mozlog 09:33:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:33:39 INFO - Running setup.py install for moznetwork 09:33:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:33:39 INFO - Running setup.py install for mozprocess 09:33:39 INFO - Running setup.py install for mozprofile 09:33:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:33:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:33:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:33:39 INFO - Running setup.py install for mozrunner 09:33:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:33:39 INFO - Running setup.py install for mozscreenshot 09:33:39 INFO - Running setup.py install for moztest 09:33:39 INFO - Running setup.py install for mozversion 09:33:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:33:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:33:39 INFO - Cleaning up... 09:33:39 INFO - Return code: 0 09:33:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:39 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')]} 09:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:39 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')]} 09:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:39 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 0xff2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1221400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b0570>, '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 0x12b1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b1900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', '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 09:33:39 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 09:33:39 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 09:33:39 INFO - Using env: {'DISPLAY': ':0', 09:33:39 INFO - 'HOME': '/home/cltbld', 09:33:39 INFO - 'LANG': 'en_US.UTF-8', 09:33:39 INFO - 'LANGUAGE': 'en_US:en', 09:33:39 INFO - 'LOGNAME': 'cltbld', 09:33:39 INFO - 'MAIL': '/var/mail/cltbld', 09:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:39 INFO - 'MOZ_NO_REMOTE': '1', 09:33:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:39 INFO - 'NO_EM_RESTART': '1', 09:33:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:39 INFO - 'PWD': '/builds/slave/test', 09:33:39 INFO - 'SHELL': '/bin/bash', 09:33:39 INFO - 'SHLVL': '1', 09:33:39 INFO - 'TERM': 'linux', 09:33:39 INFO - 'TMOUT': '86400', 09:33:39 INFO - 'USER': 'cltbld', 09:33:39 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', 09:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:39 INFO - '_': '/tools/buildbot/bin/python'} 09:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:40 INFO - Running setup.py (path:/tmp/pip-tUZyly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:40 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)) 09:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:40 INFO - Running setup.py (path:/tmp/pip-IOjdR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:40 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)) 09:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:40 INFO - Running setup.py (path:/tmp/pip-UUfji3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:40 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)) 09:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:40 INFO - Running setup.py (path:/tmp/pip-To6_Ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:40 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)) 09:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:40 INFO - Running setup.py (path:/tmp/pip-Ae96QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:40 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)) 09:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:40 INFO - Running setup.py (path:/tmp/pip-zSxKJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:40 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)) 09:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:40 INFO - Running setup.py (path:/tmp/pip-Kt9nN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:40 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)) 09:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:40 INFO - Running setup.py (path:/tmp/pip-D5aEWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:40 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)) 09:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:40 INFO - Running setup.py (path:/tmp/pip-P4FWxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:40 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)) 09:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:40 INFO - Running setup.py (path:/tmp/pip-BAst30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:40 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)) 09:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:40 INFO - Running setup.py (path:/tmp/pip-bZFxJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:40 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)) 09:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:40 INFO - Running setup.py (path:/tmp/pip-01m2n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:40 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)) 09:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:40 INFO - Running setup.py (path:/tmp/pip-jeA5Xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:41 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)) 09:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:41 INFO - Running setup.py (path:/tmp/pip-PUZhAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:41 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)) 09:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:41 INFO - Running setup.py (path:/tmp/pip-nzyA3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:41 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)) 09:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:41 INFO - Running setup.py (path:/tmp/pip-bzAIRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:41 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)) 09:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:41 INFO - Running setup.py (path:/tmp/pip-lR0DP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:41 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)) 09:33:41 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)) 09:33:41 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)) 09:33:41 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)) 09:33:41 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)) 09:33:41 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)) 09:33:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 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 09:33:43 INFO - Downloading blessings-1.6.tar.gz 09:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:33:43 INFO - Installing collected packages: blessings 09:33:43 INFO - Running setup.py install for blessings 09:33:43 INFO - Successfully installed blessings 09:33:43 INFO - Cleaning up... 09:33:43 INFO - Return code: 0 09:33:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:33:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:43 INFO - Reading from file tmpfile_stdout 09:33:43 INFO - Current package versions: 09:33:43 INFO - argparse == 1.2.1 09:33:43 INFO - blessings == 1.6 09:33:43 INFO - blobuploader == 1.2.4 09:33:43 INFO - docopt == 0.6.1 09:33:43 INFO - functools32 == 3.2.3-2 09:33:43 INFO - jsonschema == 2.5.1 09:33:43 INFO - manifestparser == 1.1 09:33:43 INFO - mozInstall == 1.12 09:33:43 INFO - mozcrash == 0.17 09:33:43 INFO - mozdebug == 0.1 09:33:43 INFO - mozdevice == 0.48 09:33:43 INFO - mozfile == 1.2 09:33:43 INFO - mozhttpd == 0.7 09:33:43 INFO - mozinfo == 0.9 09:33:43 INFO - mozleak == 0.1 09:33:43 INFO - mozlog == 3.2 09:33:43 INFO - moznetwork == 0.27 09:33:43 INFO - mozprocess == 0.23 09:33:43 INFO - mozprofile == 0.28 09:33:43 INFO - mozrunner == 6.12 09:33:43 INFO - mozscreenshot == 0.1 09:33:43 INFO - mozsystemmonitor == 0.3 09:33:43 INFO - moztest == 0.7 09:33:43 INFO - mozversion == 1.4 09:33:43 INFO - psutil == 3.1.1 09:33:43 INFO - requests == 1.2.3 09:33:43 INFO - wsgiref == 0.1.2 09:33:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:43 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 0xff2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1221400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b0570>, '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 0x12b1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b1900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', '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 09:33:43 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 09:33:43 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 09:33:43 INFO - Using env: {'DISPLAY': ':0', 09:33:43 INFO - 'HOME': '/home/cltbld', 09:33:43 INFO - 'LANG': 'en_US.UTF-8', 09:33:43 INFO - 'LANGUAGE': 'en_US:en', 09:33:43 INFO - 'LOGNAME': 'cltbld', 09:33:43 INFO - 'MAIL': '/var/mail/cltbld', 09:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:43 INFO - 'MOZ_NO_REMOTE': '1', 09:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:43 INFO - 'NO_EM_RESTART': '1', 09:33:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:43 INFO - 'PWD': '/builds/slave/test', 09:33:43 INFO - 'SHELL': '/bin/bash', 09:33:43 INFO - 'SHLVL': '1', 09:33:43 INFO - 'TERM': 'linux', 09:33:43 INFO - 'TMOUT': '86400', 09:33:43 INFO - 'USER': 'cltbld', 09:33:43 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', 09:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:43 INFO - '_': '/tools/buildbot/bin/python'} 09:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:43 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)) 09:33:43 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)) 09:33:43 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)) 09:33:43 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)) 09:33:43 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)) 09:33:43 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)) 09:33:43 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)) 09:33:43 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)) 09:33:43 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)) 09:33:43 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)) 09:33:43 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)) 09:33:43 INFO - Cleaning up... 09:33:43 INFO - Return code: 0 09:33:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:43 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 0xff2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1221400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b0570>, '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 0x12b1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b1900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', '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 09:33:43 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 09:33:43 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 09:33:43 INFO - Using env: {'DISPLAY': ':0', 09:33:43 INFO - 'HOME': '/home/cltbld', 09:33:43 INFO - 'LANG': 'en_US.UTF-8', 09:33:43 INFO - 'LANGUAGE': 'en_US:en', 09:33:43 INFO - 'LOGNAME': 'cltbld', 09:33:43 INFO - 'MAIL': '/var/mail/cltbld', 09:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:43 INFO - 'MOZ_NO_REMOTE': '1', 09:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:43 INFO - 'NO_EM_RESTART': '1', 09:33:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:43 INFO - 'PWD': '/builds/slave/test', 09:33:43 INFO - 'SHELL': '/bin/bash', 09:33:43 INFO - 'SHLVL': '1', 09:33:43 INFO - 'TERM': 'linux', 09:33:43 INFO - 'TMOUT': '86400', 09:33:43 INFO - 'USER': 'cltbld', 09:33:43 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', 09:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:43 INFO - '_': '/tools/buildbot/bin/python'} 09:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:33:44 INFO - Cleaning up... 09:33:44 INFO - Return code: 0 09:33:44 INFO - Running post-action listener: _resource_record_post_action 09:33:44 INFO - Running post-action listener: _start_resource_monitoring 09:33:44 INFO - Starting resource monitoring. 09:33:44 INFO - ##### 09:33:44 INFO - ##### Finished create-virtualenv step (success) 09:33:44 INFO - ##### 09:33:44 INFO - ##### 09:33:44 INFO - ##### Running install step. 09:33:44 INFO - ##### 09:33:44 INFO - Running pre-action listener: _resource_record_pre_action 09:33:44 INFO - Running main action method: install 09:33:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:44 INFO - Reading from file tmpfile_stdout 09:33:44 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:33:44 INFO - Reading from file tmpfile_stdout 09:33:44 INFO - Output received: 09:33:44 INFO - Usage: mozinstall [options] installer 09:33:44 INFO - Options: 09:33:44 INFO - -h, --help show this help message and exit 09:33:44 INFO - -d DEST, --destination=DEST 09:33:44 INFO - Directory to install application into. [default: 09:33:44 INFO - "/builds/slave/test"] 09:33:44 INFO - --app=APP Application being installed. [default: firefox] 09:33:44 INFO - mkdir: /builds/slave/test/build/application 09:33:44 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'] 09:33:44 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 09:34:00 INFO - Reading from file tmpfile_stdout 09:34:00 INFO - Output received: 09:34:00 INFO - /builds/slave/test/build/application/firefox/firefox 09:34:00 INFO - Running post-action listener: _resource_record_post_action 09:34:00 INFO - ##### 09:34:00 INFO - ##### Finished install step (success) 09:34:00 INFO - ##### 09:34:00 INFO - ##### 09:34:00 INFO - ##### Running run-tests step. 09:34:00 INFO - ##### 09:34:00 INFO - Running pre-action listener: _resource_record_pre_action 09:34:00 INFO - Running main action method: run_tests 09:34:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:34:00 INFO - Python 2.7.3 09:34:00 INFO - Return code: 0 09:34:00 INFO - grabbing minidump binary from tooltool 09:34: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')]} 09:34:00 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 0x12b0570>, '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 0x12b1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b1900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:34:00 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 09:34:00 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 09:34:00 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 09:34:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:34:00 INFO - Return code: 0 09:34:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:34:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:34:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:34:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:34:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:34:00 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/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 09:34:00 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/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 09:34:00 INFO - Using env: {'DISPLAY': ':0', 09:34:00 INFO - 'HOME': '/home/cltbld', 09:34:00 INFO - 'LANG': 'en_US.UTF-8', 09:34:00 INFO - 'LANGUAGE': 'en_US:en', 09:34:00 INFO - 'LOGNAME': 'cltbld', 09:34:00 INFO - 'MAIL': '/var/mail/cltbld', 09:34:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:34:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:00 INFO - 'MOZ_NO_REMOTE': '1', 09:34:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:34:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:00 INFO - 'NO_EM_RESTART': '1', 09:34:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:00 INFO - 'PWD': '/builds/slave/test', 09:34:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:34:00 INFO - 'SHELL': '/bin/bash', 09:34:00 INFO - 'SHLVL': '1', 09:34:00 INFO - 'TERM': 'linux', 09:34:00 INFO - 'TMOUT': '86400', 09:34:00 INFO - 'USER': 'cltbld', 09:34:00 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851', 09:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:00 INFO - '_': '/tools/buildbot/bin/python'} 09:34:00 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/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 09:34:01 INFO - mozversion application_buildid: 20160715071457 09:34:01 INFO - mozversion application_changeset: 676b7df970b6b2f9432e421f9151e80346ee42ab 09:34:01 INFO - mozversion application_display_name: Nightly 09:34:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:34:01 INFO - mozversion application_name: Firefox 09:34:01 INFO - mozversion application_remotingname: firefox 09:34:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:34:01 INFO - mozversion application_vendor: Mozilla 09:34:01 INFO - mozversion application_version: 50.0a1 09:34:01 INFO - mozversion platform_buildid: 20160715071457 09:34:01 INFO - mozversion platform_changeset: 676b7df970b6b2f9432e421f9151e80346ee42ab 09:34:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:34:01 INFO - mozversion platform_version: 50.0a1 09:34:01 INFO - using testdate: 1468600441 09:34:01 INFO - actual date: 1468600441 09:34:01 INFO - starting webserver on 'localhost:44161' 09:34:01 INFO - SUITE-START | Running 2 tests 09:34:01 INFO - TEST-START | dromaeo_css 09:34:01 INFO - operating with platform_type : linux_ 09:34:01 INFO - Initialising browser for dromaeo_css test... 09:34:01 INFO - TEST-INFO | started process 18915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVDz3yK/profile http://localhost:44161/getInfo.html) 09:34:06 INFO - PROCESS | 18915 | __metrics Screen width/height:1600/1200 09:34:06 INFO - PROCESS | 18915 | colorDepth:24 09:34:06 INFO - PROCESS | 18915 | Browser inner width/height: 1024/697 09:34:06 INFO - PROCESS | 18915 | __metrics 09:34:06 ERROR - PROCESS | 18915 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 09:34:07 INFO - TEST-INFO | 18915: exit 0 09:34:07 INFO - Browser initialized. 09:34:07 INFO - Running cycle 1/1 for dromaeo_css test... 09:34:07 INFO - TEST-INFO | started process 19035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVDz3yK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:19 INFO - PROCESS | 19035 | RSS: Main: 169136128 09:34:19 INFO - PROCESS | 19035 | 09:35:09 INFO - PROCESS | 19035 | 1468600509088 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] 09:37:22 INFO - PROCESS | 19035 | Cycle 1(1): loaded http://localhost:44161/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44161/tests/dromaeo/cssquery-ext.html) 09:37:23 INFO - PROCESS | 19035 | RSS: Main: 169914368 09:37:23 INFO - PROCESS | 19035 | 09:40:25 INFO - PROCESS | 19035 | Cycle 1(1): loaded http://localhost:44161/tests/dromaeo/cssquery-ext.html (next: http://localhost:44161/tests/dromaeo/cssquery-jquery.html) 09:40:26 INFO - PROCESS | 19035 | RSS: Main: 168767488 09:40:26 INFO - PROCESS | 19035 | 09:43:28 INFO - PROCESS | 19035 | Cycle 1(1): loaded http://localhost:44161/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44161/tests/dromaeo/cssquery-mootools.html) 09:43:29 INFO - PROCESS | 19035 | RSS: Main: 172163072 09:43:29 INFO - PROCESS | 19035 | 09:46:30 INFO - PROCESS | 19035 | Cycle 1(1): loaded http://localhost:44161/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44161/tests/dromaeo/cssquery-prototype.html) 09:46:31 INFO - PROCESS | 19035 | RSS: Main: 167804928 09:46:31 INFO - PROCESS | 19035 | 09:49:34 INFO - PROCESS | 19035 | Cycle 1(1): loaded http://localhost:44161/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44161/tests/dromaeo/cssquery-yui.html) 09:49:35 INFO - PROCESS | 19035 | RSS: Main: 169779200 09:49:35 INFO - PROCESS | 19035 | 09:52:37 INFO - PROCESS | 19035 | Cycle 1(1): loaded http://localhost:44161/tests/dromaeo/cssquery-yui.html (next: http://localhost:44161/tests/dromaeo/cssquery-dojo.html) 09:52:37 INFO - PROCESS | 19035 | RSS: Main: 170819584 09:52:37 INFO - PROCESS | 19035 | 09:52:37 INFO - PROCESS | 19035 | __start_tp_report 09:52:37 INFO - PROCESS | 19035 | _x_x_mozilla_page_load 09:52:37 INFO - PROCESS | 19035 | _x_x_mozilla_page_load_details 09:52:37 INFO - PROCESS | 19035 | |i|pagename|runs| 09:52:37 INFO - PROCESS | 19035 | |0;dojo.html;2652.602109683547;2663.2010396880937;2673.5054015007236;2677.3842016336243;2699.4601079784043;4639.072185562888;4724.433068031837;4750.7862146203415;4768.833090841821;4805.087033463648;4615.261558150696;4679.60223381013;4842.8062877484945;4902;4914.680545764523;4271.402003719481;4334.5882141196535;4397.164538737646;4410.448693913261;4410.669199810011;4324.437823083011;4424.269995450747;4430.822767089313;4442.355858400546;4445.066536027438;4258.74447533149;4349.347597860315;4366.908272931767;4368.060866913629;4411.404460397869;4266.552012038722;4297.140571885635;4300.655947524222;4339.696221264513;4355.586219309161;4366.497852746911;4374.1689079075195;4397.648188144941;4419;4424.446944131983;4769.475357710649;4800.807967681289;4826.227803551415;4853.102176097398;4891.266310053485;5173.611979101544;5177.404598471187;5180.844574662766;5190.844274671766;5195.986782577399;4956.058348913695;5221.216817477409;5227.712475813867;5244;5248.475152484721;4787.066522028206;4820.156472617348;4842.757862106881;4843.39457567804;4853.053654537402;5294.788208471695;5310.230016647564;5328.17413300939;5359.785608575691;5376;4908.410990681141;4983.875403114951;5112.233165025276;5122.129238029544;5125.538701516882;5063.265826455217;5131.97434012835;5152.587792976553;5162.148245539444;5215.504527069922;4858.951410485921;5092.159793634083;5093.0577843099145;5149.613778966593;5170.6380553360905;4908;5117.692938423632;5127.179651255781;5150.459201783834;5201.531862132426;4285;4286.507051689034;4324.848630297987;4327.6970612057485;4329.826806927751;3742.644448777362;3745.4943582615997;3748.8313025913353;3754.718396120302;3775.4903088083306;4274.807633656493;4411.073674528385;4419.513853476115;4425.159219748302;4431.977840110779;5138.640295179302;5185.896282074337;5191.532762051434;5217.243499692523;5278.129108697099;4458.331250312414;4487.50637429889;4493.842715504941;4507.391502147234;4511.413516242867;4522.638188944877;4558.612517935946;4599.402077729874;4712.764361781898;4749.572538471554;4843.903121937471;4866.0024694938165;4876.146674331907;4914.606831453403;4928.852134435972;5052.444231134498;5095.694258344512;5099.796008159632;5110.131277682728;5115.386153661584;4797.5682188601795;4853.49038350968;4869.926951095807;4883.047805677858;4904.019196160711;5052.873678158076;5078.669886457368;5081.923771143362;5086.872828179326;5134.666246693953;5098.643094983316;5142;5146.176611742103;5156;5157.458466860926;4755.643326750576;4756.738379389167;4886.193778026586;4924.72913989734;4944.085344211332;4946.35697359341;4981.37732783402;4993.101241776515;5011.724355160502;5034.320366750442;4913;4960.801567937387;4964.05682920244;4965.726885021359;5001.449840517613;4794.448638406628;4957.702537847741;4989.675671081368;5083.18669012971;5087.516685914832;4895.020995800925;4902.950970490249;4905.730184839726;4935.087008903364;4963.851084467472 09:52:37 INFO - PROCESS | 19035 | |1;ext.html;542.9891402171957;545.6807767456037;545.9563234941204;550.4990458682597;579.4611011759063;35509;36287;36297.27405451889;36340.273194536094;36509.81745091277;39938.20123597526;40125.19749605006;40262.19475610486;40378.79810600943;40417.797911010406;7776.261255180749;7865.252800983897;7918.604069796516;7943.602819859013;7945.364370850347;7870.724524641639;7947.403944704141;7979.960100199491;7988.281054705076;7998.120206777279;7958.840823183533;7976.680932762712;7991;7996.520208787462;8067.273945344918;7939.64271607779;7962.283394494494;7987.680492780281;7996.360291176692;7996.680132794681;7865.410094242955;7897.407694422941;7899.407544434191;7899.644515996736;7910.2880740733035;37871.431928521095;38079.23841523182;38118.428223576666;38179.61820381788;38192.236155277016;3064.4330798802293;3086.7221950024605;3150.2754366495606;3206.8236247006407;3779.527559055118;29512.704872951424;29997;30063.849680751457;30290.394192116255;30695.69304306973;3225.483922572401;3230.2408933900515;3249.8700051997894;3261.967380326214;3295.0279667498144;183661;183952;184051.07974460043;184071;184442;28814.71185288162;53277.73361133169;53818;53880.19179712307;53902;33820.154496137795;34370;34374.65625343764;34379.312413751584;34761.130971725404;14150.221737804519;14308.642283942776;14331.570052898429;14342.49801256951;14471.421143154366;11157.609483668033;11196.776064478665;11211.159163062803;11225.158113141384;11258.831117533244;7835.804104897309;7960.203979602109;7961.16407777175;7989.640466179036;8075.636596353178;3048.9847550762106;3108.6580476147606;3120.968790312113;3147.763917706181;3153.432382171231;827.6234313387515;844.7803571071443;881.2727054972326;914.3790589266579;1025.9076683098408;27743;29175.270618234714;29348.11955641334;29440.852795735886;29533;905.1627244798535;941.764558860285;978.1490103609905;1001.0890090018048;1052.2844465763355;14803.703925921422;14876.702465950837;15018.293048641446;15247.923760381127;15381.230938453033;372006;375461;376472;378789;379257;50432.495675043516;51004.74497627488;51022.74488627607;51082;51186.232206516936;1147.3345459633392;1195.1992165249303;1200.165884710118;1229.5757963502576;1229.6495498782983;26214.60678089792;27820.16539503818;27978.720212797612;28281.57577636378;28324.85837570799;44929.55070449384;44983.77508112438;45259.773701131286;45506.31740523829;45600.7719961398;337969;343587;344307;344947;345797;39404.408933865445;39408.6059139405;40260.79869600751;40399.1920161601;40535.3919691199;43588.78205608952;44283;44441.55558444374;44914.32628510641;45030;37302.253954920205;38120.61879381171;38124.2375152501;38278.61721382862;38983;36593;38143.42784858174;38491;38560.03599910025;40709.1858162841;31814.363712726077;35003.64996350004;37505;37539.24921501609;38539;32978;33824.323513530086;34836.65163348334;34951.475727863595;35018.649813501535;26048.21855344343;26480.867595661897;26568.202953911412;26854.59718104191;27006.729932700422 09:52:37 INFO - PROCESS | 19035 | |2;jquery.html;367.12807083177455;367.6342039670527;373.71597585834775;381.39929610862896;389.8596505258108;16218.756718649214;17377.391791287293;17631.29474821007;17847.286108555643;18014.099295035263;15985.600359991005;16702;17018.40435584755;17033.488995330128;17809.109544522787;4758.952410475903;4870.4642489326325;4902.730349830758;4934.087193869145;4939.616907265971;3547.7161827053774;4885.6335774817035;5350.91973620396;5609.49514543691;5636.859078523029;5678.630888992202;5690.4025077366905;5693.914591281134;5700.201971723962;5714.799982000631;5611.354694210157;5639.561911712528;5739.139129130622;5796.072628379481;5822.155787410844;4711.952880471185;5556.416576259475;5564.276644036249;5597.7201139943245;5605.327360716699;12288.631341059783;12984.805227921588;12994.220346779224;13009.284489353082;13161.802572961318;1895.9715604265948;1981.4947188466992;2183.814375778061;2361.1853910400882;2405.1581946318825;8895.555222238861;8944.284457243404;9860.50697465131;10602.734931626694;13190.53833115846;1588.8967217130964;1669.741190115534;1680.2270955360548;1697.8485960671865;1729.4725108841799;66345.3365466344;70425.64787176083;71946.64026679886;72476.275237248;73916.99999999946;9097.08825205155;9149.35954483193;9272.258219342437;9309.953450232706;9400.435973841591;12239.694007649701;12274.75450491003;12287.201331913397;12299.815502767466;12312;6908.447324214051;6933.0986971693355;6944.51388402807;7072.540284881569;7101.11236095488;7014.964925175342;7036.542624729376;7133.89299160513;7137.357637812518;7180.533265337736;3704.444333350019;3771.41543060826;3841.3469710149343;3856.2480316338606;3878.650921417086;1577.597712583284;1644.2189959769014;1652.272999880049;1713.6487020160837;1839.9172037258356;819.8729196974479;836.9874451883227;888.6401007591936;911.8449863523217;935.9906400936039;15803.525894223192;16834.074125922947;17250.568735781453;17294.13529323529;17315;859.3297228162044;865.5412631305418;875.2297977779641;877.3025444771422;919.048784508031;8216.671333146727;9357.251419886528;9534;9799.608015679292;9831.80336393268;369351;370890;372505;380791;390583;78159.60920195363;80280;82842.17157828464;84050.57974710087;84805.15194848095;863.8617821148586;864.5029108262648;865.3380164174412;872.232435456794;882.7881308485917;15073.321700523722;15539;15607.921960390126;15648.374065037271;15778.13220272896;35022;36156.91529254126;36662.63337366592;36719.81640091782;36985.81507092447;47091.76454117707;51305.48694513007;51450.74274628753;51689.48310516997;52019;7456.291652293024;7477.102747670315;7513;7545.7358992435;7574.659140338808;10862.945685271523;11511.769764604493;11769.764604708029;12253.877461225631;12420.75158496807;4982.676126051795;5941.7623295067715;10151.64469243573;10183.083522483012;10594.364338139736;10021.949890250502;10431;10520.684379468628;10708.30396024256;10857;9957.601695932082;10266.845997310196;10308.793824123326;10459.110975567162;10544.892786257333;7707.614619268902;7813;7816.687332506636;7827.25641064098;7833.686652533835;9567.091126342986;9658.227341812779;9745.12293893553;9799.902000979899;9871.851922221029 09:52:37 INFO - PROCESS | 19035 | |3;mootools.html;1373.4368908747413;1414.2433797918113;1511;1688.8648908087355;1744.9738253926184;6604.900926486107;7555.924440755591;7652.8852067218895;8117.066537348207;8145.104038555769;7706.576138312391;8011.719589814357;8043.155468675793;8054.556999365032;8072.636731347089;2220.145244081032;2261.231181398324;2262.1403866530695;2264.6942662740485;2265.161890100665;2185.661222510513;2193.7367515898113;2235.329401179648;2236.8769717665523;2243.6410174372104;2216.556688662266;2217.789310015546;2223.7665045170265;2225.94435139122;2248.213125406111;2175.8259339252822;2176.9564608707815;2178.7276590426195;2179.727534058243;2186.7485239197376;2153.3755210988793;2159.8596091254017;2170.869747815136;2171.685105659686;2177.281497105951;7972.760817175494;7976.322012628933;8043.195680431969;8069.677212911535;8075.757727268191;4537.863864084083;4660.324252983332;4673.532646735299;4679.672422930396;4683.812647494096;2773.556046517278;2926.078285340111;2927.209653393572;2932.003118939571;2932.5190778656643;889.3596610440472;889.7375274294099;909.6952520905504;926.0878035135386;931.6040682709821;10966.945165274203;10982.286151400134;10985.505652245669;10990;11024.283421577571;4084.1831633673382;4192.643625291823;4316.568343165721;4321.049369138785;4325.091730736581;9397.295202859676;9404.106609872051;9413.2469402449;9435.716928492157;9457.668981585612;4766.666333356701;4790.520947905182;4807.158747219222;4817.710937343771;4829.830955916596;3807.333716599584;4210.221109094828;4369.781510924441;4397.560243975577;4399.978000109979;3448.5516882805073;3494.9126271843406;3515.8066306352885;3537.7877327360443;3550.396432606463;1186.827909953052;1222.480445810527;1224.3205021213312;1235.9196652217577;1245.2279586656332;836.8075342671098;850.2602735620051;854.8803167556423;872.1583671756786;877.3376101043672;5382.838514844561;5475.479829416199;5475.780968761284;5575.247341608912;5647.152927060892;404.50044195418633;406.1227748064167;409.4411128809154;414.42808923685124;422.780154319752;3917.4515567820526;4080.7959602019782;4117.835286588563;4180.958190418118;4189.937150942738;9611.663591774255;9872.259580531489;9894.109530142321;10286;10295.279330446796;10137.695869123938;10156.695299141038;10174.593016279414;10206.693799186036;10242.231832612435;7498.4376171787335;7586.203448637924;7744.690212391554;7792.6103694816165;7799.766007019798;5588.916166257428;5769.07694768835;5875.265591801025;5879.118132280192;5881.264841894763;9223.30825188127;9367.156955874005;9371.34400591952;9395.812083758423;9516.33385662997;8865.512396818236;9214.769630759285;9224.723258302261;9506.61973521079;9775.560099795384;6056.333803281547;6973;7020.087388639444;7043.859122817617;7235.2041275458605;7857.4499785014505;7869.8819517708425;7898.486598371088;7905.960470197612;7963.641636126504;6659.866802664016;6723.327667233433;6774.932250677627;6921;7209;7113.288671132846;7137.678804453708;7139.714411423485;7176.641167941478;7187.137543494814;6549.410553050057;6554.934450655433;6628.668566571749;6654.434373078343;6658.9667051666365;4866.8053277868485;4885.609151267961;4964.900701986012;4973.229149481836;5002.849914502571;4897.289892965428;4972.950270497248;4979.676321039121;4980.551750342486;5008.173651347487 09:52:37 INFO - PROCESS | 19035 | |4;prototype.html;295.71758970183475;301.61393416426984;309.55115083129454;310.627247303236;314.8787716729059;4981.427135879375;5021.472745361734;5052.772625231864;5057.494250574945;5082.390113186413;4953.4798846121175;4973.5772459341;4974.1295273327205;4986.35177426934;4987.975060124694;3710.2932650980515;3821.5987321331277;3926.548446928597;3933.940990885125;3941.152652179781;3899.9610003900025;3909.654207475506;3912.5109361329833;3919.314120028998;3934.075492259317;3879.9030024249337;3881.4565960765517;3892.6885849132145;3902.8633997810084;3912.5696173421043;3818.618138186187;3881.6894648428056;3883.592222816606;3912.3544615138467;3916.17760270345;3433.9141521461916;3457.6369481204615;3458.8962331130106;3464.1685995361186;3469.670381313771;4866.635002374801;4870.342503761982;4872.9756351218375;4874.341963834872;4882.926756098661;4359.891002724926;4465.1739428205565;4474.485434175079;4486.192485352635;4507.143642707875;5179.766910489037;5183.922241166386;5242.842714718565;5244.187150991603;5250.527452529291;3708.9443658345144;3729.533808273966;3734.8692795752017;3737.831797569116;3739;5340.546053585489;5476.070302388203;5482.574530622027;5484.972575137139;5497.340319161686;3873.573906870242;3875.748076375083;3884.9223015539533;3886.8833934981994;3896.8441262349756;3897.006263402814;3907.980460097738;3931.941020884689;3936.6063393660406;3941.724079314478;4397.164538737629;4404.625606823456;4406.449193850769;4417.558244175621;4453.665975051884;4955.975220123876;5187.0922588546855;5188.936268065037;5204.531592156724;5215.817446389358;1331.9533816316382;1334.2194816032536;1337.2912356451097;1344.7695358746637;1348.2315080404076;844.2064459408136;846.8094678697244;857.2627540315324;883.5140672630027;892.2950868813565;4439.822407103679;4566.292224705176;4598.448186217675;4614.661748093015;4659.953400465952;5351.545118664957;5390.838274851761;5393.2179833923865;5411.107167317427;5417.51242388187;4482.260427029503;4581.541845815458;4627.629789616823;4630.513796051433;4644.2801365788355;2802.271409433521;2856;2866.5270230412166;2874.4969630314613;2876.367199216169;5052.343195384577;5092.562520298783;5109.897802043938;5111.309973153577;5144.819931302462;5350.8662283442445;5388.973055134699;5425.565954723613;5462.399136095027;5491.752871120809;5073.746312684351;5075.771590278447;5093.8726531837;5105.085592902661;5125.666831656005;5323.893522129459;5350.7324633767375;5354.4110147884485;5356.634058315105;5366.409694933633;5084.796608135781;5239.659422137549;5266.578673706018;5279.577633789365;5301.019311427398;5108.182690769459;5116.513931176532;5134.614903882299;5138.409082955508;5146.25027490655;3808.1622043150464;3825.7704537726713;3826.789526576065;3829.291581057513;3842.634949679776;5240.397354304304;5366.275552800478;5383.596230282823;5388.2725832012175;5400.675959442446;5224;5242;5250.894982100413;5257.816991176955;5261.237120617566;5220.712860792541;5224.843254702365;5230.738463076755;5235.397929238186;5248.763805628832;4968.527989840959;5204.453532379046;5206.2450944612065;5206.5314121729225;5210.97394513025;5050.974745126251;5116.437191908962;5285.577153827608;5294.391145018218;5302.151655735064;5121.924395876758;5130.974345128399;5143.897122057613;5150.6137039721425;5163.66436181647 09:52:37 INFO - PROCESS | 19035 | |5;yui.html;638.6072565372298;658.9143411356523;717.3257138290007;723.7141329174976;763.9961800190998;12856.1643493173;13906.721865562682;13941.233232172226;13953.930230348848;13958.720825583483;12507.562235321766;13081.869181308208;13112.475500979974;13146.868531314683;13176.077674562785;776.6543887969856;789.3093543149744;789.6407134753673;792.0297635396622;793.9801504962364;784.2079499705281;786.7561056072607;787.5314188058096;788.7081779741503;789.3251270164013;835.5738573327616;836.7196989008659;837.5435387713711;840.3025488844276;844.273924424994;825.2325337436182;825.3933358981144;826.8883700700388;828.8052307707684;830.211299265697;599.0325624117063;602.7106988645431;604;605.267626172332;605.772835186805;11419.371934543597;11444.198906076577;11496.712582185428;11510.079193664487;11563.190576659637;10859.13126949842;10993.945030274877;11103.38931358775;11230.045446137088;11405.14461415397;9385.10841470066;9638.325317227796;9705.417674939526;9736.610535578568;9841.163501102415;3206.150370151912;3217.1313745288876;3277.0332751838264;3322.335532893431;3386.3227354528944;43705.12589748187;44521;52377.73811130958;52752.47247527552;57818.710906445616;10508.264421490576;10578.841317380246;10643.254972151875;10646.254762166729;10923.453827308604;20283.492912677008;20804.271850485162;20839.270625528035;20889;20897.686534701992;7334;7461.365783908429;7468.178500364956;7595.962020189863;7689.269519395649;3760.605136460687;3798.145417281145;3851.614838516126;3853.460515527828;3853.5953724859046;2967.629046369204;3054.862531186102;3086.2901532647616;3088.089013740952;3117.8285194314076;494.8391772673895;500.9198528235465;502.8466317773114;517.8368813823633;521.6922016010571;439.54726631569537;467.48576565777375;498.2003883766575;538.2195816066719;550.3643291997749;7630.618469076524;7753.728619498291;7757.456978011598;7818.14000459949;8135.633896474673;495.8438092001008;506.43490719505587;520.3963402453136;523.6151428699902;533.5304931660114;3512.7189824813954;3859.1702783901596;3878.7866667333005;3916.706247031484;4015.3976903464713;92771.53614232021;95084;95334.52332738292;97237.5138124319;97293;46766;47260;48425.757871210415;58067;85225;73354;74221;74444.62777686077;74833.25166748372;75714.62142689251;8170.959145204236;8186.713465028695;8200.466969646954;8409.2431681149;8489.4481858679;44633.33050004317;44723.77638111919;44798;44818.327725084804;45027.549724502336;60769.69615152073;63640.04539931812;63749;65079;65143.674281628286;11145.2198346115;11253;12049.33728644933;12272.75454490923;12436.31600261958;12824.743505130033;12836.486540538273;12867.163634364111;13010.349482526026;13604.86395136036;12024.33866137371;12028.578999734968;12295.631131066082;12520.937395312965;12538.937305313415;11334.546618135511;11362.431878406212;11768.176227663982;11831.585894493652;12064.939675301568;11487.19589628718;11598.536058557564;11781.609195402285;11808.232464890098;12271.447784849524;9940.850887236553;10107.595696172364;10130.189584833342;10311.123554497952;10322.312166218959;9604.183644390025;10179;10300.484975751333;10319.742006449898;10378.221633377376 09:52:37 INFO - PROCESS | 19035 | __end_tp_report 09:52:37 INFO - PROCESS | 19035 | __start_cc_report 09:52:37 INFO - PROCESS | 19035 | _x_x_mozilla_cycle_collect,439 09:52:37 INFO - PROCESS | 19035 | __end_cc_report 09:52:37 INFO - PROCESS | 19035 | __startTimestamp1468601557744__endTimestamp 09:52:37 INFO - PROCESS | 19035 | 09:52:37 INFO - PROCESS | 19035 | ------- Summary: start ------- 09:52:37 INFO - PROCESS | 19035 | Number of tests: 6 09:52:37 INFO - PROCESS | 19035 | 09:52:37 INFO - PROCESS | 19035 | [#0] dojo.html Cycles:165 Average:4737.05 Median:4883.05 stddev:511.28 (10.5%) stddev-sans-first:486.00 09:52:37 INFO - PROCESS | 19035 | Values: 2652.6 2663.2 2673.5 2677.4 2699.5 4639.1 4724.4 4750.8 4768.8 4805.1 4615.3 4679.6 4842.8 4902.0 4914.7 4271.4 4334.6 4397.2 4410.4 4410.7 4324.4 4424.3 4430.8 4442.4 4445.1 4258.7 4349.3 4366.9 4368.1 4411.4 4266.6 4297.1 4300.7 4339.7 4355.6 4366.5 4374.2 4397.6 4419.0 4424.4 4769.5 4800.8 4826.2 4853.1 4891.3 5173.6 5177.4 5180.8 5190.8 5196.0 4956.1 5221.2 5227.7 5244.0 5248.5 4787.1 4820.2 4842.8 4843.4 4853.1 5294.8 5310.2 5328.2 5359.8 5376.0 4908.4 4983.9 5112.2 5122.1 5125.5 5063.3 5132.0 5152.6 5162.1 5215.5 4859.0 5092.2 5093.1 5149.6 5170.6 4908.0 5117.7 5127.2 5150.5 5201.5 4285.0 4286.5 4324.8 4327.7 4329.8 3742.6 3745.5 3748.8 3754.7 3775.5 4274.8 4411.1 4419.5 4425.2 4432.0 5138.6 5185.9 5191.5 5217.2 5278.1 4458.3 4487.5 4493.8 4507.4 4511.4 4522.6 4558.6 4599.4 4712.8 4749.6 4843.9 4866.0 4876.1 4914.6 4928.9 5052.4 5095.7 5099.8 5110.1 5115.4 4797.6 4853.5 4869.9 4883.0 4904.0 5052.9 5078.7 5081.9 5086.9 5134.7 5098.6 5142.0 5146.2 5156.0 5157.5 4755.6 4756.7 4886.2 4924.7 4944.1 4946.4 4981.4 4993.1 5011.7 5034.3 4913.0 4960.8 4964.1 4965.7 5001.4 4794.4 4957.7 4989.7 5083.2 5087.5 4895.0 4903.0 4905.7 4935.1 4963.9 09:52:37 INFO - PROCESS | 19035 | 09:52:37 INFO - PROCESS | 19035 | [#1] ext.html Cycles:180 Average:45668.30 Median:375966.50 stddev:82594.97 (22.0%) stddev-sans-first:82757.18 09:52:37 INFO - PROCESS | 19035 | Values: 543.0 545.7 546.0 550.5 579.5 35509.0 36287.0 36297.3 36340.3 36509.8 39938.2 40125.2 40262.2 40378.8 40417.8 7776.3 7865.3 7918.6 7943.6 7945.4 7870.7 7947.4 7980.0 7988.3 7998.1 7958.8 7976.7 7991.0 7996.5 8067.3 7939.6 7962.3 7987.7 7996.4 7996.7 7865.4 7897.4 7899.4 7899.6 7910.3 37871.4 38079.2 38118.4 38179.6 38192.2 3064.4 3086.7 3150.3 3206.8 3779.5 29512.7 29997.0 30063.8 30290.4 30695.7 3225.5 3230.2 3249.9 3262.0 3295.0 183661.0 183952.0 184051.1 184071.0 184442.0 28814.7 53277.7 53818.0 53880.2 53902.0 33820.2 34370.0 34374.7 34379.3 34761.1 14150.2 14308.6 14331.6 14342.5 14471.4 11157.6 11196.8 11211.2 11225.2 11258.8 7835.8 7960.2 7961.2 7989.6 8075.6 3049.0 3108.7 3121.0 3147.8 3153.4 827.6 844.8 881.3 914.4 1025.9 27743.0 29175.3 29348.1 29440.9 29533.0 905.2 941.8 978.1 1001.1 1052.3 14803.7 14876.7 15018.3 15247.9 15381.2 372006.0 375461.0 376472.0 378789.0 379257.0 50432.5 51004.7 51022.7 51082.0 51186.2 1147.3 1195.2 1200.2 1229.6 1229.6 26214.6 27820.2 27978.7 28281.6 28324.9 44929.6 44983.8 45259.8 45506.3 45600.8 337969.0 343587.0 344307.0 344947.0 345797.0 39404.4 39408.6 40260.8 40399.2 40535.4 43588.8 44283.0 44441.6 44914.3 45030.0 37302.3 38120.6 38124.2 38278.6 38983.0 36593.0 38143.4 38491.0 38560.0 40709.2 31814.4 35003.6 37505.0 37539.2 38539.0 32978.0 33824.3 34836.7 34951.5 35018.6 26048.2 26480.9 26568.2 26854.6 27006.7 09:52:37 INFO - PROCESS | 19035 | 09:52:37 INFO - PROCESS | 19035 | [#2] jquery.html Cycles:180 Average:23801.32 Median:4918.41 stddev:62529.21 (1271.3%) stddev-sans-first:62679.86 09:52:37 INFO - PROCESS | 19035 | Values: 367.1 367.6 373.7 381.4 389.9 16218.8 17377.4 17631.3 17847.3 18014.1 15985.6 16702.0 17018.4 17033.5 17809.1 4759.0 4870.5 4902.7 4934.1 4939.6 3547.7 4885.6 5350.9 5609.5 5636.9 5678.6 5690.4 5693.9 5700.2 5714.8 5611.4 5639.6 5739.1 5796.1 5822.2 4712.0 5556.4 5564.3 5597.7 5605.3 12288.6 12984.8 12994.2 13009.3 13161.8 1896.0 1981.5 2183.8 2361.2 2405.2 8895.6 8944.3 9860.5 10602.7 13190.5 1588.9 1669.7 1680.2 1697.8 1729.5 66345.3 70425.6 71946.6 72476.3 73917.0 9097.1 9149.4 9272.3 9310.0 9400.4 12239.7 12274.8 12287.2 12299.8 12312.0 6908.4 6933.1 6944.5 7072.5 7101.1 7015.0 7036.5 7133.9 7137.4 7180.5 3704.4 3771.4 3841.3 3856.2 3878.7 1577.6 1644.2 1652.3 1713.6 1839.9 819.9 837.0 888.6 911.8 936.0 15803.5 16834.1 17250.6 17294.1 17315.0 859.3 865.5 875.2 877.3 919.0 8216.7 9357.3 9534.0 9799.6 9831.8 369351.0 370890.0 372505.0 380791.0 390583.0 78159.6 80280.0 82842.2 84050.6 84805.2 863.9 864.5 865.3 872.2 882.8 15073.3 15539.0 15607.9 15648.4 15778.1 35022.0 36156.9 36662.6 36719.8 36985.8 47091.8 51305.5 51450.7 51689.5 52019.0 7456.3 7477.1 7513.0 7545.7 7574.7 10862.9 11511.8 11769.8 12253.9 12420.8 4982.7 5941.8 10151.6 10183.1 10594.4 10021.9 10431.0 10520.7 10708.3 10857.0 9957.6 10266.8 10308.8 10459.1 10544.9 7707.6 7813.0 7816.7 7827.3 7833.7 9567.1 9658.2 9745.1 9799.9 9871.9 09:52:37 INFO - PROCESS | 19035 | 09:52:37 INFO - PROCESS | 19035 | [#3] mootools.html Cycles:180 Average:5322.70 Median:4968.93 stddev:3019.91 (60.8%) stddev-sans-first:3013.80 09:52:37 INFO - PROCESS | 19035 | Values: 1373.4 1414.2 1511.0 1688.9 1745.0 6604.9 7555.9 7652.9 8117.1 8145.1 7706.6 8011.7 8043.2 8054.6 8072.6 2220.1 2261.2 2262.1 2264.7 2265.2 2185.7 2193.7 2235.3 2236.9 2243.6 2216.6 2217.8 2223.8 2225.9 2248.2 2175.8 2177.0 2178.7 2179.7 2186.7 2153.4 2159.9 2170.9 2171.7 2177.3 7972.8 7976.3 8043.2 8069.7 8075.8 4537.9 4660.3 4673.5 4679.7 4683.8 2773.6 2926.1 2927.2 2932.0 2932.5 889.4 889.7 909.7 926.1 931.6 10966.9 10982.3 10985.5 10990.0 11024.3 4084.2 4192.6 4316.6 4321.0 4325.1 9397.3 9404.1 9413.2 9435.7 9457.7 4766.7 4790.5 4807.2 4817.7 4829.8 3807.3 4210.2 4369.8 4397.6 4400.0 3448.6 3494.9 3515.8 3537.8 3550.4 1186.8 1222.5 1224.3 1235.9 1245.2 836.8 850.3 854.9 872.2 877.3 5382.8 5475.5 5475.8 5575.2 5647.2 404.5 406.1 409.4 414.4 422.8 3917.5 4080.8 4117.8 4181.0 4189.9 9611.7 9872.3 9894.1 10286.0 10295.3 10137.7 10156.7 10174.6 10206.7 10242.2 7498.4 7586.2 7744.7 7792.6 7799.8 5588.9 5769.1 5875.3 5879.1 5881.3 9223.3 9367.2 9371.3 9395.8 9516.3 8865.5 9214.8 9224.7 9506.6 9775.6 6056.3 6973.0 7020.1 7043.9 7235.2 7857.4 7869.9 7898.5 7906.0 7963.6 6659.9 6723.3 6774.9 6921.0 7209.0 7113.3 7137.7 7139.7 7176.6 7187.1 6549.4 6554.9 6628.7 6654.4 6659.0 4866.8 4885.6 4964.9 4973.2 5002.8 4897.3 4973.0 4979.7 4980.6 5008.2 09:52:37 INFO - PROCESS | 19035 | 09:52:37 INFO - PROCESS | 19035 | [#4] prototype.html Cycles:180 Average:4349.34 Median:4983.89 stddev:1259.93 (25.3%) stddev-sans-first:1226.18 09:52:37 INFO - PROCESS | 19035 | Values: 295.7 301.6 309.6 310.6 314.9 4981.4 5021.5 5052.8 5057.5 5082.4 4953.5 4973.6 4974.1 4986.4 4988.0 3710.3 3821.6 3926.5 3933.9 3941.2 3900.0 3909.7 3912.5 3919.3 3934.1 3879.9 3881.5 3892.7 3902.9 3912.6 3818.6 3881.7 3883.6 3912.4 3916.2 3433.9 3457.6 3458.9 3464.2 3469.7 4866.6 4870.3 4873.0 4874.3 4882.9 4359.9 4465.2 4474.5 4486.2 4507.1 5179.8 5183.9 5242.8 5244.2 5250.5 3708.9 3729.5 3734.9 3737.8 3739.0 5340.5 5476.1 5482.6 5485.0 5497.3 3873.6 3875.7 3884.9 3886.9 3896.8 3897.0 3908.0 3931.9 3936.6 3941.7 4397.2 4404.6 4406.4 4417.6 4453.7 4956.0 5187.1 5188.9 5204.5 5215.8 1332.0 1334.2 1337.3 1344.8 1348.2 844.2 846.8 857.3 883.5 892.3 4439.8 4566.3 4598.4 4614.7 4660.0 5351.5 5390.8 5393.2 5411.1 5417.5 4482.3 4581.5 4627.6 4630.5 4644.3 2802.3 2856.0 2866.5 2874.5 2876.4 5052.3 5092.6 5109.9 5111.3 5144.8 5350.9 5389.0 5425.6 5462.4 5491.8 5073.7 5075.8 5093.9 5105.1 5125.7 5323.9 5350.7 5354.4 5356.6 5366.4 5084.8 5239.7 5266.6 5279.6 5301.0 5108.2 5116.5 5134.6 5138.4 5146.3 3808.2 3825.8 3826.8 3829.3 3842.6 5240.4 5366.3 5383.6 5388.3 5400.7 5224.0 5242.0 5250.9 5257.8 5261.2 5220.7 5224.8 5230.7 5235.4 5248.8 4968.5 5204.5 5206.2 5206.5 5211.0 5051.0 5116.4 5285.6 5294.4 5302.2 5121.9 5131.0 5143.9 5150.6 5163.7 09:52:37 INFO - PROCESS | 19035 | 09:52:37 INFO - PROCESS | 19035 | [#5] yui.html Cycles:180 Average:16692.52 Median:22747.52 stddev:23148.56 (101.8%) stddev-sans-first:23182.11 09:52:37 INFO - PROCESS | 19035 | Values: 638.6 658.9 717.3 723.7 764.0 12856.2 13906.7 13941.2 13953.9 13958.7 12507.6 13081.9 13112.5 13146.9 13176.1 776.7 789.3 789.6 792.0 794.0 784.2 786.8 787.5 788.7 789.3 835.6 836.7 837.5 840.3 844.3 825.2 825.4 826.9 828.8 830.2 599.0 602.7 604.0 605.3 605.8 11419.4 11444.2 11496.7 11510.1 11563.2 10859.1 10993.9 11103.4 11230.0 11405.1 9385.1 9638.3 9705.4 9736.6 9841.2 3206.2 3217.1 3277.0 3322.3 3386.3 43705.1 44521.0 52377.7 52752.5 57818.7 10508.3 10578.8 10643.3 10646.3 10923.5 20283.5 20804.3 20839.3 20889.0 20897.7 7334.0 7461.4 7468.2 7596.0 7689.3 3760.6 3798.1 3851.6 3853.5 3853.6 2967.6 3054.9 3086.3 3088.1 3117.8 494.8 500.9 502.8 517.8 521.7 439.5 467.5 498.2 538.2 550.4 7630.6 7753.7 7757.5 7818.1 8135.6 495.8 506.4 520.4 523.6 533.5 3512.7 3859.2 3878.8 3916.7 4015.4 92771.5 95084.0 95334.5 97237.5 97293.0 46766.0 47260.0 48425.8 58067.0 85225.0 73354.0 74221.0 74444.6 74833.3 75714.6 8171.0 8186.7 8200.5 8409.2 8489.4 44633.3 44723.8 44798.0 44818.3 45027.5 60769.7 63640.0 63749.0 65079.0 65143.7 11145.2 11253.0 12049.3 12272.8 12436.3 12824.7 12836.5 12867.2 13010.3 13604.9 12024.3 12028.6 12295.6 12520.9 12538.9 11334.5 11362.4 11768.2 11831.6 12064.9 11487.2 11598.5 11781.6 11808.2 12271.4 9940.9 10107.6 10130.2 10311.1 10322.3 9604.2 10179.0 10300.5 10319.7 10378.2 09:52:37 INFO - PROCESS | 19035 | -------- Summary: end -------- 09:52:37 INFO - PROCESS | 19035 | 09:52:38 INFO - TEST-INFO | 19035: exit 0 09:52:38 INFO - TEST-OK | dromaeo_css | took 1117427ms 09:52:38 INFO - TEST-START | kraken 09:52:38 INFO - operating with platform_type : linux_ 09:52:38 INFO - Initialising browser for kraken test... 09:52:38 INFO - TEST-INFO | started process 19276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxxlZOA/profile http://localhost:44161/getInfo.html) 09:52:43 INFO - PROCESS | 19276 | __metrics Screen width/height:1600/1200 09:52:43 INFO - PROCESS | 19276 | colorDepth:24 09:52:43 INFO - PROCESS | 19276 | Browser inner width/height: 1024/697 09:52:43 INFO - PROCESS | 19276 | __metrics 09:52:44 ERROR - PROCESS | 19276 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 09:52:44 INFO - TEST-INFO | 19276: exit 0 09:52:44 INFO - Browser initialized. 09:52:44 INFO - Running cycle 1/1 for kraken test... 09:52:44 INFO - TEST-INFO | started process 19398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxxlZOA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:56 INFO - PROCESS | 19398 | RSS: Main: 169164800 09:52:56 INFO - PROCESS | 19398 | 09:52:59 INFO - PROCESS | 19398 | Cycle 1(1): loaded http://localhost:44161/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44161/tests/kraken/driver.html?testName=audio-beat-detection) 09:53:00 INFO - PROCESS | 19398 | RSS: Main: 173961216 09:53:00 INFO - PROCESS | 19398 | 09:53:03 INFO - PROCESS | 19398 | Cycle 1(1): loaded http://localhost:44161/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44161/tests/kraken/driver.html?testName=audio-dft) 09:53:03 INFO - PROCESS | 19398 | RSS: Main: 173314048 09:53:03 INFO - PROCESS | 19398 | 09:53:06 INFO - PROCESS | 19398 | Cycle 1(1): loaded http://localhost:44161/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44161/tests/kraken/driver.html?testName=audio-fft) 09:53:07 INFO - PROCESS | 19398 | RSS: Main: 168357888 09:53:07 INFO - PROCESS | 19398 | 09:53:09 INFO - PROCESS | 19398 | Cycle 1(1): loaded http://localhost:44161/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44161/tests/kraken/driver.html?testName=audio-oscillator) 09:53:10 INFO - PROCESS | 19398 | RSS: Main: 168828928 09:53:10 INFO - PROCESS | 19398 | 09:53:12 INFO - PROCESS | 19398 | Cycle 1(1): loaded http://localhost:44161/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44161/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:53:13 INFO - PROCESS | 19398 | RSS: Main: 168976384 09:53:13 INFO - PROCESS | 19398 | 09:53:16 INFO - PROCESS | 19398 | Cycle 1(1): loaded http://localhost:44161/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44161/tests/kraken/driver.html?testName=imaging-darkroom) 09:53:16 INFO - PROCESS | 19398 | RSS: Main: 169488384 09:53:16 INFO - PROCESS | 19398 | 09:53:20 INFO - PROCESS | 19398 | Cycle 1(1): loaded http://localhost:44161/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44161/tests/kraken/driver.html?testName=imaging-desaturate) 09:53:21 INFO - PROCESS | 19398 | RSS: Main: 167317504 09:53:21 INFO - PROCESS | 19398 | 09:53:24 INFO - PROCESS | 19398 | Cycle 1(1): loaded http://localhost:44161/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44161/tests/kraken/driver.html?testName=json-parse-financial) 09:53:24 INFO - PROCESS | 19398 | RSS: Main: 168570880 09:53:24 INFO - PROCESS | 19398 | 09:53:26 INFO - PROCESS | 19398 | Cycle 1(1): loaded http://localhost:44161/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44161/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:53:27 INFO - PROCESS | 19398 | RSS: Main: 169222144 09:53:27 INFO - PROCESS | 19398 | 09:53:28 INFO - PROCESS | 19398 | Cycle 1(1): loaded http://localhost:44161/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44161/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:53:29 INFO - PROCESS | 19398 | RSS: Main: 169394176 09:53:29 INFO - PROCESS | 19398 | 09:53:31 INFO - PROCESS | 19398 | Cycle 1(1): loaded http://localhost:44161/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44161/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:53:32 INFO - PROCESS | 19398 | RSS: Main: 169480192 09:53:32 INFO - PROCESS | 19398 | 09:53:35 INFO - PROCESS | 19398 | Cycle 1(1): loaded http://localhost:44161/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44161/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:53:36 INFO - PROCESS | 19398 | RSS: Main: 169992192 09:53:36 INFO - PROCESS | 19398 | 09:53:38 INFO - PROCESS | 19398 | Cycle 1(1): loaded http://localhost:44161/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44161/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:53:39 INFO - PROCESS | 19398 | RSS: Main: 169709568 09:53:39 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | Cycle 1(1): loaded http://localhost:44161/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44161/tests/kraken/driver.html?testName=ai-astar) 09:53:41 INFO - PROCESS | 19398 | RSS: Main: 170618880 09:53:41 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | __start_tp_report 09:53:41 INFO - PROCESS | 19398 | _x_x_mozilla_page_load 09:53:41 INFO - PROCESS | 19398 | _x_x_mozilla_page_load_details 09:53:41 INFO - PROCESS | 19398 | |i|pagename|runs| 09:53:41 INFO - PROCESS | 19398 | |0;ai-astar;103;113;107;113;112;114;114;112;113;112 09:53:41 INFO - PROCESS | 19398 | |1;audio-beat-detection;150;121;147;179;129;150;149;123;178;124 09:53:41 INFO - PROCESS | 19398 | |2;audio-dft;163;161;163;168;175;164;162;162;163;163 09:53:41 INFO - PROCESS | 19398 | |3;audio-fft;75;76;76;150;78;77;77;76;168;77 09:53:41 INFO - PROCESS | 19398 | |4;audio-oscillator;86;87;140;89;86;85;141;85;86;147 09:53:41 INFO - PROCESS | 19398 | |5;imaging-gaussian-blur;118;118;118;117;118;117;118;117;117;118 09:53:41 INFO - PROCESS | 19398 | |6;imaging-darkroom;147;149;149;147;147;149;147;147;147;147 09:53:41 INFO - PROCESS | 19398 | |7;imaging-desaturate;96;95;95;96;95;97;96;95;96;96 09:53:41 INFO - PROCESS | 19398 | |8;json-parse-financial;68;66;66;67;70;66;67;68;67;68 09:53:41 INFO - PROCESS | 19398 | |9;json-stringify-tinderbox;66;66;66;66;66;67;67;65;66;66 09:53:41 INFO - PROCESS | 19398 | |10;stanford-crypto-aes;82;80;79;85;80;85;79;80;84;79 09:53:41 INFO - PROCESS | 19398 | |11;stanford-crypto-ccm;143;130;139;146;138;130;154;134;176;141 09:53:41 INFO - PROCESS | 19398 | |12;stanford-crypto-pbkdf2;172;167;167;166;166;165;167;165;166;172 09:53:41 INFO - PROCESS | 19398 | |13;stanford-crypto-sha256-iterative;68;71;68;69;67;67;69;71;67;67 09:53:41 INFO - PROCESS | 19398 | __end_tp_report 09:53:41 INFO - PROCESS | 19398 | __start_cc_report 09:53:41 INFO - PROCESS | 19398 | _x_x_mozilla_cycle_collect,1048 09:53:41 INFO - PROCESS | 19398 | __end_cc_report 09:53:41 INFO - PROCESS | 19398 | __startTimestamp1468601621530__endTimestamp 09:53:41 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | ------- Summary: start ------- 09:53:41 INFO - PROCESS | 19398 | Number of tests: 14 09:53:41 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.53 (3.1%) stddev-sans-first:2.11 09:53:41 INFO - PROCESS | 19398 | Values: 103.0 113.0 107.0 113.0 112.0 114.0 114.0 112.0 113.0 112.0 09:53:41 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:149.50 stddev:21.27 (14.2%) stddev-sans-first:22.48 09:53:41 INFO - PROCESS | 19398 | Values: 150.0 121.0 147.0 179.0 129.0 150.0 149.0 123.0 178.0 124.0 09:53:41 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.00 stddev:4.17 (2.6%) stddev-sans-first:4.39 09:53:41 INFO - PROCESS | 19398 | Values: 163.0 161.0 163.0 168.0 175.0 164.0 162.0 162.0 163.0 163.0 09:53:41 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.50 stddev:35.05 (45.8%) stddev-sans-first:36.57 09:53:41 INFO - PROCESS | 19398 | Values: 75.0 76.0 76.0 150.0 78.0 77.0 77.0 76.0 168.0 77.0 09:53:41 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:86.00 stddev:27.32 (31.8%) stddev-sans-first:28.26 09:53:41 INFO - PROCESS | 19398 | Values: 86.0 87.0 140.0 89.0 86.0 85.0 141.0 85.0 86.0 147.0 09:53:41 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:53:41 INFO - PROCESS | 19398 | Values: 118.0 118.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 09:53:41 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 09:53:41 INFO - PROCESS | 19398 | Values: 147.0 149.0 149.0 147.0 147.0 149.0 147.0 147.0 147.0 147.0 09:53:41 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:53:41 INFO - PROCESS | 19398 | Values: 96.0 95.0 95.0 96.0 95.0 97.0 96.0 95.0 96.0 96.0 09:53:41 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:67.50 stddev:1.25 (1.9%) stddev-sans-first:1.30 09:53:41 INFO - PROCESS | 19398 | Values: 68.0 66.0 66.0 67.0 70.0 66.0 67.0 68.0 67.0 68.0 09:53:41 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:53:41 INFO - PROCESS | 19398 | Values: 66.0 66.0 66.0 66.0 66.0 67.0 67.0 65.0 66.0 66.0 09:53:41 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:2.50 (3.1%) stddev-sans-first:2.64 09:53:41 INFO - PROCESS | 19398 | Values: 82.0 80.0 79.0 85.0 80.0 85.0 79.0 80.0 84.0 79.0 09:53:41 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:142.00 stddev:13.67 (9.6%) stddev-sans-first:14.50 09:53:41 INFO - PROCESS | 19398 | Values: 143.0 130.0 139.0 146.0 138.0 130.0 154.0 134.0 176.0 141.0 09:53:41 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:167.00 stddev:2.58 (1.5%) stddev-sans-first:2.11 09:53:41 INFO - PROCESS | 19398 | Values: 172.0 167.0 167.0 166.0 166.0 165.0 167.0 165.0 166.0 172.0 09:53:41 INFO - PROCESS | 19398 | 09:53:41 INFO - PROCESS | 19398 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.58 (2.3%) stddev-sans-first:1.67 09:53:41 INFO - PROCESS | 19398 | Values: 68.0 71.0 68.0 69.0 67.0 67.0 69.0 71.0 67.0 67.0 09:53:41 INFO - PROCESS | 19398 | -------- Summary: end -------- 09:53:41 INFO - PROCESS | 19398 | 09:53:42 INFO - TEST-INFO | 19398: exit 0 09:53:42 INFO - TEST-OK | kraken | took 64141ms 09:53:42 INFO - SUITE-END | took 1181s 09:53:42 INFO - Completed test suite (00:19:41) 09:53:42 INFO - javascript benchmark 09:53:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6378.701270071759, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2652.602109683547, 2663.2010396880937, 2673.5054015007236, 2677.3842016336243, 2699.4601079784043, 4639.072185562888, 4724.433068031837, 4750.7862146203415, 4768.833090841821, 4805.087033463648, 4615.261558150696, 4679.60223381013, 4842.8062877484945, 4902.0, 4914.680545764523, 4271.402003719481, 4334.5882141196535, 4397.164538737646, 4410.448693913261, 4410.669199810011, 4324.437823083011, 4424.269995450747, 4430.822767089313, 4442.355858400546, 4445.066536027438, 4258.74447533149, 4349.347597860315, 4366.908272931767, 4368.060866913629, 4411.404460397869, 4266.552012038722, 4297.140571885635, 4300.655947524222, 4339.696221264513, 4355.586219309161, 4366.497852746911, 4374.1689079075195, 4397.648188144941, 4419.0, 4424.446944131983, 4769.475357710649, 4800.807967681289, 4826.227803551415, 4853.102176097398, 4891.266310053485, 5173.611979101544, 5177.404598471187, 5180.844574662766, 5190.844274671766, 5195.986782577399, 4956.058348913695, 5221.216817477409, 5227.712475813867, 5244.0, 5248.475152484721, 4787.066522028206, 4820.156472617348, 4842.757862106881, 4843.39457567804, 4853.053654537402, 5294.788208471695, 5310.230016647564, 5328.17413300939, 5359.785608575691, 5376.0, 4908.410990681141, 4983.875403114951, 5112.233165025276, 5122.129238029544, 5125.538701516882, 5063.265826455217, 5131.97434012835, 5152.587792976553, 5162.148245539444, 5215.504527069922, 4858.951410485921, 5092.159793634083, 5093.0577843099145, 5149.613778966593, 5170.6380553360905, 4908.0, 5117.692938423632, 5127.179651255781, 5150.459201783834, 5201.531862132426, 4285.0, 4286.507051689034, 4324.848630297987, 4327.6970612057485, 4329.826806927751, 3742.644448777362, 3745.4943582615997, 3748.8313025913353, 3754.718396120302, 3775.4903088083306, 4274.807633656493, 4411.073674528385, 4419.513853476115, 4425.159219748302, 4431.977840110779, 5138.640295179302, 5185.896282074337, 5191.532762051434, 5217.243499692523, 5278.129108697099, 4458.331250312414, 4487.50637429889, 4493.842715504941, 4507.391502147234, 4511.413516242867, 4522.638188944877, 4558.612517935946, 4599.402077729874, 4712.764361781898, 4749.572538471554, 4843.903121937471, 4866.0024694938165, 4876.146674331907, 4914.606831453403, 4928.852134435972, 5052.444231134498, 5095.694258344512, 5099.796008159632, 5110.131277682728, 5115.386153661584, 4797.5682188601795, 4853.49038350968, 4869.926951095807, 4883.047805677858, 4904.019196160711, 5052.873678158076, 5078.669886457368, 5081.923771143362, 5086.872828179326, 5134.666246693953, 5098.643094983316, 5142.0, 5146.176611742103, 5156.0, 5157.458466860926, 4755.643326750576, 4756.738379389167, 4886.193778026586, 4924.72913989734, 4944.085344211332, 4946.35697359341, 4981.37732783402, 4993.101241776515, 5011.724355160502, 5034.320366750442, 4913.0, 4960.801567937387, 4964.05682920244, 4965.726885021359, 5001.449840517613, 4794.448638406628, 4957.702537847741, 4989.675671081368, 5083.18669012971, 5087.516685914832, 4895.020995800925, 4902.950970490249, 4905.730184839726, 4935.087008903364, 4963.851084467472], "value": 4703.825013658628, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.9891402171957, 545.6807767456037, 545.9563234941204, 550.4990458682597, 579.4611011759063, 35509.0, 36287.0, 36297.27405451889, 36340.273194536094, 36509.81745091277, 39938.20123597526, 40125.19749605006, 40262.19475610486, 40378.79810600943, 40417.797911010406, 7776.261255180749, 7865.252800983897, 7918.604069796516, 7943.602819859013, 7945.364370850347, 7870.724524641639, 7947.403944704141, 7979.960100199491, 7988.281054705076, 7998.120206777279, 7958.840823183533, 7976.680932762712, 7991.0, 7996.520208787462, 8067.273945344918, 7939.64271607779, 7962.283394494494, 7987.680492780281, 7996.360291176692, 7996.680132794681, 7865.410094242955, 7897.407694422941, 7899.407544434191, 7899.644515996736, 7910.2880740733035, 37871.431928521095, 38079.23841523182, 38118.428223576666, 38179.61820381788, 38192.236155277016, 3064.4330798802293, 3086.7221950024605, 3150.2754366495606, 3206.8236247006407, 3779.527559055118, 29512.704872951424, 29997.0, 30063.849680751457, 30290.394192116255, 30695.69304306973, 3225.483922572401, 3230.2408933900515, 3249.8700051997894, 3261.967380326214, 3295.0279667498144, 183661.0, 183952.0, 184051.07974460043, 184071.0, 184442.0, 28814.71185288162, 53277.73361133169, 53818.0, 53880.19179712307, 53902.0, 33820.154496137795, 34370.0, 34374.65625343764, 34379.312413751584, 34761.130971725404, 14150.221737804519, 14308.642283942776, 14331.570052898429, 14342.49801256951, 14471.421143154366, 11157.609483668033, 11196.776064478665, 11211.159163062803, 11225.158113141384, 11258.831117533244, 7835.804104897309, 7960.203979602109, 7961.16407777175, 7989.640466179036, 8075.636596353178, 3048.9847550762106, 3108.6580476147606, 3120.968790312113, 3147.763917706181, 3153.432382171231, 827.6234313387515, 844.7803571071443, 881.2727054972326, 914.3790589266579, 1025.9076683098408, 27743.0, 29175.270618234714, 29348.11955641334, 29440.852795735886, 29533.0, 905.1627244798535, 941.764558860285, 978.1490103609905, 1001.0890090018048, 1052.2844465763355, 14803.703925921422, 14876.702465950837, 15018.293048641446, 15247.923760381127, 15381.230938453033, 372006.0, 375461.0, 376472.0, 378789.0, 379257.0, 50432.495675043516, 51004.74497627488, 51022.74488627607, 51082.0, 51186.232206516936, 1147.3345459633392, 1195.1992165249303, 1200.165884710118, 1229.5757963502576, 1229.6495498782983, 26214.60678089792, 27820.16539503818, 27978.720212797612, 28281.57577636378, 28324.85837570799, 44929.55070449384, 44983.77508112438, 45259.773701131286, 45506.31740523829, 45600.7719961398, 337969.0, 343587.0, 344307.0, 344947.0, 345797.0, 39404.408933865445, 39408.6059139405, 40260.79869600751, 40399.1920161601, 40535.3919691199, 43588.78205608952, 44283.0, 44441.55558444374, 44914.32628510641, 45030.0, 37302.253954920205, 38120.61879381171, 38124.2375152501, 38278.61721382862, 38983.0, 36593.0, 38143.42784858174, 38491.0, 38560.03599910025, 40709.1858162841, 31814.363712726077, 35003.64996350004, 37505.0, 37539.24921501609, 38539.0, 32978.0, 33824.323513530086, 34836.65163348334, 34951.475727863595, 35018.649813501535, 26048.21855344343, 26480.867595661897, 26568.202953911412, 26854.59718104191, 27006.729932700422], "value": 16784.17370490774, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.12807083177455, 367.6342039670527, 373.71597585834775, 381.39929610862896, 389.8596505258108, 16218.756718649214, 17377.391791287293, 17631.29474821007, 17847.286108555643, 18014.099295035263, 15985.600359991005, 16702.0, 17018.40435584755, 17033.488995330128, 17809.109544522787, 4758.952410475903, 4870.4642489326325, 4902.730349830758, 4934.087193869145, 4939.616907265971, 3547.7161827053774, 4885.6335774817035, 5350.91973620396, 5609.49514543691, 5636.859078523029, 5678.630888992202, 5690.4025077366905, 5693.914591281134, 5700.201971723962, 5714.799982000631, 5611.354694210157, 5639.561911712528, 5739.139129130622, 5796.072628379481, 5822.155787410844, 4711.952880471185, 5556.416576259475, 5564.276644036249, 5597.7201139943245, 5605.327360716699, 12288.631341059783, 12984.805227921588, 12994.220346779224, 13009.284489353082, 13161.802572961318, 1895.9715604265948, 1981.4947188466992, 2183.814375778061, 2361.1853910400882, 2405.1581946318825, 8895.555222238861, 8944.284457243404, 9860.50697465131, 10602.734931626694, 13190.53833115846, 1588.8967217130964, 1669.741190115534, 1680.2270955360548, 1697.8485960671865, 1729.4725108841799, 66345.3365466344, 70425.64787176083, 71946.64026679886, 72476.275237248, 73916.99999999946, 9097.08825205155, 9149.35954483193, 9272.258219342437, 9309.953450232706, 9400.435973841591, 12239.694007649701, 12274.75450491003, 12287.201331913397, 12299.815502767466, 12312.0, 6908.447324214051, 6933.0986971693355, 6944.51388402807, 7072.540284881569, 7101.11236095488, 7014.964925175342, 7036.542624729376, 7133.89299160513, 7137.357637812518, 7180.533265337736, 3704.444333350019, 3771.41543060826, 3841.3469710149343, 3856.2480316338606, 3878.650921417086, 1577.597712583284, 1644.2189959769014, 1652.272999880049, 1713.6487020160837, 1839.9172037258356, 819.8729196974479, 836.9874451883227, 888.6401007591936, 911.8449863523217, 935.9906400936039, 15803.525894223192, 16834.074125922947, 17250.568735781453, 17294.13529323529, 17315.0, 859.3297228162044, 865.5412631305418, 875.2297977779641, 877.3025444771422, 919.048784508031, 8216.671333146727, 9357.251419886528, 9534.0, 9799.608015679292, 9831.80336393268, 369351.0, 370890.0, 372505.0, 380791.0, 390583.0, 78159.60920195363, 80280.0, 82842.17157828464, 84050.57974710087, 84805.15194848095, 863.8617821148586, 864.5029108262648, 865.3380164174412, 872.232435456794, 882.7881308485917, 15073.321700523722, 15539.0, 15607.921960390126, 15648.374065037271, 15778.13220272896, 35022.0, 36156.91529254126, 36662.63337366592, 36719.81640091782, 36985.81507092447, 47091.76454117707, 51305.48694513007, 51450.74274628753, 51689.48310516997, 52019.0, 7456.291652293024, 7477.102747670315, 7513.0, 7545.7358992435, 7574.659140338808, 10862.945685271523, 11511.769764604493, 11769.764604708029, 12253.877461225631, 12420.75158496807, 4982.676126051795, 5941.7623295067715, 10151.64469243573, 10183.083522483012, 10594.364338139736, 10021.949890250502, 10431.0, 10520.684379468628, 10708.30396024256, 10857.0, 9957.601695932082, 10266.845997310196, 10308.793824123326, 10459.110975567162, 10544.892786257333, 7707.614619268902, 7813.0, 7816.687332506636, 7827.25641064098, 7833.686652533835, 9567.091126342986, 9658.227341812779, 9745.12293893553, 9799.902000979899, 9871.851922221029], "value": 8009.394439786116, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.4368908747413, 1414.2433797918113, 1511.0, 1688.8648908087355, 1744.9738253926184, 6604.900926486107, 7555.924440755591, 7652.8852067218895, 8117.066537348207, 8145.104038555769, 7706.576138312391, 8011.719589814357, 8043.155468675793, 8054.556999365032, 8072.636731347089, 2220.145244081032, 2261.231181398324, 2262.1403866530695, 2264.6942662740485, 2265.161890100665, 2185.661222510513, 2193.7367515898113, 2235.329401179648, 2236.8769717665523, 2243.6410174372104, 2216.556688662266, 2217.789310015546, 2223.7665045170265, 2225.94435139122, 2248.213125406111, 2175.8259339252822, 2176.9564608707815, 2178.7276590426195, 2179.727534058243, 2186.7485239197376, 2153.3755210988793, 2159.8596091254017, 2170.869747815136, 2171.685105659686, 2177.281497105951, 7972.760817175494, 7976.322012628933, 8043.195680431969, 8069.677212911535, 8075.757727268191, 4537.863864084083, 4660.324252983332, 4673.532646735299, 4679.672422930396, 4683.812647494096, 2773.556046517278, 2926.078285340111, 2927.209653393572, 2932.003118939571, 2932.5190778656643, 889.3596610440472, 889.7375274294099, 909.6952520905504, 926.0878035135386, 931.6040682709821, 10966.945165274203, 10982.286151400134, 10985.505652245669, 10990.0, 11024.283421577571, 4084.1831633673382, 4192.643625291823, 4316.568343165721, 4321.049369138785, 4325.091730736581, 9397.295202859676, 9404.106609872051, 9413.2469402449, 9435.716928492157, 9457.668981585612, 4766.666333356701, 4790.520947905182, 4807.158747219222, 4817.710937343771, 4829.830955916596, 3807.333716599584, 4210.221109094828, 4369.781510924441, 4397.560243975577, 4399.978000109979, 3448.5516882805073, 3494.9126271843406, 3515.8066306352885, 3537.7877327360443, 3550.396432606463, 1186.827909953052, 1222.480445810527, 1224.3205021213312, 1235.9196652217577, 1245.2279586656332, 836.8075342671098, 850.2602735620051, 854.8803167556423, 872.1583671756786, 877.3376101043672, 5382.838514844561, 5475.479829416199, 5475.780968761284, 5575.247341608912, 5647.152927060892, 404.50044195418633, 406.1227748064167, 409.4411128809154, 414.42808923685124, 422.780154319752, 3917.4515567820526, 4080.7959602019782, 4117.835286588563, 4180.958190418118, 4189.937150942738, 9611.663591774255, 9872.259580531489, 9894.109530142321, 10286.0, 10295.279330446796, 10137.695869123938, 10156.695299141038, 10174.593016279414, 10206.693799186036, 10242.231832612435, 7498.4376171787335, 7586.203448637924, 7744.690212391554, 7792.6103694816165, 7799.766007019798, 5588.916166257428, 5769.07694768835, 5875.265591801025, 5879.118132280192, 5881.264841894763, 9223.30825188127, 9367.156955874005, 9371.34400591952, 9395.812083758423, 9516.33385662997, 8865.512396818236, 9214.769630759285, 9224.723258302261, 9506.61973521079, 9775.560099795384, 6056.333803281547, 6973.0, 7020.087388639444, 7043.859122817617, 7235.2041275458605, 7857.4499785014505, 7869.8819517708425, 7898.486598371088, 7905.960470197612, 7963.641636126504, 6659.866802664016, 6723.327667233433, 6774.932250677627, 6921.0, 7209.0, 7113.288671132846, 7137.678804453708, 7139.714411423485, 7176.641167941478, 7187.137543494814, 6549.410553050057, 6554.934450655433, 6628.668566571749, 6654.434373078343, 6658.9667051666365, 4866.8053277868485, 4885.609151267961, 4964.900701986012, 4973.229149481836, 5002.849914502571, 4897.289892965428, 4972.950270497248, 4979.676321039121, 4980.551750342486, 5008.173651347487], "value": 4191.953422804356, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.71758970183475, 301.61393416426984, 309.55115083129454, 310.627247303236, 314.8787716729059, 4981.427135879375, 5021.472745361734, 5052.772625231864, 5057.494250574945, 5082.390113186413, 4953.4798846121175, 4973.5772459341, 4974.1295273327205, 4986.35177426934, 4987.975060124694, 3710.2932650980515, 3821.5987321331277, 3926.548446928597, 3933.940990885125, 3941.152652179781, 3899.9610003900025, 3909.654207475506, 3912.5109361329833, 3919.314120028998, 3934.075492259317, 3879.9030024249337, 3881.4565960765517, 3892.6885849132145, 3902.8633997810084, 3912.5696173421043, 3818.618138186187, 3881.6894648428056, 3883.592222816606, 3912.3544615138467, 3916.17760270345, 3433.9141521461916, 3457.6369481204615, 3458.8962331130106, 3464.1685995361186, 3469.670381313771, 4866.635002374801, 4870.342503761982, 4872.9756351218375, 4874.341963834872, 4882.926756098661, 4359.891002724926, 4465.1739428205565, 4474.485434175079, 4486.192485352635, 4507.143642707875, 5179.766910489037, 5183.922241166386, 5242.842714718565, 5244.187150991603, 5250.527452529291, 3708.9443658345144, 3729.533808273966, 3734.8692795752017, 3737.831797569116, 3739.0, 5340.546053585489, 5476.070302388203, 5482.574530622027, 5484.972575137139, 5497.340319161686, 3873.573906870242, 3875.748076375083, 3884.9223015539533, 3886.8833934981994, 3896.8441262349756, 3897.006263402814, 3907.980460097738, 3931.941020884689, 3936.6063393660406, 3941.724079314478, 4397.164538737629, 4404.625606823456, 4406.449193850769, 4417.558244175621, 4453.665975051884, 4955.975220123876, 5187.0922588546855, 5188.936268065037, 5204.531592156724, 5215.817446389358, 1331.9533816316382, 1334.2194816032536, 1337.2912356451097, 1344.7695358746637, 1348.2315080404076, 844.2064459408136, 846.8094678697244, 857.2627540315324, 883.5140672630027, 892.2950868813565, 4439.822407103679, 4566.292224705176, 4598.448186217675, 4614.661748093015, 4659.953400465952, 5351.545118664957, 5390.838274851761, 5393.2179833923865, 5411.107167317427, 5417.51242388187, 4482.260427029503, 4581.541845815458, 4627.629789616823, 4630.513796051433, 4644.2801365788355, 2802.271409433521, 2856.0, 2866.5270230412166, 2874.4969630314613, 2876.367199216169, 5052.343195384577, 5092.562520298783, 5109.897802043938, 5111.309973153577, 5144.819931302462, 5350.8662283442445, 5388.973055134699, 5425.565954723613, 5462.399136095027, 5491.752871120809, 5073.746312684351, 5075.771590278447, 5093.8726531837, 5105.085592902661, 5125.666831656005, 5323.893522129459, 5350.7324633767375, 5354.4110147884485, 5356.634058315105, 5366.409694933633, 5084.796608135781, 5239.659422137549, 5266.578673706018, 5279.577633789365, 5301.019311427398, 5108.182690769459, 5116.513931176532, 5134.614903882299, 5138.409082955508, 5146.25027490655, 3808.1622043150464, 3825.7704537726713, 3826.789526576065, 3829.291581057513, 3842.634949679776, 5240.397354304304, 5366.275552800478, 5383.596230282823, 5388.2725832012175, 5400.675959442446, 5224.0, 5242.0, 5250.894982100413, 5257.816991176955, 5261.237120617566, 5220.712860792541, 5224.843254702365, 5230.738463076755, 5235.397929238186, 5248.763805628832, 4968.527989840959, 5204.453532379046, 5206.2450944612065, 5206.5314121729225, 5210.97394513025, 5050.974745126251, 5116.437191908962, 5285.577153827608, 5294.391145018218, 5302.151655735064, 5121.924395876758, 5130.974345128399, 5143.897122057613, 5150.6137039721425, 5163.66436181647], "value": 3945.4330102974454, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.6072565372298, 658.9143411356523, 717.3257138290007, 723.7141329174976, 763.9961800190998, 12856.1643493173, 13906.721865562682, 13941.233232172226, 13953.930230348848, 13958.720825583483, 12507.562235321766, 13081.869181308208, 13112.475500979974, 13146.868531314683, 13176.077674562785, 776.6543887969856, 789.3093543149744, 789.6407134753673, 792.0297635396622, 793.9801504962364, 784.2079499705281, 786.7561056072607, 787.5314188058096, 788.7081779741503, 789.3251270164013, 835.5738573327616, 836.7196989008659, 837.5435387713711, 840.3025488844276, 844.273924424994, 825.2325337436182, 825.3933358981144, 826.8883700700388, 828.8052307707684, 830.211299265697, 599.0325624117063, 602.7106988645431, 604.0, 605.267626172332, 605.772835186805, 11419.371934543597, 11444.198906076577, 11496.712582185428, 11510.079193664487, 11563.190576659637, 10859.13126949842, 10993.945030274877, 11103.38931358775, 11230.045446137088, 11405.14461415397, 9385.10841470066, 9638.325317227796, 9705.417674939526, 9736.610535578568, 9841.163501102415, 3206.150370151912, 3217.1313745288876, 3277.0332751838264, 3322.335532893431, 3386.3227354528944, 43705.12589748187, 44521.0, 52377.73811130958, 52752.47247527552, 57818.710906445616, 10508.264421490576, 10578.841317380246, 10643.254972151875, 10646.254762166729, 10923.453827308604, 20283.492912677008, 20804.271850485162, 20839.270625528035, 20889.0, 20897.686534701992, 7334.0, 7461.365783908429, 7468.178500364956, 7595.962020189863, 7689.269519395649, 3760.605136460687, 3798.145417281145, 3851.614838516126, 3853.460515527828, 3853.5953724859046, 2967.629046369204, 3054.862531186102, 3086.2901532647616, 3088.089013740952, 3117.8285194314076, 494.8391772673895, 500.9198528235465, 502.8466317773114, 517.8368813823633, 521.6922016010571, 439.54726631569537, 467.48576565777375, 498.2003883766575, 538.2195816066719, 550.3643291997749, 7630.618469076524, 7753.728619498291, 7757.456978011598, 7818.14000459949, 8135.633896474673, 495.8438092001008, 506.43490719505587, 520.3963402453136, 523.6151428699902, 533.5304931660114, 3512.7189824813954, 3859.1702783901596, 3878.7866667333005, 3916.706247031484, 4015.3976903464713, 92771.53614232021, 95084.0, 95334.52332738292, 97237.5138124319, 97293.0, 46766.0, 47260.0, 48425.757871210415, 58067.0, 85225.0, 73354.0, 74221.0, 74444.62777686077, 74833.25166748372, 75714.62142689251, 8170.959145204236, 8186.713465028695, 8200.466969646954, 8409.2431681149, 8489.4481858679, 44633.33050004317, 44723.77638111919, 44798.0, 44818.327725084804, 45027.549724502336, 60769.69615152073, 63640.04539931812, 63749.0, 65079.0, 65143.674281628286, 11145.2198346115, 11253.0, 12049.33728644933, 12272.75454490923, 12436.31600261958, 12824.743505130033, 12836.486540538273, 12867.163634364111, 13010.349482526026, 13604.86395136036, 12024.33866137371, 12028.578999734968, 12295.631131066082, 12520.937395312965, 12538.937305313415, 11334.546618135511, 11362.431878406212, 11768.176227663982, 11831.585894493652, 12064.939675301568, 11487.19589628718, 11598.536058557564, 11781.609195402285, 11808.232464890098, 12271.447784849524, 9940.850887236553, 10107.595696172364, 10130.189584833342, 10311.123554497952, 10322.312166218959, 9604.183644390025, 10179.0, 10300.484975751333, 10319.742006449898, 10378.221633377376], "value": 6440.01142721881, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 107.0, 113.0, 112.0, 114.0, 114.0, 112.0, 113.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 147.0, 179.0, 129.0, 150.0, 149.0, 123.0, 178.0, 124.0], "value": 145.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 168.0, 175.0, 164.0, 162.0, 162.0, 163.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 150.0, 78.0, 77.0, 77.0, 76.0, 168.0, 77.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 140.0, 89.0, 86.0, 85.0, 141.0, 85.0, 86.0, 147.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 149.0, 147.0, 147.0, 149.0, 147.0, 147.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 97.0, 96.0, 95.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 67.0, 70.0, 66.0, 67.0, 68.0, 67.0, 68.0], "value": 67.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 65.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 79.0, 85.0, 80.0, 85.0, 79.0, 80.0, 84.0, 79.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 130.0, 139.0, 146.0, 138.0, 130.0, 154.0, 134.0, 176.0, 141.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 167.0, 167.0, 166.0, 166.0, 165.0, 167.0, 165.0, 166.0, 172.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 68.0, 69.0, 67.0, 67.0, 69.0, 71.0, 67.0, 67.0], "value": 68.4, "unit": "score"}]}]} 09:53:42 INFO - Return code: 0 09:53:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:53:42 ERROR - # TBPL SUCCESS # 09:53:42 INFO - Running post-action listener: _resource_record_post_action 09:53:42 INFO - ##### 09:53:42 INFO - ##### Finished run-tests step (success) 09:53:42 INFO - ##### 09:53:42 INFO - Running post-run listener: _resource_record_post_run 09:53:42 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 536920064; Read time: 0; Write time: 558868 09:53:42 INFO - TinderboxPrint: CPU usage
13.3% 09:53:42 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:53:42 INFO - TinderboxPrint: I/O write bytes / time
536,920,064 / 558,868 09:53:42 INFO - TinderboxPrint: CPU idle
8,284.1 (86.6%) 09:53:42 INFO - TinderboxPrint: CPU user
1,219.7 (12.8%) 09:53:42 INFO - TinderboxPrint: Swap in / out
0 / 0 09:53:42 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247070720; Read time: 0; Write time: 310968 09:53:42 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 289849344; Read time: 0; Write time: 247900 09:53:43 INFO - Running post-run listener: _upload_blobber_files 09:53:43 INFO - Blob upload gear active. 09:53:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:53:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:53:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:53:43 INFO - (blobuploader) - INFO - Open directory for files ... 09:53:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:53:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:53:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:44 INFO - (blobuploader) - INFO - Done attempting. 09:53:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:53:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:53:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:48 INFO - (blobuploader) - INFO - Done attempting. 09:53:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:53:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:53:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:49 INFO - (blobuploader) - INFO - Done attempting. 09:53:49 INFO - (blobuploader) - INFO - Iteration through files over. 09:53:49 INFO - Return code: 0 09:53:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:53:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:53:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/090817b22f0c363935b812c50ed4696aaab2f60ee538df848339681ad28855696726c45a398bba761b2054d80ec124fac770af44db0a5f7dc38f27ad5f270497", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10b4be3d7e91e719558b0b352a624e945c0c211632a2378ef3bb29c119e493b8a4c7f0282aa09a34f7b4e07b37507e1a285a622006152276063ff4e16953411a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3eb54291a370f5bf13f395753fe9fb7e191c9616076b816a585f1f5863e991c30eaac81dff134ef9e1cbf9ff5d57dc417530a07724b0f8657723fb504ed93ad"} 09:53:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:53:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:53:49 INFO - Contents: 09:53:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/090817b22f0c363935b812c50ed4696aaab2f60ee538df848339681ad28855696726c45a398bba761b2054d80ec124fac770af44db0a5f7dc38f27ad5f270497", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10b4be3d7e91e719558b0b352a624e945c0c211632a2378ef3bb29c119e493b8a4c7f0282aa09a34f7b4e07b37507e1a285a622006152276063ff4e16953411a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3eb54291a370f5bf13f395753fe9fb7e191c9616076b816a585f1f5863e991c30eaac81dff134ef9e1cbf9ff5d57dc417530a07724b0f8657723fb504ed93ad"} 09:53:49 INFO - Running post-run listener: copy_logs_to_upload_dir 09:53:49 INFO - Copying logs to upload dir... 09:53:49 INFO - mkdir: /builds/slave/test/build/upload/logs 09:53:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.216311 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-15 09:53:49.699509) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 09:53:49.702845) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851 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/090817b22f0c363935b812c50ed4696aaab2f60ee538df848339681ad28855696726c45a398bba761b2054d80ec124fac770af44db0a5f7dc38f27ad5f270497", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10b4be3d7e91e719558b0b352a624e945c0c211632a2378ef3bb29c119e493b8a4c7f0282aa09a34f7b4e07b37507e1a285a622006152276063ff4e16953411a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3eb54291a370f5bf13f395753fe9fb7e191c9616076b816a585f1f5863e991c30eaac81dff134ef9e1cbf9ff5d57dc417530a07724b0f8657723fb504ed93ad"} build_url:https://queue.taskcluster.net/v1/task/Y_EQikAlTG-GD6lA43Y7KA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/Y_EQikAlTG-GD6lA43Y7KA/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/090817b22f0c363935b812c50ed4696aaab2f60ee538df848339681ad28855696726c45a398bba761b2054d80ec124fac770af44db0a5f7dc38f27ad5f270497", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10b4be3d7e91e719558b0b352a624e945c0c211632a2378ef3bb29c119e493b8a4c7f0282aa09a34f7b4e07b37507e1a285a622006152276063ff4e16953411a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3eb54291a370f5bf13f395753fe9fb7e191c9616076b816a585f1f5863e991c30eaac81dff134ef9e1cbf9ff5d57dc417530a07724b0f8657723fb504ed93ad"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 09:53:49.731542) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:53:49.732283) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468595569.809878-1379485851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:53:49.817655) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 09:53:49.818327) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 09:53:49.818983) ========= ========= Total master_lag: 0.18 =========